builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1461330468.15 results: success (0) buildid: 20160419230832 builduid: 1ab072c2db0d4b259b7f46e10e93ac05 revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.154514) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.155014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.155314) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.172339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.172905) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 06:07:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-04-22 06:07:48 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.314981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.315628) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017713 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.367724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.368433) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d42b25947fc26a0f9eab98d631465b72769553bd --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 d42b25947fc26a0f9eab98d631465b72769553bd --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=fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 06:07:48,890 truncating revision to first 12 chars 2016-04-22 06:07:48,890 Setting DEBUG logging. 2016-04-22 06:07:48,890 attempt 1/10 2016-04-22 06:07:48,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d42b25947fc2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 06:07:49,149 unpacking tar archive at: fx-team-d42b25947fc2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.934033) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.934378) ========= script_repo_revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.934787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.935054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:48.942990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-22 06:07:48.943389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:07:49 INFO - MultiFileLogger online at 20160422 06:07:49 in /builds/slave/test 06:07:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:07:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:07:49 INFO - {'append_to_log': False, 06:07:49 INFO - 'base_work_dir': '/builds/slave/test', 06:07:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:07:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:07:49 INFO - 'branch': 'Fx-Team-Non-PGO', 06:07:49 INFO - 'buildbot_json_path': 'buildprops.json', 06:07:49 INFO - 'config_files': ('talos/linux_config.py',), 06:07:49 INFO - 'default_actions': ('clobber', 06:07:49 INFO - 'read-buildbot-config', 06:07:49 INFO - 'download-and-extract', 06:07:49 INFO - 'populate-webroot', 06:07:49 INFO - 'create-virtualenv', 06:07:49 INFO - 'install', 06:07:49 INFO - 'run-tests'), 06:07:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:07:49 INFO - 'download_minidump_stackwalk': True, 06:07:49 INFO - 'download_symbols': 'ondemand', 06:07:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:07:49 INFO - 'tooltool.py': '/tools/tooltool.py', 06:07:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:07:49 INFO - '/tools/misc-python/virtualenv.py')}, 06:07:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:07:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:07:49 INFO - 'installer_path': 'installer.exe', 06:07:49 INFO - 'log_level': 'info', 06:07:49 INFO - 'log_name': 'talos', 06:07:49 INFO - 'log_to_console': True, 06:07:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:07:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:07:49 INFO - 'opt_config_files': (), 06:07:49 INFO - 'pip_index': False, 06:07:49 INFO - 'sps_profile': False, 06:07:49 INFO - 'sps_profile_interval': 0, 06:07:49 INFO - 'suite': 'dromaeojs', 06:07:49 INFO - 'system_bits': '32', 06:07:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:07:49 INFO - 'title': 'talos-linux64-ix-014', 06:07:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:07:49 INFO - 'use_talos_json': True, 06:07:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:07:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:07:49 INFO - 'work_dir': 'build'} 06:07:49 INFO - ##### 06:07:49 INFO - ##### Running clobber step. 06:07:49 INFO - ##### 06:07:49 INFO - Running pre-action listener: _resource_record_pre_action 06:07:49 INFO - Running main action method: clobber 06:07:49 INFO - rmtree: /builds/slave/test/build 06:07:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:07:50 INFO - Running post-action listener: _resource_record_post_action 06:07:50 INFO - ##### 06:07:50 INFO - ##### Running read-buildbot-config step. 06:07:50 INFO - ##### 06:07:50 INFO - Running pre-action listener: _resource_record_pre_action 06:07:50 INFO - Running main action method: read_buildbot_config 06:07:50 INFO - Using buildbot properties: 06:07:50 INFO - { 06:07:50 INFO - "project": "", 06:07:50 INFO - "product": "firefox", 06:07:50 INFO - "script_repo_revision": "production", 06:07:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:07:50 INFO - "repository": "", 06:07:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:07:50 INFO - "buildid": "20160419230832", 06:07:50 INFO - "pgo_build": "False", 06:07:50 INFO - "basedir": "/builds/slave/test", 06:07:50 INFO - "buildnumber": 1701, 06:07:50 INFO - "slavename": "talos-linux64-ix-014", 06:07:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:07:50 INFO - "platform": "ubuntu64_hw", 06:07:50 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:07:50 INFO - "branch": "fx-team", 06:07:50 INFO - "repo_path": "integration/fx-team", 06:07:50 INFO - "revision": "d42b25947fc26a0f9eab98d631465b72769553bd", 06:07:50 INFO - "stage_platform": "linux64", 06:07:50 INFO - "builduid": "1ab072c2db0d4b259b7f46e10e93ac05", 06:07:50 INFO - "slavebuilddir": "test" 06:07:50 INFO - } 06:07:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:07:50 INFO - Running post-action listener: _resource_record_post_action 06:07:50 INFO - ##### 06:07:50 INFO - ##### Running download-and-extract step. 06:07:50 INFO - ##### 06:07:50 INFO - Running pre-action listener: _resource_record_pre_action 06:07:50 INFO - Running main action method: download_and_extract 06:07:50 INFO - mkdir: /builds/slave/test/build/tests 06:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:50 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:07:50 INFO - Downloaded 1361 bytes. 06:07:50 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:07:50 INFO - Using the following test package requirements: 06:07:50 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:07:50 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:07:50 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:07:50 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:50 INFO - u'jsshell-linux-x86_64.zip'], 06:07:50 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:07:50 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:07:50 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:07:50 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:07:50 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:07:50 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:07:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:50 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:07:52 INFO - Downloaded 22267191 bytes. 06:07:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:07:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:07:53 INFO - Return code: 0 06:07:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:53 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:07:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:07:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:07:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:07:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:07:54 INFO - Downloaded 22267191 bytes. 06:07:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:07:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:07:56 INFO - Return code: 0 06:07: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')]} 06:07:56 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:07:57 INFO - Downloaded 10845952 bytes. 06:07:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:07:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:07:57 INFO - Return code: 0 06:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:57 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:07:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:07:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:07:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:07:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:08:02 INFO - Downloaded 54589518 bytes. 06:08:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:02 INFO - mkdir: /builds/slave/test/properties 06:08:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:08:02 INFO - Writing to file /builds/slave/test/properties/build_url 06:08:02 INFO - Contents: 06:08:02 INFO - build_url:https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:03 INFO - Running post-action listener: _resource_record_post_action 06:08:03 INFO - Running post-action listener: set_extra_try_arguments 06:08:03 INFO - ##### 06:08:03 INFO - ##### Running populate-webroot step. 06:08:03 INFO - ##### 06:08:03 INFO - Running pre-action listener: _resource_record_pre_action 06:08:03 INFO - Running main action method: populate_webroot 06:08:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:08:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:08:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:08:03 INFO - '--tppagecycles', 06:08:03 INFO - '7'], 06:08:03 INFO - 'tests': ['tsvgm']}}, 06:08:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:08:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:08:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:08:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:08:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:08:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:08:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:03 INFO - 'talos_options': ['--disable-e10s'], 06:08:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:03 INFO - 'talos_options': ['--disable-e10s'], 06:08:03 INFO - 'tests': ['damp', 'tps']}, 06:08:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:03 INFO - 'tests': ['damp', 'tps']}, 06:08:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:08:03 INFO - 'tests': ['dromaeo_dom']}, 06:08:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:08:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:08:03 INFO - 'tests': ['a11yr', 06:08:03 INFO - 'ts_paint', 06:08:03 INFO - 'tpaint', 06:08:03 INFO - 'sessionrestore', 06:08:03 INFO - 'sessionrestore_no_auto_restore', 06:08:03 INFO - 'tabpaint']}, 06:08:03 INFO - 'other-e10s': {'tests': ['a11yr', 06:08:03 INFO - 'ts_paint', 06:08:03 INFO - 'tpaint', 06:08:03 INFO - 'sessionrestore', 06:08:03 INFO - 'sessionrestore_no_auto_restore', 06:08:03 INFO - 'tabpaint']}, 06:08:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:08:03 INFO - 'ts_paint', 06:08:03 INFO - 'tpaint', 06:08:03 INFO - 'sessionrestore', 06:08:03 INFO - 'sessionrestore_no_auto_restore', 06:08:03 INFO - 'tabpaint']}, 06:08:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:08:03 INFO - 'ts_paint', 06:08:03 INFO - 'tpaint', 06:08:03 INFO - 'sessionrestore', 06:08:03 INFO - 'sessionrestore_no_auto_restore', 06:08:03 INFO - 'tabpaint']}, 06:08:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:08:03 INFO - 'tests': ['a11yr', 06:08:03 INFO - 'ts_paint', 06:08:03 INFO - 'tpaint', 06:08:03 INFO - 'sessionrestore', 06:08:03 INFO - 'sessionrestore_no_auto_restore', 06:08:03 INFO - 'tabpaint']}, 06:08:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:08:03 INFO - 'tests': ['a11yr', 06:08:03 INFO - 'ts_paint', 06:08:03 INFO - 'tpaint', 06:08:03 INFO - 'sessionrestore', 06:08:03 INFO - 'sessionrestore_no_auto_restore', 06:08:03 INFO - 'tabpaint']}, 06:08:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:08:03 INFO - 'tests': ['tsvgx', 06:08:03 INFO - 'tsvgr_opacity', 06:08:03 INFO - 'tart', 06:08:03 INFO - 'tscrollx', 06:08:03 INFO - 'cart']}, 06:08:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:08:03 INFO - 'tsvgr_opacity', 06:08:03 INFO - 'tart', 06:08:03 INFO - 'tscrollx', 06:08:03 INFO - 'cart']}, 06:08:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:03 INFO - 'talos_options': ['--disable-e10s'], 06:08:03 INFO - 'tests': ['tp5o']}, 06:08:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:03 INFO - 'tests': ['tp5o']}, 06:08:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:03 INFO - 'talos_options': ['--disable-e10s', 06:08:03 INFO - '--xperf_path', 06:08:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:03 INFO - 'tests': ['tp5n']}, 06:08:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:03 INFO - 'talos_options': ['--xperf_path', 06:08:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:03 INFO - 'tests': ['tp5n']}}, 06:08:03 INFO - 'talos.zip': {'path': '', 06:08:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:08:03 INFO - Running post-action listener: _resource_record_post_action 06:08:03 INFO - ##### 06:08:03 INFO - ##### Running create-virtualenv step. 06:08:03 INFO - ##### 06:08:03 INFO - Running pre-action listener: _resource_record_pre_action 06:08:03 INFO - Running main action method: create_virtualenv 06:08:03 INFO - Creating virtualenv /builds/slave/test/build/venv 06:08:03 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 06:08:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:08:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:08:03 INFO - Using real prefix '/usr' 06:08:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:08:04 INFO - Installing distribute.............................................................................................................................................................................................done. 06:08:06 INFO - Installing pip.................done. 06:08:06 INFO - Return code: 0 06:08:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:08:06 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')]} 06:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:06 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')]} 06:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:06 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 0x7fc63ddccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328410>, '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 0x2329310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23297a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', '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 06:08:06 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 06:08:06 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 06:08:06 INFO - Using env: {'DISPLAY': ':0', 06:08:06 INFO - 'HOME': '/home/cltbld', 06:08:06 INFO - 'LANG': 'en_US.UTF-8', 06:08:06 INFO - 'LANGUAGE': 'en_US:en', 06:08:06 INFO - 'LOGNAME': 'cltbld', 06:08:06 INFO - 'MAIL': '/var/mail/cltbld', 06:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:06 INFO - 'MOZ_NO_REMOTE': '1', 06:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:06 INFO - 'NO_EM_RESTART': '1', 06:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:06 INFO - 'PWD': '/builds/slave/test', 06:08:06 INFO - 'SHELL': '/bin/bash', 06:08:06 INFO - 'SHLVL': '1', 06:08:06 INFO - 'TERM': 'linux', 06:08:06 INFO - 'TMOUT': '86400', 06:08:06 INFO - 'USER': 'cltbld', 06:08:06 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', 06:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:06 INFO - '_': '/tools/buildbot/bin/python'} 06:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:06 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 06:08:06 INFO - Cleaning up... 06:08:06 INFO - Return code: 0 06:08:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:08:06 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')]} 06:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:06 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')]} 06:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:06 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 0x7fc63ddccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328410>, '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 0x2329310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23297a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', '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 06:08:06 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 06:08:06 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 06:08:06 INFO - Using env: {'DISPLAY': ':0', 06:08:06 INFO - 'HOME': '/home/cltbld', 06:08:06 INFO - 'LANG': 'en_US.UTF-8', 06:08:06 INFO - 'LANGUAGE': 'en_US:en', 06:08:06 INFO - 'LOGNAME': 'cltbld', 06:08:06 INFO - 'MAIL': '/var/mail/cltbld', 06:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:06 INFO - 'MOZ_NO_REMOTE': '1', 06:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:06 INFO - 'NO_EM_RESTART': '1', 06:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:06 INFO - 'PWD': '/builds/slave/test', 06:08:06 INFO - 'SHELL': '/bin/bash', 06:08:06 INFO - 'SHLVL': '1', 06:08:06 INFO - 'TERM': 'linux', 06:08:06 INFO - 'TMOUT': '86400', 06:08:06 INFO - 'USER': 'cltbld', 06:08:06 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', 06:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:06 INFO - '_': '/tools/buildbot/bin/python'} 06:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:06 INFO - Downloading/unpacking psutil>=0.7.1 06:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:08:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:08 INFO - Installing collected packages: psutil 06:08:08 INFO - Running setup.py install for psutil 06:08:08 INFO - building 'psutil._psutil_linux' extension 06:08:08 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 06:08:08 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 06:08:08 INFO - building 'psutil._psutil_posix' extension 06:08:08 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 06:08:09 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 06:08:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:09 INFO - Successfully installed psutil 06:08:09 INFO - Cleaning up... 06:08:09 INFO - Return code: 0 06:08:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:09 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 0x7fc63ddccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328410>, '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 0x2329310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23297a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', '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 06:08:09 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 06:08:09 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 06:08:09 INFO - Using env: {'DISPLAY': ':0', 06:08:09 INFO - 'HOME': '/home/cltbld', 06:08:09 INFO - 'LANG': 'en_US.UTF-8', 06:08:09 INFO - 'LANGUAGE': 'en_US:en', 06:08:09 INFO - 'LOGNAME': 'cltbld', 06:08:09 INFO - 'MAIL': '/var/mail/cltbld', 06:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:09 INFO - 'MOZ_NO_REMOTE': '1', 06:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:09 INFO - 'NO_EM_RESTART': '1', 06:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:09 INFO - 'PWD': '/builds/slave/test', 06:08:09 INFO - 'SHELL': '/bin/bash', 06:08:09 INFO - 'SHLVL': '1', 06:08:09 INFO - 'TERM': 'linux', 06:08:09 INFO - 'TMOUT': '86400', 06:08:09 INFO - 'USER': 'cltbld', 06:08:09 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', 06:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:09 INFO - '_': '/tools/buildbot/bin/python'} 06:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:08:11 INFO - Installing collected packages: mozsystemmonitor 06:08:11 INFO - Running setup.py install for mozsystemmonitor 06:08:11 INFO - Successfully installed mozsystemmonitor 06:08:11 INFO - Cleaning up... 06:08:11 INFO - Return code: 0 06:08:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:08:11 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')]} 06:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:11 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')]} 06:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:11 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 0x7fc63ddccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328410>, '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 0x2329310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23297a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', '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 06:08:11 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 06:08:11 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 06:08:11 INFO - Using env: {'DISPLAY': ':0', 06:08:11 INFO - 'HOME': '/home/cltbld', 06:08:11 INFO - 'LANG': 'en_US.UTF-8', 06:08:11 INFO - 'LANGUAGE': 'en_US:en', 06:08:11 INFO - 'LOGNAME': 'cltbld', 06:08:11 INFO - 'MAIL': '/var/mail/cltbld', 06:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:11 INFO - 'MOZ_NO_REMOTE': '1', 06:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:11 INFO - 'NO_EM_RESTART': '1', 06:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:11 INFO - 'PWD': '/builds/slave/test', 06:08:11 INFO - 'SHELL': '/bin/bash', 06:08:11 INFO - 'SHLVL': '1', 06:08:11 INFO - 'TERM': 'linux', 06:08:11 INFO - 'TMOUT': '86400', 06:08:11 INFO - 'USER': 'cltbld', 06:08:11 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', 06:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:11 INFO - '_': '/tools/buildbot/bin/python'} 06:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:11 INFO - Downloading/unpacking blobuploader==1.2.4 06:08:11 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 06:08:11 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 06:08:11 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 06:08:11 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 06:08:11 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 06:08:11 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 06:08:13 INFO - Downloading blobuploader-1.2.4.tar.gz 06:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:08:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:08:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:08:14 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 06:08:14 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 06:08:14 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 06:08:14 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 06:08:14 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 06:08:14 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 06:08:14 INFO - Downloading docopt-0.6.1.tar.gz 06:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:08:14 INFO - Installing collected packages: blobuploader, requests, docopt 06:08:14 INFO - Running setup.py install for blobuploader 06:08:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:08:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:08:14 INFO - Running setup.py install for requests 06:08:14 INFO - Running setup.py install for docopt 06:08:14 INFO - Successfully installed blobuploader requests docopt 06:08:14 INFO - Cleaning up... 06:08:14 INFO - Return code: 0 06:08:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:14 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 0x7fc63ddccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328410>, '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 0x2329310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23297a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', '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 06:08:14 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 06:08:14 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 06:08:14 INFO - Using env: {'DISPLAY': ':0', 06:08:14 INFO - 'HOME': '/home/cltbld', 06:08:14 INFO - 'LANG': 'en_US.UTF-8', 06:08:14 INFO - 'LANGUAGE': 'en_US:en', 06:08:14 INFO - 'LOGNAME': 'cltbld', 06:08:14 INFO - 'MAIL': '/var/mail/cltbld', 06:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:14 INFO - 'MOZ_NO_REMOTE': '1', 06:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:14 INFO - 'NO_EM_RESTART': '1', 06:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:14 INFO - 'PWD': '/builds/slave/test', 06:08:14 INFO - 'SHELL': '/bin/bash', 06:08:14 INFO - 'SHLVL': '1', 06:08:14 INFO - 'TERM': 'linux', 06:08:14 INFO - 'TMOUT': '86400', 06:08:14 INFO - 'USER': 'cltbld', 06:08:14 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', 06:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:14 INFO - '_': '/tools/buildbot/bin/python'} 06:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:15 INFO - Running setup.py (path:/tmp/pip-ZWHEEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:15 INFO - Running setup.py (path:/tmp/pip-88Ib8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:15 INFO - Running setup.py (path:/tmp/pip-mFbVki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:15 INFO - Running setup.py (path:/tmp/pip-LpMHs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:15 INFO - Running setup.py (path:/tmp/pip-mFCbub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:15 INFO - Running setup.py (path:/tmp/pip-9EBkP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:15 INFO - Running setup.py (path:/tmp/pip-emnzJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:15 INFO - Running setup.py (path:/tmp/pip-hASlL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:15 INFO - Running setup.py (path:/tmp/pip-fe3GGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:15 INFO - Running setup.py (path:/tmp/pip-6rH4is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:15 INFO - Running setup.py (path:/tmp/pip-Cl7WR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:15 INFO - Running setup.py (path:/tmp/pip-5Povpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:16 INFO - Running setup.py (path:/tmp/pip-JaU7dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:16 INFO - Running setup.py (path:/tmp/pip-ZhHKXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:16 INFO - Running setup.py (path:/tmp/pip-9u7Ce_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:16 INFO - Running setup.py (path:/tmp/pip-_b5Ggi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:16 INFO - Running setup.py (path:/tmp/pip-aUFZm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:08:16 INFO - Running setup.py install for manifestparser 06:08:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:08:16 INFO - Running setup.py install for mozcrash 06:08:16 INFO - Running setup.py install for mozdebug 06:08:16 INFO - Running setup.py install for mozdevice 06:08:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:08:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:08:16 INFO - Running setup.py install for mozfile 06:08:16 INFO - Running setup.py install for mozhttpd 06:08:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:08:16 INFO - Running setup.py install for mozinfo 06:08:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Running setup.py install for mozInstall 06:08:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Running setup.py install for mozleak 06:08:17 INFO - Running setup.py install for mozlog 06:08:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Running setup.py install for moznetwork 06:08:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Running setup.py install for mozprocess 06:08:17 INFO - Running setup.py install for mozprofile 06:08:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Running setup.py install for mozrunner 06:08:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:08:17 INFO - Running setup.py install for mozscreenshot 06:08:17 INFO - Running setup.py install for moztest 06:08:18 INFO - Running setup.py install for mozversion 06:08:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:08:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:08:18 INFO - Cleaning up... 06:08:18 INFO - Return code: 0 06:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:18 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 0x7fc63ddccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328410>, '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 0x2329310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23297a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', '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 06:08:18 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 06:08:18 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 06:08:18 INFO - Using env: {'DISPLAY': ':0', 06:08:18 INFO - 'HOME': '/home/cltbld', 06:08:18 INFO - 'LANG': 'en_US.UTF-8', 06:08:18 INFO - 'LANGUAGE': 'en_US:en', 06:08:18 INFO - 'LOGNAME': 'cltbld', 06:08:18 INFO - 'MAIL': '/var/mail/cltbld', 06:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:18 INFO - 'MOZ_NO_REMOTE': '1', 06:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:18 INFO - 'NO_EM_RESTART': '1', 06:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:18 INFO - 'PWD': '/builds/slave/test', 06:08:18 INFO - 'SHELL': '/bin/bash', 06:08:18 INFO - 'SHLVL': '1', 06:08:18 INFO - 'TERM': 'linux', 06:08:18 INFO - 'TMOUT': '86400', 06:08:18 INFO - 'USER': 'cltbld', 06:08:18 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', 06:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:18 INFO - '_': '/tools/buildbot/bin/python'} 06:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:18 INFO - Running setup.py (path:/tmp/pip-gCI9Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:18 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)) 06:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:18 INFO - Running setup.py (path:/tmp/pip-Bqsys4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:18 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)) 06:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:18 INFO - Running setup.py (path:/tmp/pip-mMs256-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:18 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)) 06:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:18 INFO - Running setup.py (path:/tmp/pip-vTpyYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:18 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)) 06:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:18 INFO - Running setup.py (path:/tmp/pip-ai7gTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:18 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)) 06:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:18 INFO - Running setup.py (path:/tmp/pip-VxGwbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:18 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)) 06:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:18 INFO - Running setup.py (path:/tmp/pip-1A8Hgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:18 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)) 06:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:18 INFO - Running setup.py (path:/tmp/pip-UmpiaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:18 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)) 06:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:18 INFO - Running setup.py (path:/tmp/pip-lvejV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:19 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)) 06:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:19 INFO - Running setup.py (path:/tmp/pip-W8kT0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:19 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)) 06:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:19 INFO - Running setup.py (path:/tmp/pip-uHKyys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:19 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)) 06:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:19 INFO - Running setup.py (path:/tmp/pip-FvUKBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:19 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)) 06:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:19 INFO - Running setup.py (path:/tmp/pip-kinbp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:19 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)) 06:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:19 INFO - Running setup.py (path:/tmp/pip-zOa8t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:19 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)) 06:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:19 INFO - Running setup.py (path:/tmp/pip-1cqmCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:19 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)) 06:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:19 INFO - Running setup.py (path:/tmp/pip-hdCjYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:19 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)) 06:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:19 INFO - Running setup.py (path:/tmp/pip-RWfYXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:19 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)) 06:08:19 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)) 06:08:19 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)) 06:08:19 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)) 06:08:19 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)) 06:08:19 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)) 06:08:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:21 INFO - Downloading blessings-1.6.tar.gz 06:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:08:21 INFO - Installing collected packages: blessings 06:08:21 INFO - Running setup.py install for blessings 06:08:21 INFO - Successfully installed blessings 06:08:21 INFO - Cleaning up... 06:08:21 INFO - Return code: 0 06:08:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:21 INFO - Reading from file tmpfile_stdout 06:08:21 INFO - Current package versions: 06:08:21 INFO - argparse == 1.2.1 06:08:21 INFO - blessings == 1.6 06:08:22 INFO - blobuploader == 1.2.4 06:08:22 INFO - docopt == 0.6.1 06:08:22 INFO - manifestparser == 1.1 06:08:22 INFO - mozInstall == 1.12 06:08:22 INFO - mozcrash == 0.17 06:08:22 INFO - mozdebug == 0.1 06:08:22 INFO - mozdevice == 0.48 06:08:22 INFO - mozfile == 1.2 06:08:22 INFO - mozhttpd == 0.7 06:08:22 INFO - mozinfo == 0.9 06:08:22 INFO - mozleak == 0.1 06:08:22 INFO - mozlog == 3.1 06:08:22 INFO - moznetwork == 0.27 06:08:22 INFO - mozprocess == 0.22 06:08:22 INFO - mozprofile == 0.28 06:08:22 INFO - mozrunner == 6.11 06:08:22 INFO - mozscreenshot == 0.1 06:08:22 INFO - mozsystemmonitor == 0.0 06:08:22 INFO - moztest == 0.7 06:08:22 INFO - mozversion == 1.4 06:08:22 INFO - psutil == 3.1.1 06:08:22 INFO - requests == 1.2.3 06:08:22 INFO - wsgiref == 0.1.2 06:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:22 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')]} 06:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:22 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')]} 06:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:22 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 0x7fc63ddccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328410>, '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 0x2329310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23297a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', '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 06:08:22 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 06:08:22 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 06:08:22 INFO - Using env: {'DISPLAY': ':0', 06:08:22 INFO - 'HOME': '/home/cltbld', 06:08:22 INFO - 'LANG': 'en_US.UTF-8', 06:08:22 INFO - 'LANGUAGE': 'en_US:en', 06:08:22 INFO - 'LOGNAME': 'cltbld', 06:08:22 INFO - 'MAIL': '/var/mail/cltbld', 06:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:22 INFO - 'MOZ_NO_REMOTE': '1', 06:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:22 INFO - 'NO_EM_RESTART': '1', 06:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:22 INFO - 'PWD': '/builds/slave/test', 06:08:22 INFO - 'SHELL': '/bin/bash', 06:08:22 INFO - 'SHLVL': '1', 06:08:22 INFO - 'TERM': 'linux', 06:08:22 INFO - 'TMOUT': '86400', 06:08:22 INFO - 'USER': 'cltbld', 06:08:22 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', 06:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:22 INFO - '_': '/tools/buildbot/bin/python'} 06:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:22 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)) 06:08:22 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)) 06:08:22 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)) 06:08:22 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)) 06:08:22 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)) 06:08:22 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)) 06:08:22 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)) 06:08:22 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)) 06:08:22 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)) 06:08:22 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)) 06:08:22 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)) 06:08:22 INFO - Cleaning up... 06:08:22 INFO - Return code: 0 06:08:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:08:22 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')]} 06:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:22 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')]} 06:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:22 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 0x7fc63ddccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328410>, '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 0x2329310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23297a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', '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 06:08:22 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 06:08:22 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 06:08:22 INFO - Using env: {'DISPLAY': ':0', 06:08:22 INFO - 'HOME': '/home/cltbld', 06:08:22 INFO - 'LANG': 'en_US.UTF-8', 06:08:22 INFO - 'LANGUAGE': 'en_US:en', 06:08:22 INFO - 'LOGNAME': 'cltbld', 06:08:22 INFO - 'MAIL': '/var/mail/cltbld', 06:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:22 INFO - 'MOZ_NO_REMOTE': '1', 06:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:22 INFO - 'NO_EM_RESTART': '1', 06:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:22 INFO - 'PWD': '/builds/slave/test', 06:08:22 INFO - 'SHELL': '/bin/bash', 06:08:22 INFO - 'SHLVL': '1', 06:08:22 INFO - 'TERM': 'linux', 06:08:22 INFO - 'TMOUT': '86400', 06:08:22 INFO - 'USER': 'cltbld', 06:08:22 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', 06:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:22 INFO - '_': '/tools/buildbot/bin/python'} 06:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:22 INFO - Downloading/unpacking jsonschema 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:08:24 INFO - Downloading/unpacking functools32 (from jsonschema) 06:08:24 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 06:08:24 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 06:08:24 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 06:08:24 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 06:08:24 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 06:08:24 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 06:08:24 INFO - Downloading functools32-3.2.3-2.tar.gz 06:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:08:24 INFO - warning: no files found matching '*.txt' 06:08:24 INFO - no previously-included directories found matching 'build' 06:08:24 INFO - no previously-included directories found matching 'dist' 06:08:24 INFO - no previously-included directories found matching '.git*' 06:08:24 INFO - Installing collected packages: jsonschema, functools32 06:08:24 INFO - Running setup.py install for functools32 06:08:24 INFO - warning: no files found matching '*.txt' 06:08:24 INFO - no previously-included directories found matching 'build' 06:08:24 INFO - no previously-included directories found matching 'dist' 06:08:24 INFO - no previously-included directories found matching '.git*' 06:08:24 INFO - Successfully installed jsonschema functools32 06:08:24 INFO - Cleaning up... 06:08:24 INFO - Return code: 0 06:08:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:24 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 0x7fc63ddccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328410>, '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 0x2329310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23297a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', '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 06:08:24 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 06:08:24 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 06:08:24 INFO - Using env: {'DISPLAY': ':0', 06:08:24 INFO - 'HOME': '/home/cltbld', 06:08:24 INFO - 'LANG': 'en_US.UTF-8', 06:08:24 INFO - 'LANGUAGE': 'en_US:en', 06:08:24 INFO - 'LOGNAME': 'cltbld', 06:08:24 INFO - 'MAIL': '/var/mail/cltbld', 06:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:24 INFO - 'MOZ_NO_REMOTE': '1', 06:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:24 INFO - 'NO_EM_RESTART': '1', 06:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:24 INFO - 'PWD': '/builds/slave/test', 06:08:24 INFO - 'SHELL': '/bin/bash', 06:08:24 INFO - 'SHLVL': '1', 06:08:24 INFO - 'TERM': 'linux', 06:08:24 INFO - 'TMOUT': '86400', 06:08:24 INFO - 'USER': 'cltbld', 06:08:24 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', 06:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:24 INFO - '_': '/tools/buildbot/bin/python'} 06:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:24 INFO - Downloading/unpacking flake8 06:08:24 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 06:08:24 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 06:08:24 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 06:08:24 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 06:08:24 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 06:08:24 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 06:08:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:08:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:08:26 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 06:08:26 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 06:08:26 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 06:08:26 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 06:08:26 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 06:08:26 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 06:08:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:08:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:08:27 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 06:08:27 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 06:08:27 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 06:08:27 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 06:08:27 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 06:08:27 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 06:08:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:08:27 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 06:08:27 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 06:08:27 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 06:08:27 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 06:08:27 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 06:08:27 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 06:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:08:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:27 INFO - no previously-included directories found matching 'docs/_build' 06:08:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:08:28 INFO - Running setup.py install for pep8 06:08:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:28 INFO - no previously-included directories found matching 'docs/_build' 06:08:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:08:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:08:28 INFO - Cleaning up... 06:08:28 INFO - Return code: 0 06:08:28 INFO - Running post-action listener: _resource_record_post_action 06:08:28 INFO - Running post-action listener: _start_resource_monitoring 06:08:28 INFO - Starting resource monitoring. 06:08:28 INFO - ##### 06:08:28 INFO - ##### Running install step. 06:08:28 INFO - ##### 06:08:28 INFO - Running pre-action listener: _resource_record_pre_action 06:08:28 INFO - Running main action method: install 06:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:28 INFO - Reading from file tmpfile_stdout 06:08:28 INFO - Detecting whether we're running mozinstall >=1.0... 06:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:08:28 INFO - Reading from file tmpfile_stdout 06:08:28 INFO - Output received: 06:08:28 INFO - Usage: mozinstall [options] installer 06:08:28 INFO - Options: 06:08:28 INFO - -h, --help show this help message and exit 06:08:28 INFO - -d DEST, --destination=DEST 06:08:28 INFO - Directory to install application into. [default: 06:08:28 INFO - "/builds/slave/test"] 06:08:28 INFO - --app=APP Application being installed. [default: firefox] 06:08:28 INFO - mkdir: /builds/slave/test/build/application 06:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:08:44 INFO - Reading from file tmpfile_stdout 06:08:44 INFO - Output received: 06:08:44 INFO - /builds/slave/test/build/application/firefox/firefox 06:08:44 INFO - Running post-action listener: _resource_record_post_action 06:08:44 INFO - ##### 06:08:44 INFO - ##### Running run-tests step. 06:08:44 INFO - ##### 06:08:44 INFO - Running pre-action listener: _resource_record_pre_action 06:08:44 INFO - Running main action method: run_tests 06:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:08:44 INFO - Python 2.7.3 06:08:44 INFO - Return code: 0 06:08:44 INFO - grabbing minidump binary from tooltool 06:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:44 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 0x2328410>, '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 0x2329310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23297a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:08:44 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 06:08:44 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 06:08:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:08:44 INFO - Return code: 0 06:08:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:08:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:08:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:08:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:08:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:08:45 INFO - Return code: 0 06:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 06:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 06:08:45 INFO - Using env: {'DISPLAY': ':0', 06:08:45 INFO - 'HOME': '/home/cltbld', 06:08:45 INFO - 'LANG': 'en_US.UTF-8', 06:08:45 INFO - 'LANGUAGE': 'en_US:en', 06:08:45 INFO - 'LOGNAME': 'cltbld', 06:08:45 INFO - 'MAIL': '/var/mail/cltbld', 06:08:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:08:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:45 INFO - 'MOZ_NO_REMOTE': '1', 06:08:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:45 INFO - 'NO_EM_RESTART': '1', 06:08:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:45 INFO - 'PWD': '/builds/slave/test', 06:08:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:08:45 INFO - 'SHELL': '/bin/bash', 06:08:45 INFO - 'SHLVL': '1', 06:08:45 INFO - 'TERM': 'linux', 06:08:45 INFO - 'TMOUT': '86400', 06:08:45 INFO - 'USER': 'cltbld', 06:08:45 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572', 06:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:45 INFO - '_': '/tools/buildbot/bin/python'} 06:08:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 06:08:45 INFO - mozversion application_buildid: 20160419230832 06:08:45 INFO - mozversion application_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 06:08:45 INFO - mozversion application_display_name: Nightly 06:08:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:08:45 INFO - mozversion application_name: Firefox 06:08:45 INFO - mozversion application_remotingname: firefox 06:08:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:08:45 INFO - mozversion application_vendor: Mozilla 06:08:45 INFO - mozversion application_version: 48.0a1 06:08:45 INFO - mozversion platform_buildid: 20160419230832 06:08:45 INFO - mozversion platform_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 06:08:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:08:45 INFO - mozversion platform_version: 48.0a1 06:08:45 INFO - using testdate: 1461330525 06:08:45 INFO - actual date: 1461330525 06:08:45 INFO - starting webserver on 'localhost:57324' 06:08:45 INFO - SUITE-START | Running 2 tests 06:08:45 INFO - TEST-START | dromaeo_css 06:08:45 INFO - operating with platform_type : linux_ 06:08:45 INFO - Initialising browser for dromaeo_css test... 06:08:45 INFO - TEST-INFO | started process 6270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUv7gOi/profile http://localhost:57324/getInfo.html) 06:08:50 INFO - PROCESS | 6270 | __metrics Screen width/height:1600/1200 06:08:50 INFO - PROCESS | 6270 | colorDepth:24 06:08:50 INFO - PROCESS | 6270 | Browser inner width/height: 1024/697 06:08:50 INFO - PROCESS | 6270 | __metrics 06:08:51 ERROR - PROCESS | 6270 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:08:52 INFO - TEST-INFO | 6270: exit 0 06:08:52 INFO - Browser initialized. 06:08:52 INFO - Running cycle 1/1 for dromaeo_css test... 06:08:52 INFO - TEST-INFO | started process 6353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUv7gOi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:03 INFO - PROCESS | 6353 | RSS: Main: 155467776 06:09:03 INFO - PROCESS | 6353 | 06:09:55 INFO - PROCESS | 6353 | 1461330595443 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] 06:12:06 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:57324/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57324/tests/dromaeo/cssquery-ext.html) 06:12:07 INFO - PROCESS | 6353 | RSS: Main: 226598912 06:12:07 INFO - PROCESS | 6353 | 06:15:10 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:57324/tests/dromaeo/cssquery-ext.html (next: http://localhost:57324/tests/dromaeo/cssquery-jquery.html) 06:15:10 INFO - PROCESS | 6353 | RSS: Main: 234512384 06:15:10 INFO - PROCESS | 6353 | 06:18:12 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:57324/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57324/tests/dromaeo/cssquery-mootools.html) 06:18:13 INFO - PROCESS | 6353 | RSS: Main: 239583232 06:18:13 INFO - PROCESS | 6353 | 06:21:15 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:57324/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57324/tests/dromaeo/cssquery-prototype.html) 06:21:16 INFO - PROCESS | 6353 | RSS: Main: 230109184 06:21:16 INFO - PROCESS | 6353 | 06:24:19 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:57324/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57324/tests/dromaeo/cssquery-yui.html) 06:24:19 INFO - PROCESS | 6353 | RSS: Main: 210096128 06:24:19 INFO - PROCESS | 6353 | 06:27:22 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:57324/tests/dromaeo/cssquery-yui.html (next: http://localhost:57324/tests/dromaeo/cssquery-dojo.html) 06:27:22 INFO - PROCESS | 6353 | RSS: Main: 268562432 06:27:22 INFO - PROCESS | 6353 | 06:27:22 INFO - PROCESS | 6353 | __start_tp_report 06:27:22 INFO - PROCESS | 6353 | _x_x_mozilla_page_load 06:27:22 INFO - PROCESS | 6353 | _x_x_mozilla_page_load_details 06:27:22 INFO - PROCESS | 6353 | |i|pagename|runs| 06:27:22 INFO - PROCESS | 6353 | |0;dojo.html;2586.379268975446;2649.6158057081734;2651.615515750215;2676.53160696878;2695.083671551672;4425.468943726749;4497.437820272466;4568.223402021656;4575.839845605405;4587.977060114703;4485.775711214443;4604.7237165770075;4623.907521849561;4637.327587499811;4659.510751371108;4257.552956939523;4290.978545107278;4336.04606986464;4367.45406824147;4450;4369.606735393814;4395.626371758389;4413.139437809628;4418.469783625953;4447.466304043519;4099.999999999985;4208.558101399371;4227.365895115727;4237.089025859455;4309.676774241944;4301.44081269433;4326.913461730748;4332.805023773906;4335.913281734379;4384.21084204843;4316.56834316569;4321.157374312011;4327.870163895088;4330.761808100553;4373.759443230621;4409.581089796464;4462.665300102505;4485.9551404485865;4541.023679908835;4560.315952607136;4892.584130348924;4903.754812259408;4905.141600219983;4940.53064958832;4947.851564453073;4905.828296009622;4926.729029903354;4928.901421971576;4931.0630980113665;4933.851984440436;4465.129299786543;4546.954530454686;4605.148047611203;4632.420947381577;4645.6980296280635;4990.126727822617;5032.72320022395;5034.370703662043;5041.798328066836;5078.771455284521;4700.929486057712;4830.541098595628;4833.32333473314;4833.927491087637;4874.53691899269;4908.950910490849;4945.629077819178;4946.851594452172;4984.925226121611;4989.725565093882;4851.151048566487;4874.975625121851;4879.097366987119;4888.6577939543895;4929.75351232437;4716.693414928019;4856.368672072608;4863.8540843774745;4898.044881248123;4917.754112294371;4146.813393397304;4148.087420767426;4172.603602657743;4184.351425529047;4194.098268872207;3643.908902277464;3648.0150359402815;3651.4522821576975;3678.6321367863;3686.981565092211;4162.875113746592;4208.053188032729;4225.176090662353;4238.152369526107;4252.064545799919;4889.242167464049;4929.088118698052;4929.630277729185;4974.452810190876;4976.651634385558;4218.767967761742;4249.532551419341;4252.510961239497;4280.464941882265;4287.549807270254;4286.978565107217;4401.383806267125;4450.799714012877;4451.755153466591;4455.331700244989;4724.503927087606;4728.881777955578;4740.1230772307235;4744.478107408113;4784.282357646381;4987.2768448574025;4989.675671081368;4991.700497970133;4998.175301075427;5009.4489606144025;4576.405067341224;4638.466576343763;4693.178693728652;4739.526047395233;4755.667103302736;4794.30482580017;4817.1810792164715;4817.831375901967;4867.780949857336;4872;4863.003084367625;4882.951170488392;4885.706857588556;4888.902221955612;4943.283223932582;4608.769561521977;4768.070226305837;4791.616670666408;4820.035992801384;4864.805407783649;4749.620030397629;4774.809007639795;4800.66395352322;4803.351547541037;4845.297431872429;4693.131770622445;4709.740964246862;4717.693349932243;4742.1227072991605;4760.119377915097;4666.206744853315;4791.257355109963;4827.517248275144;4896.461389247252;4927.310176575354;4721.362616046789;4723.291506274087;4727.787249573708;4729.054189162112;4795.424549054136 06:27:22 INFO - PROCESS | 6353 | |1;ext.html;589.201631788926;599.7151353107272;603.3544107804651;603.5624172474957;622.8007037747919;32926;34342.48486272702;34399.48400773987;34414.13964650882;34474.827625861835;37143.44284835723;37801;37803.24393512135;37830.4603447586;37881.810590947076;7642.350400215974;7817.257360550767;7835.451518393715;7840.4511684182135;7842.72550460734;7668.501547399401;7773.067231932176;7780.727674531393;7796.688132474723;7808.102068262166;7926.564038977854;8011.1187769345615;8014.67941282348;8018.278354948054;8018.398620103487;7896.170902055288;7949.205079492062;7962.243586859239;7966.840663186733;7972.561509116997;7837.7648670539975;7933.048034235871;7934.642941067666;7938.880916786253;7944.801379965547;36438.453423198676;36922.81538592317;36923;36935.445968310494;36941.07647308812;3075.4464196444633;3223.7904536205074;3280.721138703213;3284.129705627987;3524.4889491023914;27463.862680686667;28068.719312806814;28161.718382816114;28312.292192695142;29357.70642293571;3339.332133573295;3353.161709572607;3403.5915690117345;3413.607435144965;3420.7776494527775;170549;277293.3623982567;284279;286059.5697021522;286682;46941.765291173324;47167.764161179664;47447;47455.52544474511;47462;50677.49322506728;56379.71810140923;57929.71035144882;58115.12827307594;58143.12785308224;13076.542321018718;13160.210387376597;13164.60506184816;13186.868131318564;13200.20798752078;9274.258059355236;9725.756856078513;10289.588416463257;10356.119729823049;10431.269811113149;17254.482365529053;17277;17325.913370433067;17458;17498.300067997392;6671.532992690562;6723.596584204865;6798.637675658868;6873.278305777922;6929.995150703221;869.6217145541709;879.5997820991433;881.5371929736812;893.8122994171297;1064.446487826326;26601.33496662599;28025.579616305364;28188.93230858391;28541.857290713415;28572.571411428846;970.4274478057838;1008.505832142245;1021.402479549457;1050.8844027157006;1077.49357801833;14284.928575357057;15040;15040.924795375953;15099.698006040038;15103.093814370954;154147;156684;157143;157429;157800.21099894427;48384;49088;49182.262266066034;49189.50810491921;49230.50769492259;1111.6720567432626;1259.8551166615773;1269.435101379877;1308.9659169256372;1351.6418149190472;25722.614160787976;27504.21736656658;27696.307592310353;27797.583036254877;28160.43679126365;37835.81082094572;38104.428433574074;38434.42348364833;38474.42288365621;38586.42120368253;207645;208767;209895;210569;211180.88819112227;22139.1144354224;23054.654180187645;24952.500949981262;25670.8716456424;25718;35589.82205088958;35634.82182589071;36286.09711223043;36422.453663194545;36617.63382366249;30808;30884.227894301923;31207.84396078005;31217.53173702351;31286;30786.84606576953;31027.68972310248;31273.218169545944;31420.528692070093;32544.674553254164;33422.33155336831;33995;34249;34417.655823442445;34474.82762586171;30441.391172176875;30695;31108.844455777577;31130;31168.688313117487;23745.406364840324;23883;24217.51564968726;24321.148759793323;24612.138575149784 06:27:22 INFO - PROCESS | 6353 | |2;jquery.html;377.0235091114015;383.27560909880316;389.7817222355481;390.5489160020176;391.79039214020503;15644.608884777872;16592.33630654774;16817.075060871648;16829.326826926907;16834.747478787827;14762;14813.851861481382;15452;15454.227288635551;15470.303836327364;4527.796249168787;4642.721436713808;4673.859784206462;4680.5787479126875;4680.906381872361;3448.982755086221;5064.468230835764;5297.337832770903;5328.893422131555;5331.253624492574;5285.867853303679;5306.973465132669;5307.336582927134;5308.256844041837;5336.706481143536;5607.243022191993;5860.443257890493;5863.530917526609;5864;5867.501262392701;4683.765811709435;5086.109930762102;5277.498637629457;5281.313429254173;5283.128283833163;12262.386880655931;12265.632031039084;12380.566680166152;12386.566470173591;12393.62819115428;1781.1628534588851;1801.9189136488758;1855.109547417234;1869.0094250047496;1929.5465565592074;8864.822703545957;9062.184403403659;9140.405873618194;9197.540122993823;9303.627854885865;1677.069226579248;1689.4087069525567;1713.0321368426798;1716.450735764556;1778.1109445277361;63845.68077159631;68980.6550967247;69549;69721.65139174322;70261.2973870265;9867.950660246797;9921.206303495703;10102.272386455616;10249.436281004468;10876.728081798019;13767.931160344135;13832.30838458073;13840.169589824442;13883.861161388257;13909.026368154133;6990.161180658353;7163.176234733072;7239.638018099074;7287.161976372679;7313.414926805843;6638.6680665966505;6647.86704265912;6807.217170025411;6821.522493425512;6825.48808839339;4236.173946080485;4326.329418940069;4327.502337231196;4332.328489084134;4443.33349997503;1653.115583163002;1706.9146542672818;1812.664657038452;1835.972460413095;1840.981590184081;886.5035580075179;933.8132373525186;969.016448304971;974.4737841565617;999.1257649556638;16048.839511604734;16110.194490275439;16334.918325408296;16522.339106435847;16567.834321656872;847.1063028504987;853.5646820121783;875.2866413872673;877.2061284537504;913.3378300731916;8741.606627701769;9227.215686666574;9284.118008789153;9419.529023548796;9443.858342124873;357976;370401;371422;376797;379974;77276;78801;78825.21174788178;78872;78996.60501697454;890.955452227386;897.9191872731485;906.9138431848963;916.1022198245623;950.5104870991584;14201.573952781433;14425.49510767118;14432.711345773236;14600.415983360972;14844.480443184437;33335.83332083324;33455;33510;33626.66373336333;33851.492227616116;47805;48691.269630956274;48791.26813097877;48918.51081489282;49040;7714.884276735966;7715.614219289126;7787.845922401437;7883.921160788548;7894.052713674396;11560.075193984292;11696.35670038122;11769;11793.646190614296;12123.333216672814;9911.900880991387;9942.453165075991;10100.949495252476;10301.896981030093;10479.214058945458;10132.392056476636;10166.237532185263;10183.541740621542;10262.743431414274;10418.531166097695;10065.69802905914;10387.480625968521;10454.0068693474;10647.574097036031;10658.360498370123;7769.223077692185;7798.844023119393;7803.063632364153;7907.56508392044;7940.801479963047;9551.617935282511;10448.477576121315;10526.105281051196;10635.308704934465;10638.89361106379 06:27:22 INFO - PROCESS | 6353 | |3;mootools.html;1255.522901297508;1441.3946142620098;1505.8117735283092;1636.3209268153716;1833.9633207335862;7518.661660225289;7821.882671759914;7828.882566761489;7833.76498705039;7840.568768717718;7587.317141457268;7730.265624765652;7753.457257991929;7754.961225193866;7756.146823849372;1890.5368184794677;1964.901754912256;1966.6558352288364;2222.83328750344;2257.480779420726;2221.522372689871;2312.745597984229;2315.9536809263805;2316.745158032615;2317.5017371265176;2161.4164175672636;2169.208238992764;2185.519185779126;2197.13213280754;2202.0861342542826;1875.7373967644542;2171.565686862618;2273.624851899435;2278.6695929090274;2283.5547068321684;2213.701150344715;2237.3959031061686;2239.093167267243;2241.4396400899777;2248.415411992877;7347.3020063094455;7393.223711510322;7397.18630950595;7403.185649578542;7405.74079907206;4555.453345598549;4775.9283610745515;4779.115863565252;4782.904341913177;4809.446913604946;2866.3693987322754;3069.0946170879643;3074.661787203428;3086.7807216149718;3097.550855126017;908.8227795579865;926.2960150285764;927.2859897878664;947.6209516193509;953.2659851913987;10612.46937653122;10878.61924832635;10912.072473839733;10931.125509959184;10931.83602245959;4121.196366708523;4161.583841615814;4301.247281725686;4303.870883873489;4460.553944605514;9322.953385233166;9377.437353758796;9388.436693798394;9411.4823684698;9416.152546270869;4868.659193856396;4882.633802464758;4891.119598472238;4892.241702536113;4902.411710594752;3827.2154208387215;4251.06476575153;4387.561243875587;4419.1382680377665;4428.7121337112985;3741.981290093532;3773.509443772347;3791.658750712449;3830.042489377656;3904.39481880309;1239.6343078791779;1299.4672184404349;1304.9021323400593;1307.4378017452586;1312.527490103562;913.2785099771239;915.2997956563235;917.6831247160346;918.9540522973824;943.6697155995347;5651.208830763697;5677.432256774372;5783.363829978699;5783.88432231353;5808.244928159313;864.4251572704081;896.1934259166802;939.8543225800012;942.1097063275276;946.7928391301009;3596.514470546495;3757.2485502898985;3864.613538646113;3968.7817170055923;4047.1905618875753;9194.26445884341;9502.524873756285;9627.807443851083;9644.228461723045;10186.949065254626;9482.668106616235;9514.28642851789;9523.28575356851;9551;9571.808563828685;7105.43156547475;7124.643767811589;7247.275272472711;7277.781666550012;7289.927100728924;5334.19246115341;5477.835664930059;5575.414581469049;5736.942630573641;5819.6508209507565;8901.33240006989;8997.415168014059;9013.504257265913;9026.729198124067;9037.502937338246;8859.11408859109;9053.411528250643;9153.405028673114;9164.770880727769;9252.444853308823;5955.434233747787;6288.088227207121;6298.496120310456;7045.718171273092;7197.49617526789;6762.628055456997;7319.926800731924;7552;7558.433117516318;7590.468667193243;6797.830054248683;6866.313368663094;6907.34380233877;6999.440044796506;7041.753538626123;6878.58728476273;6953.304669533006;6957.478189135733;7051.541649792747;7093.574385536885;6457.225132984072;6477.676116194078;6566.573172743756;6573.1783527059115;6582.275949645439;4720.740359280273;4791.377120974251;4829.034193161452;4892.8532144035735;4970.179920313108;4815.518448155157;4819.397575303087;4826.975865120792;4871.878203044952;4903.26451032348 06:27:22 INFO - PROCESS | 6353 | |4;prototype.html;309.1745040741221;312.17585574084416;320.25221108711156;323.3097337185109;326.5917602996255;4899.289603007562;4947.480514545975;4981.825636102737;4984.202527595586;5005.299258103868;4880;4904.656674032819;4911.484294149108;4922.114019476493;4923.286123512089;3695.90760230995;3755.2301778135416;3865.323568375537;3876.069743261611;3885.734829306292;3880.641775378623;3904.726669133162;3912.3349030664713;3923.823427945735;3925.725199236055;3651.6165802590745;3874.2638898609316;3886.2227554489073;3888.786116763577;3897.9805100974454;3775.7168212384045;3894.922101557953;3905.1213476967455;3915.158240978203;3918.098837267416;3464.428369319059;3466.843992020365;3474.774139680938;3479.6868281854754;3485.9128521786906;4696.131215725101;4702.741349225791;4705.976470117662;4715.95284047162;4726.314684370781;4249.766262855542;4422.506220086128;4446.399736035626;4447.755373454459;4471.53048929861;5112.744362781846;5125.538701516882;5126.0521002018995;5135;5138.434772175057;3785.9810700946596;3793.905152371185;3796.867109651149;3798.2593394288124;3804.4782087165077;5268.341457317835;5310.946890531084;5361.169018802131;5391.622586418913;5400.540954018913;3861.7489863159367;3861.806909654506;3880.4567360569545;3888.9805550972064;3889.1055057336407;3893.9610603894166;3930.567637559866;3935.5080614923136;3938.1729836734035;3953.920921581552;4268.701190916606;4391.363252328459;4405.471343438744;4407.162639098561;4430.379746835446;5040.344755181803;5117.71852548106;5130.871728206825;5144.511271429208;5153.392625162402;1350.6083235861686;1374.271636032904;1374.731927274192;1381.2679279981626;1382.5506710318984;874.6807415293372;935.2891802230354;949.4161090929028;961.110972350573;963.8987906269881;4479.820807167742;4488.281874900001;4512.706674066175;4526.932096018562;4534.7052441591195;5237.240600112962;5246.639012444339;5246.842594722164;5250.894982100336;5259.710715910585;4383.736975781463;4481.3726078349055;4522.321651752263;4523.7285762854335;4526.977365113154;2780.2354352552807;2782.9025984090863;2799.622051023086;2805.621241132462;2809.90165344212;4979.925301120486;4983.526564976321;4994.725290109006;4996.90006199874;5001.849944501598;5206.921896171561;5323.467653234723;5358.892822143535;5360.758765855546;5363.249145119687;4965.776540055778;4981.950180498221;4984.22744474607;4984.27727979441;4984.401871775338;5233.958756085054;5249.422563517934;5249.89500209986;5257.8695580450385;5260.579153667621;4964.528369804862;5121;5127.589792816491;5133.717645529532;5148.227765835155;4958.256261560795;4981.850544483671;4983.900321993612;4988.750562471934;4999.65002449825;3878.786666733357;3880.7089468290555;3882.52464063654;3885.1258466844733;3895.8831235062994;5024.547790698854;5219.686818790885;5224.817131400383;5341.732913354239;5371.785128594969;5178.741062946913;5192.169252919514;5192.5586325162785;5192.662476938987;5198.142306519533;5059.139946209079;5100.897982040264;5142.6914385137015;5150.99555586657;5198.610104242272;4832.202686556679;5048.693106015566;5081.288619593186;5101.974490127525;5108.361454818148;4938.604911606991;5013.949860501349;5230.137027390438;5231.843044708665;5241.790328386975;5104.923426148685;5112.182050871991;5115.7953681852305;5117.667351622133;5124.180131178993 06:27:22 INFO - PROCESS | 6353 | |5;yui.html;667.3560014585923;678.9524733268673;698.3400686351397;704.707546368257;705.7459314646726;11741.647750567487;11851.940740296286;11923.64229073128;11939.34333611651;11941.820872686916;11559.711007224823;12846.16499927504;13184.077114601982;13211.339433028359;13213.735725285489;821.2772759971217;823.8928939237906;827.9710210142646;828.3828547731948;828.3952714518375;649.438235925923;791.762471258623;824.1799409587469;827.7723626002837;828.0725587342185;854.5214679779313;857.4555157474986;860.0453496618749;861.1259571534897;862.525610913998;669.2003056347667;852.4544291653347;855.8630619100945;856.2678909532385;856.6659002988871;618.1716499890168;631.0376675569793;632.715278124841;632.8544434780026;633.2559242889587;11889.702757431047;11922.10584206188;11962.641120766391;11978;11990.04079673624;11489.942550287195;12004.759904801942;12134.817977730341;12513.186642868184;12537.811932821014;8663.220310172052;8810.779730506725;8897.555122243926;8911.55442227886;9120.087991200893;2869.6986816384397;2870.454613623405;2875.2093174377005;2907.3022474606155;2977.0919869439813;44336.334954975704;44773.328400074024;44852.77573612144;47953.520464795605;50255.24617130782;9762.804743905082;10139.594416223268;10276.972302769664;10293.382397056052;10386.272960892817;16424.917875410785;16446.506604801874;16455;16459.5885102871;16633.417830375878;5978.970105149533;6015.578909476382;6041.848953776191;6114.5414093942245;6142.477889379453;3288.490284005983;3306.3883181611477;3337.241187457762;3372.9494057589154;3517;2695.986520067387;2789.065663002876;2794.720527947189;2795.748382645572;2796.314902848815;488.7116601205306;494.1870622825432;505.4591587001873;508.0905179728319;508.5982074161445;540.8783023819609;557.6096732287334;571.6512927114456;573.377884994777;584.9766009359578;7424.368928641018;7578.772636820904;7916.366690664733;7938.126806051329;8112;531.8909623527168;535.7267793425303;546.8906218756265;559.8684309187338;572.4504475703371;3516.7538272320694;3629.891103266906;3658.8719394821055;3678.0437086357206;3704.388775852008;50171.74914125479;51020.489795101574;51167.48832511702;51229.7438512805;51254.487455125716;45855.5414445858;46319.30521042187;46504.069918602116;47157;47216.5278347219;40147.79926100351;40562.188756224714;41727.58272417237;42441.57558424438;43864.561354386045;6973.6164510952385;7015.614141222078;7021.473389495706;7050.788476345718;7117.608531530608;26006.609900851123;26851;27604.309892252855;27877.721222787513;29546.852265738533;34635;35261.82369088138;35455.11362215965;36181.457278140326;36209;10410.323328983592;10444.582216711551;10508.21188410857;10528.684139475828;10589.36463812143;11077;11145.331280123219;11537.769244614892;11541.942290288494;12268;10460.843087353544;10641.733956651145;10839.67480975572;11021.118310534977;11202.271852329572;9757;9796.21630269591;9894.653687120915;9909.851352229578;9934.801303974025;10203.438810865473;10363.896361036293;10408.219383546113;10540.314879532805;10781.730456738644;8238.794030149294;8765.737027889174;8980.236679882284;9003.549822508718;9185.265178785547;8445.282151017233;8457.788555286166;8492.490450572985;8545.273651739672;8686 06:27:22 INFO - PROCESS | 6353 | __end_tp_report 06:27:22 INFO - PROCESS | 6353 | __start_cc_report 06:27:22 INFO - PROCESS | 6353 | _x_x_mozilla_cycle_collect,1074 06:27:22 INFO - PROCESS | 6353 | __end_cc_report 06:27:22 INFO - PROCESS | 6353 | __startTimestamp1461331642769__endTimestamp 06:27:22 INFO - PROCESS | 6353 | 06:27:22 INFO - PROCESS | 6353 | ------- Summary: start ------- 06:27:22 INFO - PROCESS | 6353 | Number of tests: 6 06:27:22 INFO - PROCESS | 6353 | 06:27:22 INFO - PROCESS | 6353 | [#0] dojo.html Cycles:165 Average:4561.49 Median:4709.74 stddev:458.47 (9.7%) stddev-sans-first:432.90 06:27:22 INFO - PROCESS | 6353 | Values: 2586.4 2649.6 2651.6 2676.5 2695.1 4425.5 4497.4 4568.2 4575.8 4588.0 4485.8 4604.7 4623.9 4637.3 4659.5 4257.6 4291.0 4336.0 4367.5 4450.0 4369.6 4395.6 4413.1 4418.5 4447.5 4100.0 4208.6 4227.4 4237.1 4309.7 4301.4 4326.9 4332.8 4335.9 4384.2 4316.6 4321.2 4327.9 4330.8 4373.8 4409.6 4462.7 4486.0 4541.0 4560.3 4892.6 4903.8 4905.1 4940.5 4947.9 4905.8 4926.7 4928.9 4931.1 4933.9 4465.1 4547.0 4605.1 4632.4 4645.7 4990.1 5032.7 5034.4 5041.8 5078.8 4700.9 4830.5 4833.3 4833.9 4874.5 4909.0 4945.6 4946.9 4984.9 4989.7 4851.2 4875.0 4879.1 4888.7 4929.8 4716.7 4856.4 4863.9 4898.0 4917.8 4146.8 4148.1 4172.6 4184.4 4194.1 3643.9 3648.0 3651.5 3678.6 3687.0 4162.9 4208.1 4225.2 4238.2 4252.1 4889.2 4929.1 4929.6 4974.5 4976.7 4218.8 4249.5 4252.5 4280.5 4287.5 4287.0 4401.4 4450.8 4451.8 4455.3 4724.5 4728.9 4740.1 4744.5 4784.3 4987.3 4989.7 4991.7 4998.2 5009.4 4576.4 4638.5 4693.2 4739.5 4755.7 4794.3 4817.2 4817.8 4867.8 4872.0 4863.0 4883.0 4885.7 4888.9 4943.3 4608.8 4768.1 4791.6 4820.0 4864.8 4749.6 4774.8 4800.7 4803.4 4845.3 4693.1 4709.7 4717.7 4742.1 4760.1 4666.2 4791.3 4827.5 4896.5 4927.3 4721.4 4723.3 4727.8 4729.1 4795.4 06:27:22 INFO - PROCESS | 6353 | 06:27:22 INFO - PROCESS | 6353 | [#1] ext.html Cycles:180 Average:37071.46 Median:18674.08 stddev:56045.24 (300.1%) stddev-sans-first:56135.51 06:27:22 INFO - PROCESS | 6353 | Values: 589.2 599.7 603.4 603.6 622.8 32926.0 34342.5 34399.5 34414.1 34474.8 37143.4 37801.0 37803.2 37830.5 37881.8 7642.4 7817.3 7835.5 7840.5 7842.7 7668.5 7773.1 7780.7 7796.7 7808.1 7926.6 8011.1 8014.7 8018.3 8018.4 7896.2 7949.2 7962.2 7966.8 7972.6 7837.8 7933.0 7934.6 7938.9 7944.8 36438.5 36922.8 36923.0 36935.4 36941.1 3075.4 3223.8 3280.7 3284.1 3524.5 27463.9 28068.7 28161.7 28312.3 29357.7 3339.3 3353.2 3403.6 3413.6 3420.8 170549.0 277293.4 284279.0 286059.6 286682.0 46941.8 47167.8 47447.0 47455.5 47462.0 50677.5 56379.7 57929.7 58115.1 58143.1 13076.5 13160.2 13164.6 13186.9 13200.2 9274.3 9725.8 10289.6 10356.1 10431.3 17254.5 17277.0 17325.9 17458.0 17498.3 6671.5 6723.6 6798.6 6873.3 6930.0 869.6 879.6 881.5 893.8 1064.4 26601.3 28025.6 28188.9 28541.9 28572.6 970.4 1008.5 1021.4 1050.9 1077.5 14284.9 15040.0 15040.9 15099.7 15103.1 154147.0 156684.0 157143.0 157429.0 157800.2 48384.0 49088.0 49182.3 49189.5 49230.5 1111.7 1259.9 1269.4 1309.0 1351.6 25722.6 27504.2 27696.3 27797.6 28160.4 37835.8 38104.4 38434.4 38474.4 38586.4 207645.0 208767.0 209895.0 210569.0 211180.9 22139.1 23054.7 24952.5 25670.9 25718.0 35589.8 35634.8 36286.1 36422.5 36617.6 30808.0 30884.2 31207.8 31217.5 31286.0 30786.8 31027.7 31273.2 31420.5 32544.7 33422.3 33995.0 34249.0 34417.7 34474.8 30441.4 30695.0 31108.8 31130.0 31168.7 23745.4 23883.0 24217.5 24321.1 24612.1 06:27:22 INFO - PROCESS | 6353 | 06:27:22 INFO - PROCESS | 6353 | [#2] jquery.html Cycles:180 Average:23304.23 Median:4485.56 stddev:61472.58 (1370.5%) stddev-sans-first:61620.92 06:27:22 INFO - PROCESS | 6353 | Values: 377.0 383.3 389.8 390.5 391.8 15644.6 16592.3 16817.1 16829.3 16834.7 14762.0 14813.9 15452.0 15454.2 15470.3 4527.8 4642.7 4673.9 4680.6 4680.9 3449.0 5064.5 5297.3 5328.9 5331.3 5285.9 5307.0 5307.3 5308.3 5336.7 5607.2 5860.4 5863.5 5864.0 5867.5 4683.8 5086.1 5277.5 5281.3 5283.1 12262.4 12265.6 12380.6 12386.6 12393.6 1781.2 1801.9 1855.1 1869.0 1929.5 8864.8 9062.2 9140.4 9197.5 9303.6 1677.1 1689.4 1713.0 1716.5 1778.1 63845.7 68980.7 69549.0 69721.7 70261.3 9868.0 9921.2 10102.3 10249.4 10876.7 13767.9 13832.3 13840.2 13883.9 13909.0 6990.2 7163.2 7239.6 7287.2 7313.4 6638.7 6647.9 6807.2 6821.5 6825.5 4236.2 4326.3 4327.5 4332.3 4443.3 1653.1 1706.9 1812.7 1836.0 1841.0 886.5 933.8 969.0 974.5 999.1 16048.8 16110.2 16334.9 16522.3 16567.8 847.1 853.6 875.3 877.2 913.3 8741.6 9227.2 9284.1 9419.5 9443.9 357976.0 370401.0 371422.0 376797.0 379974.0 77276.0 78801.0 78825.2 78872.0 78996.6 891.0 897.9 906.9 916.1 950.5 14201.6 14425.5 14432.7 14600.4 14844.5 33335.8 33455.0 33510.0 33626.7 33851.5 47805.0 48691.3 48791.3 48918.5 49040.0 7714.9 7715.6 7787.8 7883.9 7894.1 11560.1 11696.4 11769.0 11793.6 12123.3 9911.9 9942.5 10100.9 10301.9 10479.2 10132.4 10166.2 10183.5 10262.7 10418.5 10065.7 10387.5 10454.0 10647.6 10658.4 7769.2 7798.8 7803.1 7907.6 7940.8 9551.6 10448.5 10526.1 10635.3 10638.9 06:27:22 INFO - PROCESS | 6353 | 06:27:22 INFO - PROCESS | 6353 | [#3] mootools.html Cycles:180 Average:5231.98 Median:5707.19 stddev:2867.53 (50.2%) stddev-sans-first:2859.99 06:27:22 INFO - PROCESS | 6353 | Values: 1255.5 1441.4 1505.8 1636.3 1834.0 7518.7 7821.9 7828.9 7833.8 7840.6 7587.3 7730.3 7753.5 7755.0 7756.1 1890.5 1964.9 1966.7 2222.8 2257.5 2221.5 2312.7 2316.0 2316.7 2317.5 2161.4 2169.2 2185.5 2197.1 2202.1 1875.7 2171.6 2273.6 2278.7 2283.6 2213.7 2237.4 2239.1 2241.4 2248.4 7347.3 7393.2 7397.2 7403.2 7405.7 4555.5 4775.9 4779.1 4782.9 4809.4 2866.4 3069.1 3074.7 3086.8 3097.6 908.8 926.3 927.3 947.6 953.3 10612.5 10878.6 10912.1 10931.1 10931.8 4121.2 4161.6 4301.2 4303.9 4460.6 9323.0 9377.4 9388.4 9411.5 9416.2 4868.7 4882.6 4891.1 4892.2 4902.4 3827.2 4251.1 4387.6 4419.1 4428.7 3742.0 3773.5 3791.7 3830.0 3904.4 1239.6 1299.5 1304.9 1307.4 1312.5 913.3 915.3 917.7 919.0 943.7 5651.2 5677.4 5783.4 5783.9 5808.2 864.4 896.2 939.9 942.1 946.8 3596.5 3757.2 3864.6 3968.8 4047.2 9194.3 9502.5 9627.8 9644.2 10186.9 9482.7 9514.3 9523.3 9551.0 9571.8 7105.4 7124.6 7247.3 7277.8 7289.9 5334.2 5477.8 5575.4 5736.9 5819.7 8901.3 8997.4 9013.5 9026.7 9037.5 8859.1 9053.4 9153.4 9164.8 9252.4 5955.4 6288.1 6298.5 7045.7 7197.5 6762.6 7319.9 7552.0 7558.4 7590.5 6797.8 6866.3 6907.3 6999.4 7041.8 6878.6 6953.3 6957.5 7051.5 7093.6 6457.2 6477.7 6566.6 6573.2 6582.3 4720.7 4791.4 4829.0 4892.9 4970.2 4815.5 4819.4 4827.0 4871.9 4903.3 06:27:22 INFO - PROCESS | 6353 | 06:27:22 INFO - PROCESS | 6353 | [#4] prototype.html Cycles:180 Average:4291.72 Median:4922.70 stddev:1216.23 (24.7%) stddev-sans-first:1182.33 06:27:22 INFO - PROCESS | 6353 | Values: 309.2 312.2 320.3 323.3 326.6 4899.3 4947.5 4981.8 4984.2 5005.3 4880.0 4904.7 4911.5 4922.1 4923.3 3695.9 3755.2 3865.3 3876.1 3885.7 3880.6 3904.7 3912.3 3923.8 3925.7 3651.6 3874.3 3886.2 3888.8 3898.0 3775.7 3894.9 3905.1 3915.2 3918.1 3464.4 3466.8 3474.8 3479.7 3485.9 4696.1 4702.7 4706.0 4716.0 4726.3 4249.8 4422.5 4446.4 4447.8 4471.5 5112.7 5125.5 5126.1 5135.0 5138.4 3786.0 3793.9 3796.9 3798.3 3804.5 5268.3 5310.9 5361.2 5391.6 5400.5 3861.7 3861.8 3880.5 3889.0 3889.1 3894.0 3930.6 3935.5 3938.2 3953.9 4268.7 4391.4 4405.5 4407.2 4430.4 5040.3 5117.7 5130.9 5144.5 5153.4 1350.6 1374.3 1374.7 1381.3 1382.6 874.7 935.3 949.4 961.1 963.9 4479.8 4488.3 4512.7 4526.9 4534.7 5237.2 5246.6 5246.8 5250.9 5259.7 4383.7 4481.4 4522.3 4523.7 4527.0 2780.2 2782.9 2799.6 2805.6 2809.9 4979.9 4983.5 4994.7 4996.9 5001.8 5206.9 5323.5 5358.9 5360.8 5363.2 4965.8 4982.0 4984.2 4984.3 4984.4 5234.0 5249.4 5249.9 5257.9 5260.6 4964.5 5121.0 5127.6 5133.7 5148.2 4958.3 4981.9 4983.9 4988.8 4999.7 3878.8 3880.7 3882.5 3885.1 3895.9 5024.5 5219.7 5224.8 5341.7 5371.8 5178.7 5192.2 5192.6 5192.7 5198.1 5059.1 5100.9 5142.7 5151.0 5198.6 4832.2 5048.7 5081.3 5102.0 5108.4 4938.6 5013.9 5230.1 5231.8 5241.8 5104.9 5112.2 5115.8 5117.7 5124.2 06:27:22 INFO - PROCESS | 6353 | 06:27:22 INFO - PROCESS | 6353 | [#5] yui.html Cycles:180 Average:12319.50 Median:47186.76 stddev:14180.58 (30.1%) stddev-sans-first:14193.36 06:27:22 INFO - PROCESS | 6353 | Values: 667.4 679.0 698.3 704.7 705.7 11741.6 11851.9 11923.6 11939.3 11941.8 11559.7 12846.2 13184.1 13211.3 13213.7 821.3 823.9 828.0 828.4 828.4 649.4 791.8 824.2 827.8 828.1 854.5 857.5 860.0 861.1 862.5 669.2 852.5 855.9 856.3 856.7 618.2 631.0 632.7 632.9 633.3 11889.7 11922.1 11962.6 11978.0 11990.0 11489.9 12004.8 12134.8 12513.2 12537.8 8663.2 8810.8 8897.6 8911.6 9120.1 2869.7 2870.5 2875.2 2907.3 2977.1 44336.3 44773.3 44852.8 47953.5 50255.2 9762.8 10139.6 10277.0 10293.4 10386.3 16424.9 16446.5 16455.0 16459.6 16633.4 5979.0 6015.6 6041.8 6114.5 6142.5 3288.5 3306.4 3337.2 3372.9 3517.0 2696.0 2789.1 2794.7 2795.7 2796.3 488.7 494.2 505.5 508.1 508.6 540.9 557.6 571.7 573.4 585.0 7424.4 7578.8 7916.4 7938.1 8112.0 531.9 535.7 546.9 559.9 572.5 3516.8 3629.9 3658.9 3678.0 3704.4 50171.7 51020.5 51167.5 51229.7 51254.5 45855.5 46319.3 46504.1 47157.0 47216.5 40147.8 40562.2 41727.6 42441.6 43864.6 6973.6 7015.6 7021.5 7050.8 7117.6 26006.6 26851.0 27604.3 27877.7 29546.9 34635.0 35261.8 35455.1 36181.5 36209.0 10410.3 10444.6 10508.2 10528.7 10589.4 11077.0 11145.3 11537.8 11541.9 12268.0 10460.8 10641.7 10839.7 11021.1 11202.3 9757.0 9796.2 9894.7 9909.9 9934.8 10203.4 10363.9 10408.2 10540.3 10781.7 8238.8 8765.7 8980.2 9003.5 9185.3 8445.3 8457.8 8492.5 8545.3 8686.0 06:27:22 INFO - PROCESS | 6353 | -------- Summary: end -------- 06:27:22 INFO - PROCESS | 6353 | 06:27:23 INFO - TEST-INFO | 6353: exit 0 06:27:23 INFO - TEST-OK | dromaeo_css | took 1117842ms 06:27:23 INFO - TEST-START | kraken 06:27:23 INFO - operating with platform_type : linux_ 06:27:23 INFO - Initialising browser for kraken test... 06:27:23 INFO - TEST-INFO | started process 6532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz9jLtn/profile http://localhost:57324/getInfo.html) 06:27:27 INFO - PROCESS | 6532 | __metrics Screen width/height:1600/1200 06:27:27 INFO - PROCESS | 6532 | colorDepth:24 06:27:27 INFO - PROCESS | 6532 | Browser inner width/height: 1024/697 06:27:27 INFO - PROCESS | 6532 | __metrics 06:27:28 ERROR - PROCESS | 6532 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:27:29 INFO - TEST-INFO | 6532: exit 0 06:27:29 INFO - Browser initialized. 06:27:29 INFO - Running cycle 1/1 for kraken test... 06:27:29 INFO - TEST-INFO | started process 6613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz9jLtn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:27:41 INFO - PROCESS | 6613 | RSS: Main: 155439104 06:27:41 INFO - PROCESS | 6613 | 06:27:44 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57324/tests/kraken/driver.html?testName=audio-beat-detection) 06:27:44 INFO - PROCESS | 6613 | RSS: Main: 210243584 06:27:44 INFO - PROCESS | 6613 | 06:27:47 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57324/tests/kraken/driver.html?testName=audio-dft) 06:27:48 INFO - PROCESS | 6613 | RSS: Main: 195198976 06:27:48 INFO - PROCESS | 6613 | 06:27:51 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57324/tests/kraken/driver.html?testName=audio-fft) 06:27:52 INFO - PROCESS | 6613 | RSS: Main: 265388032 06:27:52 INFO - PROCESS | 6613 | 06:27:54 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57324/tests/kraken/driver.html?testName=audio-oscillator) 06:27:54 INFO - PROCESS | 6613 | RSS: Main: 174395392 06:27:54 INFO - PROCESS | 6613 | 06:27:57 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57324/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:27:57 INFO - PROCESS | 6613 | RSS: Main: 178958336 06:27:57 INFO - PROCESS | 6613 | 06:28:00 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57324/tests/kraken/driver.html?testName=imaging-darkroom) 06:28:01 INFO - PROCESS | 6613 | RSS: Main: 214388736 06:28:01 INFO - PROCESS | 6613 | 06:28:04 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57324/tests/kraken/driver.html?testName=imaging-desaturate) 06:28:05 INFO - PROCESS | 6613 | RSS: Main: 215416832 06:28:05 INFO - PROCESS | 6613 | 06:28:08 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57324/tests/kraken/driver.html?testName=json-parse-financial) 06:28:08 INFO - PROCESS | 6613 | RSS: Main: 215523328 06:28:08 INFO - PROCESS | 6613 | 06:28:10 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57324/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:28:11 INFO - PROCESS | 6613 | RSS: Main: 200835072 06:28:11 INFO - PROCESS | 6613 | 06:28:13 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57324/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:28:13 INFO - PROCESS | 6613 | RSS: Main: 203190272 06:28:13 INFO - PROCESS | 6613 | 06:28:15 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57324/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:28:16 INFO - PROCESS | 6613 | RSS: Main: 218095616 06:28:16 INFO - PROCESS | 6613 | 06:28:19 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:28:19 INFO - PROCESS | 6613 | RSS: Main: 223109120 06:28:19 INFO - PROCESS | 6613 | 06:28:22 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:28:23 INFO - PROCESS | 6613 | RSS: Main: 218296320 06:28:23 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | Cycle 1(1): loaded http://localhost:57324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57324/tests/kraken/driver.html?testName=ai-astar) 06:28:25 INFO - PROCESS | 6613 | RSS: Main: 281829376 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | __start_tp_report 06:28:25 INFO - PROCESS | 6613 | _x_x_mozilla_page_load 06:28:25 INFO - PROCESS | 6613 | _x_x_mozilla_page_load_details 06:28:25 INFO - PROCESS | 6613 | |i|pagename|runs| 06:28:25 INFO - PROCESS | 6613 | |0;ai-astar;112;115;107;114;113;113;102;113;112;111 06:28:25 INFO - PROCESS | 6613 | |1;audio-beat-detection;163;140;156;182;137;155;167;133;194;136 06:28:25 INFO - PROCESS | 6613 | |2;audio-dft;159;160;161;161;162;162;170;161;162;162 06:28:25 INFO - PROCESS | 6613 | |3;audio-fft;77;74;82;113;77;74;74;103;100;74 06:28:25 INFO - PROCESS | 6613 | |4;audio-oscillator;94;95;142;94;93;94;153;94;93;139 06:28:25 INFO - PROCESS | 6613 | |5;imaging-gaussian-blur;117;118;116;117;117;116;117;116;116;117 06:28:25 INFO - PROCESS | 6613 | |6;imaging-darkroom;147;148;146;146;146;146;147;146;147;146 06:28:25 INFO - PROCESS | 6613 | |7;imaging-desaturate;95;94;96;94;95;94;96;95;95;94 06:28:25 INFO - PROCESS | 6613 | |8;json-parse-financial;65;65;64;66;65;65;65;82;62;64 06:28:25 INFO - PROCESS | 6613 | |9;json-stringify-tinderbox;66;65;66;65;65;65;65;65;67;66 06:28:25 INFO - PROCESS | 6613 | |10;stanford-crypto-aes;79;78;78;79;79;79;80;80;88;88 06:28:25 INFO - PROCESS | 6613 | |11;stanford-crypto-ccm;135;139;130;131;132;133;133;130;166;136 06:28:25 INFO - PROCESS | 6613 | |12;stanford-crypto-pbkdf2;173;170;173;172;171;173;168;168;170;181 06:28:25 INFO - PROCESS | 6613 | |13;stanford-crypto-sha256-iterative;81;72;71;72;74;72;73;71;72;70 06:28:25 INFO - PROCESS | 6613 | __end_tp_report 06:28:25 INFO - PROCESS | 6613 | __start_cc_report 06:28:25 INFO - PROCESS | 6613 | _x_x_mozilla_cycle_collect,1890 06:28:25 INFO - PROCESS | 6613 | __end_cc_report 06:28:25 INFO - PROCESS | 6613 | __startTimestamp1461331705549__endTimestamp 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | ------- Summary: start ------- 06:28:25 INFO - PROCESS | 6613 | Number of tests: 14 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:3.88 (3.4%) stddev-sans-first:4.11 06:28:25 INFO - PROCESS | 6613 | Values: 112.0 115.0 107.0 114.0 113.0 113.0 102.0 113.0 112.0 111.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#1] audio-beat-detection Cycles:10 Average:156.30 Median:159.50 stddev:20.65 (12.9%) stddev-sans-first:21.75 06:28:25 INFO - PROCESS | 6613 | Values: 163.0 140.0 156.0 182.0 137.0 155.0 167.0 133.0 194.0 136.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:2.98 (1.8%) stddev-sans-first:2.96 06:28:25 INFO - PROCESS | 6613 | Values: 159.0 160.0 161.0 161.0 162.0 162.0 170.0 161.0 162.0 162.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#3] audio-fft Cycles:10 Average:84.80 Median:74.00 stddev:14.73 (19.9%) stddev-sans-first:15.35 06:28:25 INFO - PROCESS | 6613 | Values: 77.0 74.0 82.0 113.0 77.0 74.0 74.0 103.0 100.0 74.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:94.00 stddev:24.79 (26.4%) stddev-sans-first:25.69 06:28:25 INFO - PROCESS | 6613 | Values: 94.0 95.0 142.0 94.0 93.0 94.0 153.0 94.0 93.0 139.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 06:28:25 INFO - PROCESS | 6613 | Values: 117.0 118.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:28:25 INFO - PROCESS | 6613 | Values: 147.0 148.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 06:28:25 INFO - PROCESS | 6613 | Values: 95.0 94.0 96.0 94.0 95.0 94.0 96.0 95.0 95.0 94.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.00 stddev:5.62 (8.6%) stddev-sans-first:5.94 06:28:25 INFO - PROCESS | 6613 | Values: 65.0 65.0 64.0 66.0 65.0 65.0 65.0 82.0 62.0 64.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 06:28:25 INFO - PROCESS | 6613 | Values: 66.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 67.0 66.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:79.50 stddev:3.85 (4.8%) stddev-sans-first:4.03 06:28:25 INFO - PROCESS | 6613 | Values: 79.0 78.0 78.0 79.0 79.0 79.0 80.0 80.0 88.0 88.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:134.00 stddev:10.74 (8.0%) stddev-sans-first:11.38 06:28:25 INFO - PROCESS | 6613 | Values: 135.0 139.0 130.0 131.0 132.0 133.0 133.0 130.0 166.0 136.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:172.50 stddev:3.73 (2.2%) stddev-sans-first:3.93 06:28:25 INFO - PROCESS | 6613 | Values: 173.0 170.0 173.0 172.0 171.0 173.0 168.0 168.0 170.0 181.0 06:28:25 INFO - PROCESS | 6613 | 06:28:25 INFO - PROCESS | 6613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.00 stddev:3.08 (4.3%) stddev-sans-first:1.17 06:28:25 INFO - PROCESS | 6613 | Values: 81.0 72.0 71.0 72.0 74.0 72.0 73.0 71.0 72.0 70.0 06:28:25 INFO - PROCESS | 6613 | -------- Summary: end -------- 06:28:25 INFO - PROCESS | 6613 | 06:28:26 INFO - TEST-INFO | 6613: exit 0 06:28:26 INFO - TEST-OK | kraken | took 63058ms 06:28:26 INFO - SUITE-END | took 1180s 06:28:26 INFO - Completed test suite (00:19:41) 06:28:26 INFO - javascript benchmark 06:28:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.379268975446, 2649.6158057081734, 2651.615515750215, 2676.53160696878, 2695.083671551672, 4425.468943726749, 4497.437820272466, 4568.223402021656, 4575.839845605405, 4587.977060114703, 4485.775711214443, 4604.7237165770075, 4623.907521849561, 4637.327587499811, 4659.510751371108, 4257.552956939523, 4290.978545107278, 4336.04606986464, 4367.45406824147, 4450.0, 4369.606735393814, 4395.626371758389, 4413.139437809628, 4418.469783625953, 4447.466304043519, 4099.999999999985, 4208.558101399371, 4227.365895115727, 4237.089025859455, 4309.676774241944, 4301.44081269433, 4326.913461730748, 4332.805023773906, 4335.913281734379, 4384.21084204843, 4316.56834316569, 4321.157374312011, 4327.870163895088, 4330.761808100553, 4373.759443230621, 4409.581089796464, 4462.665300102505, 4485.9551404485865, 4541.023679908835, 4560.315952607136, 4892.584130348924, 4903.754812259408, 4905.141600219983, 4940.53064958832, 4947.851564453073, 4905.828296009622, 4926.729029903354, 4928.901421971576, 4931.0630980113665, 4933.851984440436, 4465.129299786543, 4546.954530454686, 4605.148047611203, 4632.420947381577, 4645.6980296280635, 4990.126727822617, 5032.72320022395, 5034.370703662043, 5041.798328066836, 5078.771455284521, 4700.929486057712, 4830.541098595628, 4833.32333473314, 4833.927491087637, 4874.53691899269, 4908.950910490849, 4945.629077819178, 4946.851594452172, 4984.925226121611, 4989.725565093882, 4851.151048566487, 4874.975625121851, 4879.097366987119, 4888.6577939543895, 4929.75351232437, 4716.693414928019, 4856.368672072608, 4863.8540843774745, 4898.044881248123, 4917.754112294371, 4146.813393397304, 4148.087420767426, 4172.603602657743, 4184.351425529047, 4194.098268872207, 3643.908902277464, 3648.0150359402815, 3651.4522821576975, 3678.6321367863, 3686.981565092211, 4162.875113746592, 4208.053188032729, 4225.176090662353, 4238.152369526107, 4252.064545799919, 4889.242167464049, 4929.088118698052, 4929.630277729185, 4974.452810190876, 4976.651634385558, 4218.767967761742, 4249.532551419341, 4252.510961239497, 4280.464941882265, 4287.549807270254, 4286.978565107217, 4401.383806267125, 4450.799714012877, 4451.755153466591, 4455.331700244989, 4724.503927087606, 4728.881777955578, 4740.1230772307235, 4744.478107408113, 4784.282357646381, 4987.2768448574025, 4989.675671081368, 4991.700497970133, 4998.175301075427, 5009.4489606144025, 4576.405067341224, 4638.466576343763, 4693.178693728652, 4739.526047395233, 4755.667103302736, 4794.30482580017, 4817.1810792164715, 4817.831375901967, 4867.780949857336, 4872.0, 4863.003084367625, 4882.951170488392, 4885.706857588556, 4888.902221955612, 4943.283223932582, 4608.769561521977, 4768.070226305837, 4791.616670666408, 4820.035992801384, 4864.805407783649, 4749.620030397629, 4774.809007639795, 4800.66395352322, 4803.351547541037, 4845.297431872429, 4693.131770622445, 4709.740964246862, 4717.693349932243, 4742.1227072991605, 4760.119377915097, 4666.206744853315, 4791.257355109963, 4827.517248275144, 4896.461389247252, 4927.310176575354, 4721.362616046789, 4723.291506274087, 4727.787249573708, 4729.054189162112, 4795.424549054136], "value": 4533.670030635036, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.201631788926, 599.7151353107272, 603.3544107804651, 603.5624172474957, 622.8007037747919, 32926.0, 34342.48486272702, 34399.48400773987, 34414.13964650882, 34474.827625861835, 37143.44284835723, 37801.0, 37803.24393512135, 37830.4603447586, 37881.810590947076, 7642.350400215974, 7817.257360550767, 7835.451518393715, 7840.4511684182135, 7842.72550460734, 7668.501547399401, 7773.067231932176, 7780.727674531393, 7796.688132474723, 7808.102068262166, 7926.564038977854, 8011.1187769345615, 8014.67941282348, 8018.278354948054, 8018.398620103487, 7896.170902055288, 7949.205079492062, 7962.243586859239, 7966.840663186733, 7972.561509116997, 7837.7648670539975, 7933.048034235871, 7934.642941067666, 7938.880916786253, 7944.801379965547, 36438.453423198676, 36922.81538592317, 36923.0, 36935.445968310494, 36941.07647308812, 3075.4464196444633, 3223.7904536205074, 3280.721138703213, 3284.129705627987, 3524.4889491023914, 27463.862680686667, 28068.719312806814, 28161.718382816114, 28312.292192695142, 29357.70642293571, 3339.332133573295, 3353.161709572607, 3403.5915690117345, 3413.607435144965, 3420.7776494527775, 170549.0, 277293.3623982567, 284279.0, 286059.5697021522, 286682.0, 46941.765291173324, 47167.764161179664, 47447.0, 47455.52544474511, 47462.0, 50677.49322506728, 56379.71810140923, 57929.71035144882, 58115.12827307594, 58143.12785308224, 13076.542321018718, 13160.210387376597, 13164.60506184816, 13186.868131318564, 13200.20798752078, 9274.258059355236, 9725.756856078513, 10289.588416463257, 10356.119729823049, 10431.269811113149, 17254.482365529053, 17277.0, 17325.913370433067, 17458.0, 17498.300067997392, 6671.532992690562, 6723.596584204865, 6798.637675658868, 6873.278305777922, 6929.995150703221, 869.6217145541709, 879.5997820991433, 881.5371929736812, 893.8122994171297, 1064.446487826326, 26601.33496662599, 28025.579616305364, 28188.93230858391, 28541.857290713415, 28572.571411428846, 970.4274478057838, 1008.505832142245, 1021.402479549457, 1050.8844027157006, 1077.49357801833, 14284.928575357057, 15040.0, 15040.924795375953, 15099.698006040038, 15103.093814370954, 154147.0, 156684.0, 157143.0, 157429.0, 157800.21099894427, 48384.0, 49088.0, 49182.262266066034, 49189.50810491921, 49230.50769492259, 1111.6720567432626, 1259.8551166615773, 1269.435101379877, 1308.9659169256372, 1351.6418149190472, 25722.614160787976, 27504.21736656658, 27696.307592310353, 27797.583036254877, 28160.43679126365, 37835.81082094572, 38104.428433574074, 38434.42348364833, 38474.42288365621, 38586.42120368253, 207645.0, 208767.0, 209895.0, 210569.0, 211180.88819112227, 22139.1144354224, 23054.654180187645, 24952.500949981262, 25670.8716456424, 25718.0, 35589.82205088958, 35634.82182589071, 36286.09711223043, 36422.453663194545, 36617.63382366249, 30808.0, 30884.227894301923, 31207.84396078005, 31217.53173702351, 31286.0, 30786.84606576953, 31027.68972310248, 31273.218169545944, 31420.528692070093, 32544.674553254164, 33422.33155336831, 33995.0, 34249.0, 34417.655823442445, 34474.82762586171, 30441.391172176875, 30695.0, 31108.844455777577, 31130.0, 31168.688313117487, 23745.406364840324, 23883.0, 24217.51564968726, 24321.148759793323, 24612.138575149784], "value": 16398.570261360284, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.0235091114015, 383.27560909880316, 389.7817222355481, 390.5489160020176, 391.79039214020503, 15644.608884777872, 16592.33630654774, 16817.075060871648, 16829.326826926907, 16834.747478787827, 14762.0, 14813.851861481382, 15452.0, 15454.227288635551, 15470.303836327364, 4527.796249168787, 4642.721436713808, 4673.859784206462, 4680.5787479126875, 4680.906381872361, 3448.982755086221, 5064.468230835764, 5297.337832770903, 5328.893422131555, 5331.253624492574, 5285.867853303679, 5306.973465132669, 5307.336582927134, 5308.256844041837, 5336.706481143536, 5607.243022191993, 5860.443257890493, 5863.530917526609, 5864.0, 5867.501262392701, 4683.765811709435, 5086.109930762102, 5277.498637629457, 5281.313429254173, 5283.128283833163, 12262.386880655931, 12265.632031039084, 12380.566680166152, 12386.566470173591, 12393.62819115428, 1781.1628534588851, 1801.9189136488758, 1855.109547417234, 1869.0094250047496, 1929.5465565592074, 8864.822703545957, 9062.184403403659, 9140.405873618194, 9197.540122993823, 9303.627854885865, 1677.069226579248, 1689.4087069525567, 1713.0321368426798, 1716.450735764556, 1778.1109445277361, 63845.68077159631, 68980.6550967247, 69549.0, 69721.65139174322, 70261.2973870265, 9867.950660246797, 9921.206303495703, 10102.272386455616, 10249.436281004468, 10876.728081798019, 13767.931160344135, 13832.30838458073, 13840.169589824442, 13883.861161388257, 13909.026368154133, 6990.161180658353, 7163.176234733072, 7239.638018099074, 7287.161976372679, 7313.414926805843, 6638.6680665966505, 6647.86704265912, 6807.217170025411, 6821.522493425512, 6825.48808839339, 4236.173946080485, 4326.329418940069, 4327.502337231196, 4332.328489084134, 4443.33349997503, 1653.115583163002, 1706.9146542672818, 1812.664657038452, 1835.972460413095, 1840.981590184081, 886.5035580075179, 933.8132373525186, 969.016448304971, 974.4737841565617, 999.1257649556638, 16048.839511604734, 16110.194490275439, 16334.918325408296, 16522.339106435847, 16567.834321656872, 847.1063028504987, 853.5646820121783, 875.2866413872673, 877.2061284537504, 913.3378300731916, 8741.606627701769, 9227.215686666574, 9284.118008789153, 9419.529023548796, 9443.858342124873, 357976.0, 370401.0, 371422.0, 376797.0, 379974.0, 77276.0, 78801.0, 78825.21174788178, 78872.0, 78996.60501697454, 890.955452227386, 897.9191872731485, 906.9138431848963, 916.1022198245623, 950.5104870991584, 14201.573952781433, 14425.49510767118, 14432.711345773236, 14600.415983360972, 14844.480443184437, 33335.83332083324, 33455.0, 33510.0, 33626.66373336333, 33851.492227616116, 47805.0, 48691.269630956274, 48791.26813097877, 48918.51081489282, 49040.0, 7714.884276735966, 7715.614219289126, 7787.845922401437, 7883.921160788548, 7894.052713674396, 11560.075193984292, 11696.35670038122, 11769.0, 11793.646190614296, 12123.333216672814, 9911.900880991387, 9942.453165075991, 10100.949495252476, 10301.896981030093, 10479.214058945458, 10132.392056476636, 10166.237532185263, 10183.541740621542, 10262.743431414274, 10418.531166097695, 10065.69802905914, 10387.480625968521, 10454.0068693474, 10647.574097036031, 10658.360498370123, 7769.223077692185, 7798.844023119393, 7803.063632364153, 7907.56508392044, 7940.801479963047, 9551.617935282511, 10448.477576121315, 10526.105281051196, 10635.308704934465, 10638.89361106379], "value": 7973.391455324272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.522901297508, 1441.3946142620098, 1505.8117735283092, 1636.3209268153716, 1833.9633207335862, 7518.661660225289, 7821.882671759914, 7828.882566761489, 7833.76498705039, 7840.568768717718, 7587.317141457268, 7730.265624765652, 7753.457257991929, 7754.961225193866, 7756.146823849372, 1890.5368184794677, 1964.901754912256, 1966.6558352288364, 2222.83328750344, 2257.480779420726, 2221.522372689871, 2312.745597984229, 2315.9536809263805, 2316.745158032615, 2317.5017371265176, 2161.4164175672636, 2169.208238992764, 2185.519185779126, 2197.13213280754, 2202.0861342542826, 1875.7373967644542, 2171.565686862618, 2273.624851899435, 2278.6695929090274, 2283.5547068321684, 2213.701150344715, 2237.3959031061686, 2239.093167267243, 2241.4396400899777, 2248.415411992877, 7347.3020063094455, 7393.223711510322, 7397.18630950595, 7403.185649578542, 7405.74079907206, 4555.453345598549, 4775.9283610745515, 4779.115863565252, 4782.904341913177, 4809.446913604946, 2866.3693987322754, 3069.0946170879643, 3074.661787203428, 3086.7807216149718, 3097.550855126017, 908.8227795579865, 926.2960150285764, 927.2859897878664, 947.6209516193509, 953.2659851913987, 10612.46937653122, 10878.61924832635, 10912.072473839733, 10931.125509959184, 10931.83602245959, 4121.196366708523, 4161.583841615814, 4301.247281725686, 4303.870883873489, 4460.553944605514, 9322.953385233166, 9377.437353758796, 9388.436693798394, 9411.4823684698, 9416.152546270869, 4868.659193856396, 4882.633802464758, 4891.119598472238, 4892.241702536113, 4902.411710594752, 3827.2154208387215, 4251.06476575153, 4387.561243875587, 4419.1382680377665, 4428.7121337112985, 3741.981290093532, 3773.509443772347, 3791.658750712449, 3830.042489377656, 3904.39481880309, 1239.6343078791779, 1299.4672184404349, 1304.9021323400593, 1307.4378017452586, 1312.527490103562, 913.2785099771239, 915.2997956563235, 917.6831247160346, 918.9540522973824, 943.6697155995347, 5651.208830763697, 5677.432256774372, 5783.363829978699, 5783.88432231353, 5808.244928159313, 864.4251572704081, 896.1934259166802, 939.8543225800012, 942.1097063275276, 946.7928391301009, 3596.514470546495, 3757.2485502898985, 3864.613538646113, 3968.7817170055923, 4047.1905618875753, 9194.26445884341, 9502.524873756285, 9627.807443851083, 9644.228461723045, 10186.949065254626, 9482.668106616235, 9514.28642851789, 9523.28575356851, 9551.0, 9571.808563828685, 7105.43156547475, 7124.643767811589, 7247.275272472711, 7277.781666550012, 7289.927100728924, 5334.19246115341, 5477.835664930059, 5575.414581469049, 5736.942630573641, 5819.6508209507565, 8901.33240006989, 8997.415168014059, 9013.504257265913, 9026.729198124067, 9037.502937338246, 8859.11408859109, 9053.411528250643, 9153.405028673114, 9164.770880727769, 9252.444853308823, 5955.434233747787, 6288.088227207121, 6298.496120310456, 7045.718171273092, 7197.49617526789, 6762.628055456997, 7319.926800731924, 7552.0, 7558.433117516318, 7590.468667193243, 6797.830054248683, 6866.313368663094, 6907.34380233877, 6999.440044796506, 7041.753538626123, 6878.58728476273, 6953.304669533006, 6957.478189135733, 7051.541649792747, 7093.574385536885, 6457.225132984072, 6477.676116194078, 6566.573172743756, 6573.1783527059115, 6582.275949645439, 4720.740359280273, 4791.377120974251, 4829.034193161452, 4892.8532144035735, 4970.179920313108, 4815.518448155157, 4819.397575303087, 4826.975865120792, 4871.878203044952, 4903.26451032348], "value": 4249.001441708181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.1745040741221, 312.17585574084416, 320.25221108711156, 323.3097337185109, 326.5917602996255, 4899.289603007562, 4947.480514545975, 4981.825636102737, 4984.202527595586, 5005.299258103868, 4880.0, 4904.656674032819, 4911.484294149108, 4922.114019476493, 4923.286123512089, 3695.90760230995, 3755.2301778135416, 3865.323568375537, 3876.069743261611, 3885.734829306292, 3880.641775378623, 3904.726669133162, 3912.3349030664713, 3923.823427945735, 3925.725199236055, 3651.6165802590745, 3874.2638898609316, 3886.2227554489073, 3888.786116763577, 3897.9805100974454, 3775.7168212384045, 3894.922101557953, 3905.1213476967455, 3915.158240978203, 3918.098837267416, 3464.428369319059, 3466.843992020365, 3474.774139680938, 3479.6868281854754, 3485.9128521786906, 4696.131215725101, 4702.741349225791, 4705.976470117662, 4715.95284047162, 4726.314684370781, 4249.766262855542, 4422.506220086128, 4446.399736035626, 4447.755373454459, 4471.53048929861, 5112.744362781846, 5125.538701516882, 5126.0521002018995, 5135.0, 5138.434772175057, 3785.9810700946596, 3793.905152371185, 3796.867109651149, 3798.2593394288124, 3804.4782087165077, 5268.341457317835, 5310.946890531084, 5361.169018802131, 5391.622586418913, 5400.540954018913, 3861.7489863159367, 3861.806909654506, 3880.4567360569545, 3888.9805550972064, 3889.1055057336407, 3893.9610603894166, 3930.567637559866, 3935.5080614923136, 3938.1729836734035, 3953.920921581552, 4268.701190916606, 4391.363252328459, 4405.471343438744, 4407.162639098561, 4430.379746835446, 5040.344755181803, 5117.71852548106, 5130.871728206825, 5144.511271429208, 5153.392625162402, 1350.6083235861686, 1374.271636032904, 1374.731927274192, 1381.2679279981626, 1382.5506710318984, 874.6807415293372, 935.2891802230354, 949.4161090929028, 961.110972350573, 963.8987906269881, 4479.820807167742, 4488.281874900001, 4512.706674066175, 4526.932096018562, 4534.7052441591195, 5237.240600112962, 5246.639012444339, 5246.842594722164, 5250.894982100336, 5259.710715910585, 4383.736975781463, 4481.3726078349055, 4522.321651752263, 4523.7285762854335, 4526.977365113154, 2780.2354352552807, 2782.9025984090863, 2799.622051023086, 2805.621241132462, 2809.90165344212, 4979.925301120486, 4983.526564976321, 4994.725290109006, 4996.90006199874, 5001.849944501598, 5206.921896171561, 5323.467653234723, 5358.892822143535, 5360.758765855546, 5363.249145119687, 4965.776540055778, 4981.950180498221, 4984.22744474607, 4984.27727979441, 4984.401871775338, 5233.958756085054, 5249.422563517934, 5249.89500209986, 5257.8695580450385, 5260.579153667621, 4964.528369804862, 5121.0, 5127.589792816491, 5133.717645529532, 5148.227765835155, 4958.256261560795, 4981.850544483671, 4983.900321993612, 4988.750562471934, 4999.65002449825, 3878.786666733357, 3880.7089468290555, 3882.52464063654, 3885.1258466844733, 3895.8831235062994, 5024.547790698854, 5219.686818790885, 5224.817131400383, 5341.732913354239, 5371.785128594969, 5178.741062946913, 5192.169252919514, 5192.5586325162785, 5192.662476938987, 5198.142306519533, 5059.139946209079, 5100.897982040264, 5142.6914385137015, 5150.99555586657, 5198.610104242272, 4832.202686556679, 5048.693106015566, 5081.288619593186, 5101.974490127525, 5108.361454818148, 4938.604911606991, 5013.949860501349, 5230.137027390438, 5231.843044708665, 5241.790328386975, 5104.923426148685, 5112.182050871991, 5115.7953681852305, 5117.667351622133, 5124.180131178993], "value": 3912.920211726869, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.3560014585923, 678.9524733268673, 698.3400686351397, 704.707546368257, 705.7459314646726, 11741.647750567487, 11851.940740296286, 11923.64229073128, 11939.34333611651, 11941.820872686916, 11559.711007224823, 12846.16499927504, 13184.077114601982, 13211.339433028359, 13213.735725285489, 821.2772759971217, 823.8928939237906, 827.9710210142646, 828.3828547731948, 828.3952714518375, 649.438235925923, 791.762471258623, 824.1799409587469, 827.7723626002837, 828.0725587342185, 854.5214679779313, 857.4555157474986, 860.0453496618749, 861.1259571534897, 862.525610913998, 669.2003056347667, 852.4544291653347, 855.8630619100945, 856.2678909532385, 856.6659002988871, 618.1716499890168, 631.0376675569793, 632.715278124841, 632.8544434780026, 633.2559242889587, 11889.702757431047, 11922.10584206188, 11962.641120766391, 11978.0, 11990.04079673624, 11489.942550287195, 12004.759904801942, 12134.817977730341, 12513.186642868184, 12537.811932821014, 8663.220310172052, 8810.779730506725, 8897.555122243926, 8911.55442227886, 9120.087991200893, 2869.6986816384397, 2870.454613623405, 2875.2093174377005, 2907.3022474606155, 2977.0919869439813, 44336.334954975704, 44773.328400074024, 44852.77573612144, 47953.520464795605, 50255.24617130782, 9762.804743905082, 10139.594416223268, 10276.972302769664, 10293.382397056052, 10386.272960892817, 16424.917875410785, 16446.506604801874, 16455.0, 16459.5885102871, 16633.417830375878, 5978.970105149533, 6015.578909476382, 6041.848953776191, 6114.5414093942245, 6142.477889379453, 3288.490284005983, 3306.3883181611477, 3337.241187457762, 3372.9494057589154, 3517.0, 2695.986520067387, 2789.065663002876, 2794.720527947189, 2795.748382645572, 2796.314902848815, 488.7116601205306, 494.1870622825432, 505.4591587001873, 508.0905179728319, 508.5982074161445, 540.8783023819609, 557.6096732287334, 571.6512927114456, 573.377884994777, 584.9766009359578, 7424.368928641018, 7578.772636820904, 7916.366690664733, 7938.126806051329, 8112.0, 531.8909623527168, 535.7267793425303, 546.8906218756265, 559.8684309187338, 572.4504475703371, 3516.7538272320694, 3629.891103266906, 3658.8719394821055, 3678.0437086357206, 3704.388775852008, 50171.74914125479, 51020.489795101574, 51167.48832511702, 51229.7438512805, 51254.487455125716, 45855.5414445858, 46319.30521042187, 46504.069918602116, 47157.0, 47216.5278347219, 40147.79926100351, 40562.188756224714, 41727.58272417237, 42441.57558424438, 43864.561354386045, 6973.6164510952385, 7015.614141222078, 7021.473389495706, 7050.788476345718, 7117.608531530608, 26006.609900851123, 26851.0, 27604.309892252855, 27877.721222787513, 29546.852265738533, 34635.0, 35261.82369088138, 35455.11362215965, 36181.457278140326, 36209.0, 10410.323328983592, 10444.582216711551, 10508.21188410857, 10528.684139475828, 10589.36463812143, 11077.0, 11145.331280123219, 11537.769244614892, 11541.942290288494, 12268.0, 10460.843087353544, 10641.733956651145, 10839.67480975572, 11021.118310534977, 11202.271852329572, 9757.0, 9796.21630269591, 9894.653687120915, 9909.851352229578, 9934.801303974025, 10203.438810865473, 10363.896361036293, 10408.219383546113, 10540.314879532805, 10781.730456738644, 8238.794030149294, 8765.737027889174, 8980.236679882284, 9003.549822508718, 9185.265178785547, 8445.282151017233, 8457.788555286166, 8492.490450572985, 8545.273651739672, 8686.0], "value": 5690.947308054957, "unit": "score"}], "name": "dromaeo_css", "value": 6187.085005902338, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 107.0, 114.0, 113.0, 113.0, 102.0, 113.0, 112.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 140.0, 156.0, 182.0, 137.0, 155.0, 167.0, 133.0, 194.0, 136.0], "value": 156.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 161.0, 162.0, 162.0, 170.0, 161.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 82.0, 113.0, 77.0, 74.0, 74.0, 103.0, 100.0, 74.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 142.0, 94.0, 93.0, 94.0, 153.0, 94.0, 93.0, 139.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 95.0, 94.0, 96.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 82.0, 62.0, 64.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 79.0, 79.0, 80.0, 80.0, 88.0, 88.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 130.0, 131.0, 132.0, 133.0, 133.0, 130.0, 166.0, 136.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 173.0, 172.0, 171.0, 173.0, 168.0, 168.0, 170.0, 181.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 72.0, 71.0, 72.0, 74.0, 72.0, 73.0, 71.0, 72.0, 70.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1575.2, "alertThreshold": 2.0}]} 06:28:26 INFO - Return code: 0 06:28:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:28:26 ERROR - # TBPL SUCCESS # 06:28:26 INFO - Running post-action listener: _resource_record_post_action 06:28:26 INFO - Running post-run listener: _resource_record_post_run 06:28:27 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 354619392; Read time: 88; Write time: 179784 06:28:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 70627328; Read time: 0; Write time: 31996 06:28:27 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283435008; Read time: 88; Write time: 146432 06:28:27 INFO - Running post-run listener: _upload_blobber_files 06:28:27 INFO - Blob upload gear active. 06:28:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:28:27 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 06:28:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:28:28 INFO - (blobuploader) - INFO - Open directory for files ... 06:28:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:28:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:28:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:28:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:28:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:28:29 INFO - (blobuploader) - INFO - Done attempting. 06:28:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:28:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:28:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:28:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:28:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:28:30 INFO - (blobuploader) - INFO - Done attempting. 06:28:30 INFO - (blobuploader) - INFO - Iteration through files over. 06:28:30 INFO - Return code: 0 06:28:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:28:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:28:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc636b846aa3a2176d2497c94b0671bd6d0e821e1e1690b21ead1f50fd5993375b88ef7c4b2fb9994c7fcc20ad40950360088a6a6821902b96c9a57eaf44963d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29f6607e13b4aad7f4171537ef19a5cc7565d8b9ae448a7ae8417a67a5b5f130fe9b2e5f6177681fac1839fe4f982ab2c01f341f81ec96253721cde5bbf3cc13"} 06:28:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:28:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:28:30 INFO - Contents: 06:28:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc636b846aa3a2176d2497c94b0671bd6d0e821e1e1690b21ead1f50fd5993375b88ef7c4b2fb9994c7fcc20ad40950360088a6a6821902b96c9a57eaf44963d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29f6607e13b4aad7f4171537ef19a5cc7565d8b9ae448a7ae8417a67a5b5f130fe9b2e5f6177681fac1839fe4f982ab2c01f341f81ec96253721cde5bbf3cc13"} 06:28:30 INFO - Running post-run listener: copy_logs_to_upload_dir 06:28:30 INFO - Copying logs to upload dir... 06:28:30 INFO - mkdir: /builds/slave/test/build/upload/logs 06:28:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.703698 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-22 06:28:29.664702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:29.668606) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc636b846aa3a2176d2497c94b0671bd6d0e821e1e1690b21ead1f50fd5993375b88ef7c4b2fb9994c7fcc20ad40950360088a6a6821902b96c9a57eaf44963d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29f6607e13b4aad7f4171537ef19a5cc7565d8b9ae448a7ae8417a67a5b5f130fe9b2e5f6177681fac1839fe4f982ab2c01f341f81ec96253721cde5bbf3cc13"} build_url:https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc636b846aa3a2176d2497c94b0671bd6d0e821e1e1690b21ead1f50fd5993375b88ef7c4b2fb9994c7fcc20ad40950360088a6a6821902b96c9a57eaf44963d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29f6607e13b4aad7f4171537ef19a5cc7565d8b9ae448a7ae8417a67a5b5f130fe9b2e5f6177681fac1839fe4f982ab2c01f341f81ec96253721cde5bbf3cc13"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:29.693607) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:29.693951) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461330467.788561-175942572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:29.778194) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:28:29.778533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:28:29.778834) ========= ========= Total master_lag: 0.18 =========