builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1461331676.5 results: success (0) buildid: 20160419211331 builduid: 3b917d3ba8a04cb5a3589a514138e6b8 revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:56.502182) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:56.502615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:56.502888) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:56.516190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:56.516503) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 06:27:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.1M=0s 2016-04-22 06:27:56 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:56.692186) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:56.692516) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.059905 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:56.763486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 06:27:56.763855) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf3a35b355f0b48ac1020c47198053af9944a493 --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 bf3a35b355f0b48ac1020c47198053af9944a493 --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=4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 06:27:56,819 truncating revision to first 12 chars 2016-04-22 06:27:56,819 Setting DEBUG logging. 2016-04-22 06:27:56,819 attempt 1/10 2016-04-22 06:27:56,819 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf3a35b355f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 06:27:58,033 unpacking tar archive at: fx-team-bf3a35b355f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.522194 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 06:27:58.299375) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:58.299724) ========= script_repo_revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:58.300170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:58.300456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:58.309775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-22 06:27:58.310149) ========= /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=4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:27:58 INFO - MultiFileLogger online at 20160422 06:27:58 in /builds/slave/test 06:27:58 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:27:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:27:58 INFO - {'append_to_log': False, 06:27:58 INFO - 'base_work_dir': '/builds/slave/test', 06:27:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:27:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:27:58 INFO - 'branch': 'Fx-Team-Non-PGO', 06:27:58 INFO - 'buildbot_json_path': 'buildprops.json', 06:27:58 INFO - 'config_files': ('talos/linux_config.py',), 06:27:58 INFO - 'default_actions': ('clobber', 06:27:58 INFO - 'read-buildbot-config', 06:27:58 INFO - 'download-and-extract', 06:27:58 INFO - 'populate-webroot', 06:27:58 INFO - 'create-virtualenv', 06:27:58 INFO - 'install', 06:27:58 INFO - 'run-tests'), 06:27:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:27:58 INFO - 'download_minidump_stackwalk': True, 06:27:58 INFO - 'download_symbols': 'ondemand', 06:27:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:27:58 INFO - 'tooltool.py': '/tools/tooltool.py', 06:27:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:27:58 INFO - '/tools/misc-python/virtualenv.py')}, 06:27:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:27:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:27:58 INFO - 'installer_path': 'installer.exe', 06:27:58 INFO - 'log_level': 'info', 06:27:58 INFO - 'log_name': 'talos', 06:27:58 INFO - 'log_to_console': True, 06:27:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:27:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:27:58 INFO - 'opt_config_files': (), 06:27:58 INFO - 'pip_index': False, 06:27:58 INFO - 'sps_profile': False, 06:27:58 INFO - 'sps_profile_interval': 0, 06:27:58 INFO - 'suite': 'dromaeojs', 06:27:58 INFO - 'system_bits': '32', 06:27:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:27:58 INFO - 'title': 'talos-linux64-ix-030', 06:27:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:27:58 INFO - 'use_talos_json': True, 06:27:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:27:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:27:58 INFO - 'work_dir': 'build'} 06:27:58 INFO - ##### 06:27:58 INFO - ##### Running clobber step. 06:27:58 INFO - ##### 06:27:58 INFO - Running pre-action listener: _resource_record_pre_action 06:27:58 INFO - Running main action method: clobber 06:27:58 INFO - rmtree: /builds/slave/test/build 06:27:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:28:01 INFO - Running post-action listener: _resource_record_post_action 06:28:01 INFO - ##### 06:28:01 INFO - ##### Running read-buildbot-config step. 06:28:01 INFO - ##### 06:28:01 INFO - Running pre-action listener: _resource_record_pre_action 06:28:01 INFO - Running main action method: read_buildbot_config 06:28:01 INFO - Using buildbot properties: 06:28:01 INFO - { 06:28:01 INFO - "project": "", 06:28:01 INFO - "product": "firefox", 06:28:01 INFO - "script_repo_revision": "production", 06:28:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:28:01 INFO - "repository": "", 06:28:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:28:01 INFO - "buildid": "20160419211331", 06:28:01 INFO - "pgo_build": "False", 06:28:01 INFO - "basedir": "/builds/slave/test", 06:28:01 INFO - "buildnumber": 1588, 06:28:01 INFO - "slavename": "talos-linux64-ix-030", 06:28:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:28:01 INFO - "platform": "ubuntu64_hw", 06:28:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:28:01 INFO - "branch": "fx-team", 06:28:01 INFO - "repo_path": "integration/fx-team", 06:28:01 INFO - "revision": "bf3a35b355f0b48ac1020c47198053af9944a493", 06:28:01 INFO - "stage_platform": "linux64", 06:28:01 INFO - "builduid": "3b917d3ba8a04cb5a3589a514138e6b8", 06:28:01 INFO - "slavebuilddir": "test" 06:28:01 INFO - } 06:28:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:28:01 INFO - Running post-action listener: _resource_record_post_action 06:28:01 INFO - ##### 06:28:01 INFO - ##### Running download-and-extract step. 06:28:01 INFO - ##### 06:28:01 INFO - Running pre-action listener: _resource_record_pre_action 06:28:01 INFO - Running main action method: download_and_extract 06:28:01 INFO - mkdir: /builds/slave/test/build/tests 06:28:01 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:28:01 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:28:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:28:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:28:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:28:01 INFO - Downloaded 1361 bytes. 06:28:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:28:01 INFO - Using the following test package requirements: 06:28:01 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:28:01 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:28:01 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:28:01 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:01 INFO - u'jsshell-linux-x86_64.zip'], 06:28:01 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:28:01 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:28:01 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:28:01 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:28:01 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:28:01 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:28:01 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:28:01 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:28:01 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:28:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:28:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:28:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:28:04 INFO - Downloaded 22267191 bytes. 06:28:04 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:28:04 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:28:05 INFO - Return code: 0 06:28:05 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:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:05 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:28:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:28:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:28:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:28:07 INFO - Downloaded 22267191 bytes. 06:28:07 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:28:07 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:28:08 INFO - Return code: 0 06:28:08 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:28:08 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:28:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:28:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:28:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:28:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:28:09 INFO - Downloaded 10845952 bytes. 06:28:09 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:28:09 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:28:09 INFO - Return code: 0 06:28: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:28:09 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:28:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:28:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:28:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:28:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:28:11 INFO - Downloaded 54508588 bytes. 06:28:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:28:11 INFO - mkdir: /builds/slave/test/properties 06:28:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:28:11 INFO - Writing to file /builds/slave/test/properties/build_url 06:28:11 INFO - Contents: 06:28:11 INFO - build_url:https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:28:11 INFO - Running post-action listener: _resource_record_post_action 06:28:11 INFO - Running post-action listener: set_extra_try_arguments 06:28:11 INFO - ##### 06:28:11 INFO - ##### Running populate-webroot step. 06:28:11 INFO - ##### 06:28:11 INFO - Running pre-action listener: _resource_record_pre_action 06:28:11 INFO - Running main action method: populate_webroot 06:28:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:28:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:28:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:28:11 INFO - '--tppagecycles', 06:28:11 INFO - '7'], 06:28:11 INFO - 'tests': ['tsvgm']}}, 06:28:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:28:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:28:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:28:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:28:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:28:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:28:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:11 INFO - 'talos_options': ['--disable-e10s'], 06:28:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:11 INFO - 'talos_options': ['--disable-e10s'], 06:28:11 INFO - 'tests': ['damp', 'tps']}, 06:28:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:11 INFO - 'tests': ['damp', 'tps']}, 06:28:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:28:11 INFO - 'tests': ['dromaeo_dom']}, 06:28:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:28:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:28:11 INFO - 'tests': ['a11yr', 06:28:11 INFO - 'ts_paint', 06:28:11 INFO - 'tpaint', 06:28:11 INFO - 'sessionrestore', 06:28:11 INFO - 'sessionrestore_no_auto_restore', 06:28:11 INFO - 'tabpaint']}, 06:28:11 INFO - 'other-e10s': {'tests': ['a11yr', 06:28:11 INFO - 'ts_paint', 06:28:11 INFO - 'tpaint', 06:28:11 INFO - 'sessionrestore', 06:28:11 INFO - 'sessionrestore_no_auto_restore', 06:28:11 INFO - 'tabpaint']}, 06:28:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:28:11 INFO - 'ts_paint', 06:28:11 INFO - 'tpaint', 06:28:11 INFO - 'sessionrestore', 06:28:11 INFO - 'sessionrestore_no_auto_restore', 06:28:11 INFO - 'tabpaint']}, 06:28:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:28:11 INFO - 'ts_paint', 06:28:11 INFO - 'tpaint', 06:28:11 INFO - 'sessionrestore', 06:28:11 INFO - 'sessionrestore_no_auto_restore', 06:28:11 INFO - 'tabpaint']}, 06:28:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:28:11 INFO - 'tests': ['a11yr', 06:28:11 INFO - 'ts_paint', 06:28:11 INFO - 'tpaint', 06:28:11 INFO - 'sessionrestore', 06:28:11 INFO - 'sessionrestore_no_auto_restore', 06:28:11 INFO - 'tabpaint']}, 06:28:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:28:11 INFO - 'tests': ['a11yr', 06:28:11 INFO - 'ts_paint', 06:28:11 INFO - 'tpaint', 06:28:11 INFO - 'sessionrestore', 06:28:11 INFO - 'sessionrestore_no_auto_restore', 06:28:11 INFO - 'tabpaint']}, 06:28:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:28:11 INFO - 'tests': ['tsvgx', 06:28:11 INFO - 'tsvgr_opacity', 06:28:11 INFO - 'tart', 06:28:11 INFO - 'tscrollx', 06:28:11 INFO - 'cart']}, 06:28:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:28:11 INFO - 'tsvgr_opacity', 06:28:11 INFO - 'tart', 06:28:11 INFO - 'tscrollx', 06:28:11 INFO - 'cart']}, 06:28:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:11 INFO - 'talos_options': ['--disable-e10s'], 06:28:11 INFO - 'tests': ['tp5o']}, 06:28:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:11 INFO - 'tests': ['tp5o']}, 06:28:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:11 INFO - 'talos_options': ['--disable-e10s', 06:28:11 INFO - '--xperf_path', 06:28:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:11 INFO - 'tests': ['tp5n']}, 06:28:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:11 INFO - 'talos_options': ['--xperf_path', 06:28:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:11 INFO - 'tests': ['tp5n']}}, 06:28:11 INFO - 'talos.zip': {'path': '', 06:28:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:28:11 INFO - Running post-action listener: _resource_record_post_action 06:28:11 INFO - ##### 06:28:11 INFO - ##### Running create-virtualenv step. 06:28:11 INFO - ##### 06:28:11 INFO - Running pre-action listener: _resource_record_pre_action 06:28:11 INFO - Running main action method: create_virtualenv 06:28:11 INFO - Creating virtualenv /builds/slave/test/build/venv 06:28:11 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:28:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:28:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:28:12 INFO - Using real prefix '/usr' 06:28:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:28:12 INFO - Installing distribute.............................................................................................................................................................................................done. 06:28:17 INFO - Installing pip.................done. 06:28:17 INFO - Return code: 0 06:28:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:17 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 0x7f78adb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2901410>, '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 0x2902310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29027a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', '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:28:17 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:28:17 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:28:17 INFO - Using env: {'DISPLAY': ':0', 06:28:17 INFO - 'HOME': '/home/cltbld', 06:28:17 INFO - 'LANG': 'en_US.UTF-8', 06:28:17 INFO - 'LANGUAGE': 'en_US:en', 06:28:17 INFO - 'LOGNAME': 'cltbld', 06:28:17 INFO - 'MAIL': '/var/mail/cltbld', 06:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:17 INFO - 'MOZ_NO_REMOTE': '1', 06:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:17 INFO - 'NO_EM_RESTART': '1', 06:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:17 INFO - 'PWD': '/builds/slave/test', 06:28:17 INFO - 'SHELL': '/bin/bash', 06:28:17 INFO - 'SHLVL': '1', 06:28:17 INFO - 'TERM': 'linux', 06:28:17 INFO - 'TMOUT': '86400', 06:28:17 INFO - 'USER': 'cltbld', 06:28:17 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', 06:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:17 INFO - '_': '/tools/buildbot/bin/python'} 06:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:19 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:28:19 INFO - Cleaning up... 06:28:19 INFO - Return code: 0 06:28:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:19 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 0x7f78adb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2901410>, '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 0x2902310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29027a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', '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:28:19 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:28:19 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:28:19 INFO - Using env: {'DISPLAY': ':0', 06:28:19 INFO - 'HOME': '/home/cltbld', 06:28:19 INFO - 'LANG': 'en_US.UTF-8', 06:28:19 INFO - 'LANGUAGE': 'en_US:en', 06:28:19 INFO - 'LOGNAME': 'cltbld', 06:28:19 INFO - 'MAIL': '/var/mail/cltbld', 06:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:19 INFO - 'MOZ_NO_REMOTE': '1', 06:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:19 INFO - 'NO_EM_RESTART': '1', 06:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:19 INFO - 'PWD': '/builds/slave/test', 06:28:19 INFO - 'SHELL': '/bin/bash', 06:28:19 INFO - 'SHLVL': '1', 06:28:19 INFO - 'TERM': 'linux', 06:28:19 INFO - 'TMOUT': '86400', 06:28:19 INFO - 'USER': 'cltbld', 06:28:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', 06:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:19 INFO - '_': '/tools/buildbot/bin/python'} 06:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:19 INFO - Downloading/unpacking psutil>=0.7.1 06:28: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:28: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:28: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:28: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:28: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:28: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:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:21 INFO - Installing collected packages: psutil 06:28:21 INFO - Running setup.py install for psutil 06:28:21 INFO - building 'psutil._psutil_linux' extension 06:28:21 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:28:22 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:28:22 INFO - building 'psutil._psutil_posix' extension 06:28:22 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:28:23 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:28:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:23 INFO - Successfully installed psutil 06:28:23 INFO - Cleaning up... 06:28:23 INFO - Return code: 0 06:28:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:23 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 0x7f78adb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2901410>, '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 0x2902310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29027a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', '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:28:23 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:28:23 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:28:23 INFO - Using env: {'DISPLAY': ':0', 06:28:23 INFO - 'HOME': '/home/cltbld', 06:28:23 INFO - 'LANG': 'en_US.UTF-8', 06:28:23 INFO - 'LANGUAGE': 'en_US:en', 06:28:23 INFO - 'LOGNAME': 'cltbld', 06:28:23 INFO - 'MAIL': '/var/mail/cltbld', 06:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:23 INFO - 'MOZ_NO_REMOTE': '1', 06:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:23 INFO - 'NO_EM_RESTART': '1', 06:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:23 INFO - 'PWD': '/builds/slave/test', 06:28:23 INFO - 'SHELL': '/bin/bash', 06:28:23 INFO - 'SHLVL': '1', 06:28:23 INFO - 'TERM': 'linux', 06:28:23 INFO - 'TMOUT': '86400', 06:28:23 INFO - 'USER': 'cltbld', 06:28:23 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', 06:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:23 INFO - '_': '/tools/buildbot/bin/python'} 06:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:28:25 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:28:25 INFO - Installing collected packages: mozsystemmonitor 06:28:25 INFO - Running setup.py install for mozsystemmonitor 06:28:25 INFO - Successfully installed mozsystemmonitor 06:28:25 INFO - Cleaning up... 06:28:25 INFO - Return code: 0 06:28:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:25 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 0x7f78adb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2901410>, '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 0x2902310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29027a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', '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:28:25 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:28:25 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:28:25 INFO - Using env: {'DISPLAY': ':0', 06:28:25 INFO - 'HOME': '/home/cltbld', 06:28:25 INFO - 'LANG': 'en_US.UTF-8', 06:28:25 INFO - 'LANGUAGE': 'en_US:en', 06:28:25 INFO - 'LOGNAME': 'cltbld', 06:28:25 INFO - 'MAIL': '/var/mail/cltbld', 06:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:25 INFO - 'MOZ_NO_REMOTE': '1', 06:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:25 INFO - 'NO_EM_RESTART': '1', 06:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:25 INFO - 'PWD': '/builds/slave/test', 06:28:25 INFO - 'SHELL': '/bin/bash', 06:28:25 INFO - 'SHLVL': '1', 06:28:25 INFO - 'TERM': 'linux', 06:28:25 INFO - 'TMOUT': '86400', 06:28:25 INFO - 'USER': 'cltbld', 06:28:25 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', 06:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:25 INFO - '_': '/tools/buildbot/bin/python'} 06:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:25 INFO - Downloading/unpacking blobuploader==1.2.4 06:28:25 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:28:25 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:28:25 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:28:25 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:28:25 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:28:25 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:28:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:28:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:28: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:28: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:28: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:28: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:28: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:28: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:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:28:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:28:28 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:28:28 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:28:28 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:28:28 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:28:28 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:28:28 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:28:28 INFO - Downloading docopt-0.6.1.tar.gz 06:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:28:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:28:28 INFO - Running setup.py install for blobuploader 06:28:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:28:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:28:28 INFO - Running setup.py install for requests 06:28:28 INFO - Running setup.py install for docopt 06:28:28 INFO - Successfully installed blobuploader requests docopt 06:28:28 INFO - Cleaning up... 06:28:28 INFO - Return code: 0 06:28:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:28 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:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:28 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:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:28 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 0x7f78adb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2901410>, '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 0x2902310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29027a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', '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:28:28 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:28:28 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:28:28 INFO - Using env: {'DISPLAY': ':0', 06:28:28 INFO - 'HOME': '/home/cltbld', 06:28:28 INFO - 'LANG': 'en_US.UTF-8', 06:28:28 INFO - 'LANGUAGE': 'en_US:en', 06:28:28 INFO - 'LOGNAME': 'cltbld', 06:28:28 INFO - 'MAIL': '/var/mail/cltbld', 06:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:28 INFO - 'MOZ_NO_REMOTE': '1', 06:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:28 INFO - 'NO_EM_RESTART': '1', 06:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:28 INFO - 'PWD': '/builds/slave/test', 06:28:28 INFO - 'SHELL': '/bin/bash', 06:28:28 INFO - 'SHLVL': '1', 06:28:28 INFO - 'TERM': 'linux', 06:28:28 INFO - 'TMOUT': '86400', 06:28:28 INFO - 'USER': 'cltbld', 06:28:28 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', 06:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:28 INFO - '_': '/tools/buildbot/bin/python'} 06:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:29 INFO - Running setup.py (path:/tmp/pip-qdcWGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:29 INFO - Running setup.py (path:/tmp/pip-nL0NuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:29 INFO - Running setup.py (path:/tmp/pip-8WHOqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:29 INFO - Running setup.py (path:/tmp/pip-IV8Azq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:29 INFO - Running setup.py (path:/tmp/pip-HZ19Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:29 INFO - Running setup.py (path:/tmp/pip-zPSphj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:29 INFO - Running setup.py (path:/tmp/pip-ce7nqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:29 INFO - Running setup.py (path:/tmp/pip-UJCfyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:29 INFO - Running setup.py (path:/tmp/pip-cOHKVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:29 INFO - Running setup.py (path:/tmp/pip-TxqdnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:29 INFO - Running setup.py (path:/tmp/pip-5G1lNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:29 INFO - Running setup.py (path:/tmp/pip-8dOcsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:29 INFO - Running setup.py (path:/tmp/pip-TMPk44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:30 INFO - Running setup.py (path:/tmp/pip-nrTAes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:30 INFO - Running setup.py (path:/tmp/pip-doKcZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:30 INFO - Running setup.py (path:/tmp/pip-kDfIaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:30 INFO - Running setup.py (path:/tmp/pip-qBFmhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:28:30 INFO - Running setup.py install for manifestparser 06:28:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:28:30 INFO - Running setup.py install for mozcrash 06:28:30 INFO - Running setup.py install for mozdebug 06:28:30 INFO - Running setup.py install for mozdevice 06:28:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:28:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:28:30 INFO - Running setup.py install for mozfile 06:28:30 INFO - Running setup.py install for mozhttpd 06:28:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:28:30 INFO - Running setup.py install for mozinfo 06:28:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Running setup.py install for mozInstall 06:28:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Running setup.py install for mozleak 06:28:31 INFO - Running setup.py install for mozlog 06:28:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Running setup.py install for moznetwork 06:28:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Running setup.py install for mozprocess 06:28:31 INFO - Running setup.py install for mozprofile 06:28:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Running setup.py install for mozrunner 06:28:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:28:31 INFO - Running setup.py install for mozscreenshot 06:28:31 INFO - Running setup.py install for moztest 06:28:32 INFO - Running setup.py install for mozversion 06:28:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:28:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:28:32 INFO - Cleaning up... 06:28:32 INFO - Return code: 0 06:28:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:32 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:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:32 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:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:32 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 0x7f78adb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2901410>, '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 0x2902310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29027a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', '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:28:32 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:28:32 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:28:32 INFO - Using env: {'DISPLAY': ':0', 06:28:32 INFO - 'HOME': '/home/cltbld', 06:28:32 INFO - 'LANG': 'en_US.UTF-8', 06:28:32 INFO - 'LANGUAGE': 'en_US:en', 06:28:32 INFO - 'LOGNAME': 'cltbld', 06:28:32 INFO - 'MAIL': '/var/mail/cltbld', 06:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:32 INFO - 'MOZ_NO_REMOTE': '1', 06:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:32 INFO - 'NO_EM_RESTART': '1', 06:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:32 INFO - 'PWD': '/builds/slave/test', 06:28:32 INFO - 'SHELL': '/bin/bash', 06:28:32 INFO - 'SHLVL': '1', 06:28:32 INFO - 'TERM': 'linux', 06:28:32 INFO - 'TMOUT': '86400', 06:28:32 INFO - 'USER': 'cltbld', 06:28:32 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', 06:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:32 INFO - '_': '/tools/buildbot/bin/python'} 06:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:32 INFO - Running setup.py (path:/tmp/pip-BKACP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:32 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:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:32 INFO - Running setup.py (path:/tmp/pip-A6_Z7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:32 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:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:32 INFO - Running setup.py (path:/tmp/pip-xtPvDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:32 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:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:32 INFO - Running setup.py (path:/tmp/pip-sIsh1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:32 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:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:32 INFO - Running setup.py (path:/tmp/pip-AVirPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:32 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:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:32 INFO - Running setup.py (path:/tmp/pip-MqBrW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:32 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:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:32 INFO - Running setup.py (path:/tmp/pip-QRfHZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:32 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:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:32 INFO - Running setup.py (path:/tmp/pip-h1jkoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:32 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:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:32 INFO - Running setup.py (path:/tmp/pip-Mn1EPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:32 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:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:32 INFO - Running setup.py (path:/tmp/pip-QzOfZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:33 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:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:33 INFO - Running setup.py (path:/tmp/pip-hkOqZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:33 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:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:33 INFO - Running setup.py (path:/tmp/pip-vdqs1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:33 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:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:33 INFO - Running setup.py (path:/tmp/pip-my7PSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:33 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:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:33 INFO - Running setup.py (path:/tmp/pip-ZoDTc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:33 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:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:33 INFO - Running setup.py (path:/tmp/pip-1eHUJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:33 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:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:33 INFO - Running setup.py (path:/tmp/pip-7NctdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:33 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:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:33 INFO - Running setup.py (path:/tmp/pip-yBAAdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:35 INFO - Downloading blessings-1.6.tar.gz 06:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:28:35 INFO - Installing collected packages: blessings 06:28:35 INFO - Running setup.py install for blessings 06:28:35 INFO - Successfully installed blessings 06:28:35 INFO - Cleaning up... 06:28:35 INFO - Return code: 0 06:28:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:28:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:35 INFO - Reading from file tmpfile_stdout 06:28:35 INFO - Current package versions: 06:28:35 INFO - argparse == 1.2.1 06:28:35 INFO - blessings == 1.6 06:28:35 INFO - blobuploader == 1.2.4 06:28:35 INFO - docopt == 0.6.1 06:28:35 INFO - manifestparser == 1.1 06:28:35 INFO - mozInstall == 1.12 06:28:35 INFO - mozcrash == 0.17 06:28:35 INFO - mozdebug == 0.1 06:28:35 INFO - mozdevice == 0.48 06:28:35 INFO - mozfile == 1.2 06:28:35 INFO - mozhttpd == 0.7 06:28:35 INFO - mozinfo == 0.9 06:28:35 INFO - mozleak == 0.1 06:28:35 INFO - mozlog == 3.1 06:28:35 INFO - moznetwork == 0.27 06:28:35 INFO - mozprocess == 0.22 06:28:35 INFO - mozprofile == 0.28 06:28:35 INFO - mozrunner == 6.11 06:28:35 INFO - mozscreenshot == 0.1 06:28:35 INFO - mozsystemmonitor == 0.0 06:28:35 INFO - moztest == 0.7 06:28:35 INFO - mozversion == 1.4 06:28:35 INFO - psutil == 3.1.1 06:28:35 INFO - requests == 1.2.3 06:28:35 INFO - wsgiref == 0.1.2 06:28:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:35 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 0x7f78adb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2901410>, '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 0x2902310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29027a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', '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:28:35 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:28:35 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:28:35 INFO - Using env: {'DISPLAY': ':0', 06:28:35 INFO - 'HOME': '/home/cltbld', 06:28:35 INFO - 'LANG': 'en_US.UTF-8', 06:28:35 INFO - 'LANGUAGE': 'en_US:en', 06:28:35 INFO - 'LOGNAME': 'cltbld', 06:28:35 INFO - 'MAIL': '/var/mail/cltbld', 06:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:35 INFO - 'MOZ_NO_REMOTE': '1', 06:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:35 INFO - 'NO_EM_RESTART': '1', 06:28:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:35 INFO - 'PWD': '/builds/slave/test', 06:28:35 INFO - 'SHELL': '/bin/bash', 06:28:35 INFO - 'SHLVL': '1', 06:28:35 INFO - 'TERM': 'linux', 06:28:35 INFO - 'TMOUT': '86400', 06:28:35 INFO - 'USER': 'cltbld', 06:28:35 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', 06:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:35 INFO - '_': '/tools/buildbot/bin/python'} 06:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:36 INFO - Cleaning up... 06:28:36 INFO - Return code: 0 06:28:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:28:36 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:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:36 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:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:36 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 0x7f78adb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2901410>, '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 0x2902310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29027a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', '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:28:36 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:28:36 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:28:36 INFO - Using env: {'DISPLAY': ':0', 06:28:36 INFO - 'HOME': '/home/cltbld', 06:28:36 INFO - 'LANG': 'en_US.UTF-8', 06:28:36 INFO - 'LANGUAGE': 'en_US:en', 06:28:36 INFO - 'LOGNAME': 'cltbld', 06:28:36 INFO - 'MAIL': '/var/mail/cltbld', 06:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:36 INFO - 'MOZ_NO_REMOTE': '1', 06:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:36 INFO - 'NO_EM_RESTART': '1', 06:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:36 INFO - 'PWD': '/builds/slave/test', 06:28:36 INFO - 'SHELL': '/bin/bash', 06:28:36 INFO - 'SHLVL': '1', 06:28:36 INFO - 'TERM': 'linux', 06:28:36 INFO - 'TMOUT': '86400', 06:28:36 INFO - 'USER': 'cltbld', 06:28:36 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', 06:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:36 INFO - '_': '/tools/buildbot/bin/python'} 06:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:36 INFO - Downloading/unpacking jsonschema 06:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:28:38 INFO - Downloading/unpacking functools32 (from jsonschema) 06:28:38 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:28:38 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:28:38 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:28:38 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:28:38 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:28:38 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:28:38 INFO - Downloading functools32-3.2.3-2.tar.gz 06:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:28:38 INFO - warning: no files found matching '*.txt' 06:28:38 INFO - no previously-included directories found matching 'build' 06:28:38 INFO - no previously-included directories found matching 'dist' 06:28:38 INFO - no previously-included directories found matching '.git*' 06:28:38 INFO - Installing collected packages: jsonschema, functools32 06:28:38 INFO - Running setup.py install for functools32 06:28:38 INFO - warning: no files found matching '*.txt' 06:28:38 INFO - no previously-included directories found matching 'build' 06:28:38 INFO - no previously-included directories found matching 'dist' 06:28:38 INFO - no previously-included directories found matching '.git*' 06:28:38 INFO - Successfully installed jsonschema functools32 06:28:38 INFO - Cleaning up... 06:28:38 INFO - Return code: 0 06:28:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:28:38 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:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:38 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:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:38 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 0x7f78adb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2901410>, '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 0x2902310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29027a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', '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:28:38 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:28:38 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:28:38 INFO - Using env: {'DISPLAY': ':0', 06:28:38 INFO - 'HOME': '/home/cltbld', 06:28:38 INFO - 'LANG': 'en_US.UTF-8', 06:28:38 INFO - 'LANGUAGE': 'en_US:en', 06:28:38 INFO - 'LOGNAME': 'cltbld', 06:28:38 INFO - 'MAIL': '/var/mail/cltbld', 06:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:38 INFO - 'MOZ_NO_REMOTE': '1', 06:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:38 INFO - 'NO_EM_RESTART': '1', 06:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:38 INFO - 'PWD': '/builds/slave/test', 06:28:38 INFO - 'SHELL': '/bin/bash', 06:28:38 INFO - 'SHLVL': '1', 06:28:38 INFO - 'TERM': 'linux', 06:28:38 INFO - 'TMOUT': '86400', 06:28:38 INFO - 'USER': 'cltbld', 06:28:38 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', 06:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:38 INFO - '_': '/tools/buildbot/bin/python'} 06:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:38 INFO - Downloading/unpacking flake8 06:28:38 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:28:38 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:28:38 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:28:38 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:28:38 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:28:38 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:28:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:28:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:28:40 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:28:40 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:28:40 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:28:40 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:28:40 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:28:40 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:28:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:28:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:28:41 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:28:41 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:28:41 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:28:41 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:28:41 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:28:41 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:28:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:28:41 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:28:41 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:28:41 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:28:41 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:28:41 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:28:41 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:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:28:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:41 INFO - no previously-included directories found matching 'docs/_build' 06:28:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:28:41 INFO - Running setup.py install for pep8 06:28:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:41 INFO - no previously-included directories found matching 'docs/_build' 06:28:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:28:41 INFO - Cleaning up... 06:28:41 INFO - Return code: 0 06:28:41 INFO - Running post-action listener: _resource_record_post_action 06:28:41 INFO - Running post-action listener: _start_resource_monitoring 06:28:41 INFO - Starting resource monitoring. 06:28:41 INFO - ##### 06:28:41 INFO - ##### Running install step. 06:28:41 INFO - ##### 06:28:41 INFO - Running pre-action listener: _resource_record_pre_action 06:28:41 INFO - Running main action method: install 06:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:42 INFO - Reading from file tmpfile_stdout 06:28:42 INFO - Detecting whether we're running mozinstall >=1.0... 06:28:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:28:42 INFO - Reading from file tmpfile_stdout 06:28:42 INFO - Output received: 06:28:42 INFO - Usage: mozinstall [options] installer 06:28:42 INFO - Options: 06:28:42 INFO - -h, --help show this help message and exit 06:28:42 INFO - -d DEST, --destination=DEST 06:28:42 INFO - Directory to install application into. [default: 06:28:42 INFO - "/builds/slave/test"] 06:28:42 INFO - --app=APP Application being installed. [default: firefox] 06:28:42 INFO - mkdir: /builds/slave/test/build/application 06:28:42 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:28:42 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:28:57 INFO - Reading from file tmpfile_stdout 06:28:57 INFO - Output received: 06:28:57 INFO - /builds/slave/test/build/application/firefox/firefox 06:28:57 INFO - Running post-action listener: _resource_record_post_action 06:28:57 INFO - ##### 06:28:57 INFO - ##### Running run-tests step. 06:28:57 INFO - ##### 06:28:57 INFO - Running pre-action listener: _resource_record_pre_action 06:28:57 INFO - Running main action method: run_tests 06:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:28:57 INFO - Python 2.7.3 06:28:57 INFO - Return code: 0 06:28:57 INFO - grabbing minidump binary from tooltool 06:28: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:28:57 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 0x2901410>, '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 0x2902310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29027a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:28:57 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:28:57 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:28:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:28:58 INFO - Return code: 0 06:28:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:28:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:28:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:28:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:28:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:28:59 INFO - Return code: 0 06:28:59 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/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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:28:59 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/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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:28:59 INFO - Using env: {'DISPLAY': ':0', 06:28:59 INFO - 'HOME': '/home/cltbld', 06:28:59 INFO - 'LANG': 'en_US.UTF-8', 06:28:59 INFO - 'LANGUAGE': 'en_US:en', 06:28:59 INFO - 'LOGNAME': 'cltbld', 06:28:59 INFO - 'MAIL': '/var/mail/cltbld', 06:28:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:28:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:59 INFO - 'MOZ_NO_REMOTE': '1', 06:28:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:59 INFO - 'NO_EM_RESTART': '1', 06:28:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:59 INFO - 'PWD': '/builds/slave/test', 06:28:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:28:59 INFO - 'SHELL': '/bin/bash', 06:28:59 INFO - 'SHLVL': '1', 06:28:59 INFO - 'TERM': 'linux', 06:28:59 INFO - 'TMOUT': '86400', 06:28:59 INFO - 'USER': 'cltbld', 06:28:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911', 06:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:59 INFO - '_': '/tools/buildbot/bin/python'} 06:28:59 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/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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:28:59 INFO - mozversion application_buildid: 20160419211331 06:28:59 INFO - mozversion application_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 06:28:59 INFO - mozversion application_display_name: Nightly 06:28:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:28:59 INFO - mozversion application_name: Firefox 06:28:59 INFO - mozversion application_remotingname: firefox 06:28:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:28:59 INFO - mozversion application_vendor: Mozilla 06:28:59 INFO - mozversion application_version: 48.0a1 06:28:59 INFO - mozversion platform_buildid: 20160419211331 06:28:59 INFO - mozversion platform_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 06:28:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:28:59 INFO - mozversion platform_version: 48.0a1 06:28:59 INFO - using testdate: 1461331739 06:28:59 INFO - actual date: 1461331739 06:28:59 INFO - starting webserver on 'localhost:35933' 06:28:59 INFO - SUITE-START | Running 2 tests 06:28:59 INFO - TEST-START | dromaeo_css 06:28:59 INFO - operating with platform_type : linux_ 06:28:59 INFO - Initialising browser for dromaeo_css test... 06:28:59 INFO - TEST-INFO | started process 3303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0D4tjR/profile http://localhost:35933/getInfo.html) 06:29:05 INFO - PROCESS | 3303 | __metrics Screen width/height:1600/1200 06:29:05 INFO - PROCESS | 3303 | colorDepth:24 06:29:05 INFO - PROCESS | 3303 | Browser inner width/height: 1024/697 06:29:05 INFO - PROCESS | 3303 | __metrics 06:29:06 ERROR - PROCESS | 3303 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:29:07 INFO - TEST-INFO | 3303: exit 0 06:29:07 INFO - Browser initialized. 06:29:07 INFO - Running cycle 1/1 for dromaeo_css test... 06:29:07 INFO - TEST-INFO | started process 3385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0D4tjR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:19 INFO - PROCESS | 3385 | RSS: Main: 155353088 06:29:19 INFO - PROCESS | 3385 | 06:30:11 INFO - PROCESS | 3385 | 1461331811087 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:32:22 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:35933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35933/tests/dromaeo/cssquery-ext.html) 06:32:24 INFO - PROCESS | 3385 | RSS: Main: 271306752 06:32:24 INFO - PROCESS | 3385 | 06:35:26 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:35933/tests/dromaeo/cssquery-ext.html (next: http://localhost:35933/tests/dromaeo/cssquery-jquery.html) 06:35:27 INFO - PROCESS | 3385 | RSS: Main: 238714880 06:35:27 INFO - PROCESS | 3385 | 06:38:29 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:35933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35933/tests/dromaeo/cssquery-mootools.html) 06:38:30 INFO - PROCESS | 3385 | RSS: Main: 238211072 06:38:30 INFO - PROCESS | 3385 | 06:41:32 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:35933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35933/tests/dromaeo/cssquery-prototype.html) 06:41:32 INFO - PROCESS | 3385 | RSS: Main: 234835968 06:41:32 INFO - PROCESS | 3385 | 06:44:35 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:35933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35933/tests/dromaeo/cssquery-yui.html) 06:44:36 INFO - PROCESS | 3385 | RSS: Main: 217976832 06:44:36 INFO - PROCESS | 3385 | 06:47:39 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:35933/tests/dromaeo/cssquery-yui.html (next: http://localhost:35933/tests/dromaeo/cssquery-dojo.html) 06:47:39 INFO - PROCESS | 3385 | RSS: Main: 268337152 06:47:39 INFO - PROCESS | 3385 | 06:47:39 INFO - PROCESS | 3385 | __start_tp_report 06:47:39 INFO - PROCESS | 3385 | _x_x_mozilla_page_load 06:47:39 INFO - PROCESS | 3385 | _x_x_mozilla_page_load_details 06:47:39 INFO - PROCESS | 3385 | |i|pagename|runs| 06:47:39 INFO - PROCESS | 3385 | |0;dojo.html;2593.286846117318;2652.814302998791;2676.9866150669245;2691.9596206056913;2695.8382497050166;4480.462344518663;4562.885927851806;4627.07458508298;4660.697054691447;4698.201305778018;4587.954120458794;4612.769361531927;4627.5603817637275;4658.836940707076;4691.835785747499;4226.873193804191;4262.445882035338;4283.87148385549;4323.783810809463;4413.360062790894;4317.13657268546;4337.652987760972;4370.825166993316;4382.868513944571;4424.336349547578;4121.196366708493;4210.136921930997;4227.408162857202;4235.767032813194;4315.072259464199;4259.936100958488;4264.381664658638;4270.7864606769535;4272.359146128075;4326.264535029021;4266.338717498793;4271.316589345721;4272.658187345036;4297.290946993742;4310.978445107754;4368.344748287782;4437.511873693891;4476.574725401082;4552.066826300634;4557.088582283556;4939;4956.653034287601;4957.479464656195;4962.280469331927;4984.700917944899;4958.355413796219;4963.404391473046;4968.801247950078;4974.502549745032;4986;4451.9332210016555;4616.884577885579;4691.9530804692195;4720.740359280273;4723.315119307681;5029.471905449948;5032.069067222503;5035.723035233024;5037.4458809530925;5039.0929632666475;4665.6734028617675;4832.613390928787;4833;4835.419749629997;4866.367372241657;4943.678660887031;4992.700437973734;5007.24891266313;5053.444121146671;5053.9747301264;4825.613950883921;4867.66139311685;4867.756612169377;4869.63477739171;4908.533689299511;4668.3697700810635;4767.427908650984;4852;4909.968906529597;4912.508749125131;4188.68584856137;4196.538380778112;4238.6397156242065;4249.511306199826;4256.2551553478015;3710;3720.2001569662652;3725.6088110748524;3728.217074414349;3743.457198706227;4159.771212583337;4294.506131794884;4308.224519586442;4310.762908040025;4346.174226896943;4806.327114204014;4839.395075615548;4851.175300198975;4889.877753056131;4894.730789806524;4248.553901840324;4281.764502952367;4288.2066817638215;4324.718893271927;4334.41485399467;4324;4484.663650226246;4485.820567177277;4488.506264310923;4492.034212644297;4745.572898439157;4747.976260118747;4748.026654535881;4755.667103302736;4799.688020278671;4998.975005124951;5003.174476211384;5005.524475174852;5005.974970125126;5007.3240112584335;4566.26939689648;4652.348671185969;4706.388169537938;4741.193997020584;4771.904561908812;4914.459409464885;4920.532549407801;4928.802847886044;4931.260310953386;4935.383077115361;4972.8508144755715;5001.849944501525;5007.674501157413;5009.674371165863;5029.572486338702;4638.582527572535;4710.081534100817;4817.494163112963;4844.709317440965;4886.242632391985;4809.2305231162845;4832.927506087482;4846.418429788448;4851.102546028996;4910.975445122752;4752.572268495852;4784.688995215439;4789.688670236424;4791.6406269529225;4831.033793241296;4641.86074417768;4645.6980296280635;4742.478327383916;4778.904421911612;4855.271709243641;4732.290156476556;4776.355192049168;4780.521947805191;4781.713097214179;4796.160671882476 06:47:39 INFO - PROCESS | 3385 | |1;ext.html;558.4387690371179;595.603923390945;603.879224155169;616.5560796226721;621.8973869311562;26071.348216294602;26477.205683829492;26536.60195097075;26550.6017409739;26552.468950620976;26714.599281010753;33568.49647255293;34556.308873822505;34569;34609.48085778715;7584.810379740496;7761.495502792301;7771.650275737577;7771.766846994599;7773.883391749128;7466.104067511907;7562.395008399315;7692.230776922291;7694.961525192366;7753.185915478878;7520.323170914617;7613.467057305991;9799.853002204973;10202.285839991204;10206.336588121785;9708.126268635822;9833.901660983442;9834.164096051773;9835.065668761456;9845.704628861109;7424.85150296991;9608.183304419133;9727.805443891153;9745.707628771148;9747.3664211826;33652.99041028773;34856;34877;34887;34924.47613285803;3139.4192074466296;3270.3622793555264;3282.7045565898943;3473.513708080871;3716.9256614867822;27000.189994300203;27783.305417364525;29473.70526294731;29701.405971880442;29716.405671886656;3237.6114866216203;3342.8495717692763;3369.4271973764276;3395.066356751888;3477.113336099304;234568;236490;236987;237010;237860;56916;57680.423195768344;57683.42316576865;57785.71107144438;57795.71102144462;61594.0760888587;61873;62135.689321554004;62397.76022397724;62445;14000.50998215078;14437.927810360881;14473.78289325661;14484.420623175165;14485;10829.891701082888;10887.727806804734;10890.891091088988;10898.18263630215;10909.07272881798;16488.25802838875;18385.92262977763;18542.351017714314;19041.61916761657;19370;6914.688839002257;7231.674574644154;7236.38490728294;7238.963805180941;7250.2024777274455;901.2384535067857;909.0591238068567;952.7379970508166;994.4828689081637;1012.2458768217725;24788.132415365737;26433.47133057328;26506.958250497017;26808.8659556701;28784.280392990342;994.433173091331;1004.1013293102632;1049.4700176410863;1063.4629512096496;1075.3709080188178;14638.341274642667;15110;15155;15166.165860877758;15404.075755454709;333464;338690;341536;342774;343633;48310.75844620755;48904.26643600349;48938;49054.50945490571;49097;1183.260606907844;1220.558882235529;1221.2245224282467;1222.9205101668363;1254.2850575172065;26226.86886565555;27625.585616215372;27874.581881272203;27880.721192787812;28131.296717582223;42467.5753242476;42601.786991064844;43045.784771075945;43061.56938430575;43088.569114308455;325133;325304;326832;327468;328013;29543;31330.530042048933;37654.058648534;38226;38456;35733.1066723334;38592.2281554373;40368.798156009034;41017.1796564073;42643.78678106589;33335.666643334225;34505.309893802485;34715;34778.652213477544;35126.64873351234;33571.328573427905;33928.83035584806;33950.49074263839;34057.65942340545;34213.486797698555;34758.82620586881;34804;35146;35575.288494229455;37186.07034824151;29827.403451931274;30990.845045774626;31566.842165789025;31707.20731981719;31796;24232.75767242305;24268.150614728398;24471.60847824292;25016.874915625307;25082.37294067663 06:47:39 INFO - PROCESS | 3385 | |2;jquery.html;365.5138665574786;383.7390574409402;384.7883663984808;389.89464867101765;394.82430318508256;12308.384580770959;15578.143202123878;15884.52346429606;16564.420245291418;16583.258757830434;14826.777598336006;15324.540263792076;15728.528144155665;16195.83804161958;16286.185690715476;4852.665516982823;5054.064997975377;5181.6113791465605;5199.298094757197;5223.791048358061;5108.310378098946;5114.360704911886;5128.871778205537;5139;5148.485151484841;5037.672551284173;5072.644914855961;5101;5110.616703747234;5111.105556527611;4969.080720066781;5091.185410334366;5092.032513822381;5107.1828507439;5131.332926719521;4440.400545926291;4488.349189367524;4560.8859778505475;4577.656675749332;4587;19593.412197634094;19803.900980495004;19943.90028049865;20121.698174527395;20308.69536956932;1756.5345183526376;1873.3536929759348;1914.5309399197286;1966.1447270437407;1987.5329297615049;8702.173293537104;9036.50299233542;9116.498592577405;9414.246860251164;9431.575579098888;1705.4968784208688;1720.3032771727471;1722.7071397862394;1742.198588649223;1769.6637638848706;66021.339786602;68282.65858670724;68308.31691683119;68460.6576967117;70467.2953270471;8966.910330896739;9348.20540254086;10077.596896124072;10134.695959121238;10154;12652.367381630882;13479;13506.729865402636;13516.391762370717;13525.256110913797;6949.89575156373;7047.68285427157;7181.569105853561;7202.567845929261;7203.063601731741;6692.230393504809;6702.664866756642;6705.6982435790505;6823.795286141423;6830.965845170842;4264.808083636244;4268.786560671954;4289.785510724451;4318.330658747899;4358.280883654225;1800.198911484403;1817.2095138614745;1851.3242666426656;1854.9165287562091;1875.4561177258715;862.2067697717989;939.145377706284;940.844760614491;956.1346980982222;964.9855252171224;15844.207789610704;16424.589385265226;16594.917025414794;16839.410620628463;16968.321267149422;825.1310781080857;848.3891598049395;881.5460038080394;911.0034931724421;945.3099237556485;8992.8651070234;9248.26013918885;9288.303377246733;9326.95336523313;9653.082957119062;364946;374206;381341;383465.0826745848;384827;77829;77860.22139778643;78662;79467;81857.18142818495;934.4486752815872;949.4635530924867;951.5908159491485;965.710286913923;967.8790151231096;14440.855591443951;14498.492552760603;14539.636509087357;14551.19893891278;15105.47130850415;30669.8466507666;31163.220919476287;33794.49308260329;33932.830335848164;34985;44874.775626121664;45779.77110114428;45999.31001035054;46014.769926150155;46211;7727.11138219112;7799.9220007799195;7858.0570331560575;8075.434719569574;8125.390595705464;11827.231229970024;11958;11972.281663100242;12229.571964981538;12448.813267801172;9566.282528810229;10466.372017678963;10738.033576978109;10789.784204316027;10953.56185752561;5187.896242075062;8273.214044665747;10369;10600.151987841109;11033.724156896142;10306.48467576633;10551.525181366704;10782.568697252022;11096.167787415814;11223.775524489627;7801.024871891013;7958.880616790869;8010.279074883289;8011.799705007422;8108.675652973815;7592.696292148252;9013.729588112366;9850.852237216304;9869.25980551476;10092.14216791581 06:47:39 INFO - PROCESS | 3385 | |3;mootools.html;1286.7040580666453;1423.3310344138251;1448.3265281644035;1562.4921900382378;1755.7263343969557;7521.623918804058;7853.096893857201;7861.960690196541;7873.842523149548;7885.763427097197;7638.54168749874;7777.572233527154;7789.182135875736;7793.493422927506;7797.610119494031;1889.3859495663896;2129.4676330917273;2231.241377931503;2257.762934891829;2260.2315212827634;2239.261043855532;2262.954740905181;2263.106073101124;2264.8074913632363;2267.6031694453404;2193.2981445937307;2241.0139538603044;2242.2936774915847;2246.168917500527;2247.0337754765446;1841.2174825699092;2131.8507704460694;2225;2226.4100013496436;2229.041512149775;2137.10241698487;2151.9462013449634;2159.6436587962967;2159.8704077755383;2182.34529641107;7603.2776886195725;7682.654280557388;7705.075390953066;7706.653200605986;7715.884261736079;4427.800748966304;4613.1696294666945;4624.352590637313;4625.791839367236;4657.767111644438;2991.3867657130454;3016.502277124272;3048.786584939055;3055.679153688875;3079.4610943085095;956.6699488676395;1677.3877534699868;1703.4548944337816;1722.431597572798;1723.5346456456812;10333.689989300334;10433.739156521071;10442.738931526697;10464.790704185874;10475;3964.7621142731527;4073.103917138284;4099.323611604052;4130.153318569686;4161.25097482456;8314.127016663164;8340.499570025819;8348.081711011784;8358.791030224293;8547.700830470903;4015.2772500949527;4711.104890070944;4711.316859055418;4715.669903106818;4729.574338309569;4187.330027195634;4265.786710664454;4325.394444777734;4325.4593175853015;4334.869953901325;3456.1186897341017;3486.825658717054;3544.149404142987;3572.624874388204;3605.170810713498;1087.456271864068;1089.9073578745738;1093.8085834978847;1100.834874768791;1105.5135740274254;721.3579913876654;737.8007937856856;806.9475484093515;893.883795106632;906.0214967834722;5477.20580515823;5558.305211848519;5628.887422251532;5760.913586296209;5812.534997200214;883.7097837157693;913.7304495173939;915.5239275576663;919.7102912582515;923.5105394141116;3542.1852973815653;3622.673959343672;3725.701943844486;3832.156925476391;3854.2869569129803;9348.626054957726;9768.462734549526;9813.16588090006;9843.950780246196;9847.359921605215;9600.903990960142;9649.614015439303;9667.661631842851;9695.272854535797;9750.90249097514;7058.9294107059295;7080.185778635523;7126.821829454201;7138.714451421989;7196.0645116134565;5222.294990176278;5361.329833770778;5470.070088084955;5518.199861020049;5597.160425936142;8939.865902011345;8977.685780997634;9090.545472726206;9201.125893040151;9207.079292070739;8793.736187914374;9170.587323570322;9184.403013804082;9306.162445379949;9306.627734890799;5822.126680997884;6051.122587224916;6059.3637668045985;6405.167328247298;6587.736490540325;6439.45264652491;7527.059117610299;7595.696172153052;7601.809954751176;7610.353119984863;6710.899336509859;6774.458043356618;6791;6910.412614927787;7049.083619129686;6737.393634572912;6820.113385259884;6915.446764258747;6984.7206111757;7044.542104763174;6413.198350206224;6419.325970773001;6436.613803171825;6460.25707043696;6482.805515834532;4568.269076947672;4759.833405830779;4822.590079843252;4841.419029716316;4850.684705494132;4747.715137091785;4749.477557468745;4751.216049351819;4803.951960480351;4870.439899411613 06:47:39 INFO - PROCESS | 3385 | |4;prototype.html;311.30889425475436;314.4026349935123;321.68796267620405;323.6795572383341;324.388527625426;5030.823921162755;5074.188129899217;5094.439611642716;5094.7197904115255;5099.4390617032095;4695.765211739416;4794.640401969848;4942.135126352892;5000.399952005755;5034.5468907798295;3979.602039796012;4018.9196216075807;4019.4677353267402;4021.8592349267783;4023.879283621496;4016.3975403689533;4017;4027.5771044040393;4028.154087641599;4034.5561988181275;3744.6068162842917;3836.6547010769027;3982.721209515335;3984.1434091670285;4002.7198096133284;3965.643092121694;3967.305721498726;3985.143194213258;4000.7999600019884;4001.779902105383;3545.503629491873;3549.343371476259;3549.94675079874;3551.4317709166667;3555.253396786678;4725.64557658177;4788.856334309941;4852.927206091911;4856.951430485685;4878.658493905428;4484.573965473275;4523.457185137771;4526.456825181;4529.637628989706;4545.38637283969;5244.711540865251;5275.26146339509;5282;5282.2076688496645;5285.7621407036395;3704.555453345589;3835;3838.4434257032854;3841.4429907663234;3842.0010797192654;5495.752691128909;5497.780088796443;5515.696636684981;5525.364583072957;5530.170474428827;3912.628300311466;3915.5105611798526;3917.9020524487114;3919.5884432134785;3920.8039598019986;3955.7033222508426;3979.2041591681777;3986.402039694011;3986.820593073319;3996.900077498086;4165.875023749292;4365.432493775789;4420.535843736426;4436.223660859337;4453.55464453552;5283.682979021271;5299.205119232146;5301.66726640277;5308.150695888639;5312.1766126250495;1256.3655354046148;1292.38611659461;1342.4026308292716;1353.4856754433251;1357.7148798752373;888.4003297773977;899.6536333511646;907.5961197267285;910.1171863292728;911.4349103555838;4605.194091034055;4620.214563524209;4631.606313463326;4633.559811817872;4636.397268355092;5364.678119312854;5383.515483606494;5388.191771234347;5389;5391.272178255886;4552.863414097583;4629.328747331618;4634.86095417138;4636.678546614199;4638.95361046392;2803.649543807024;2884.1059271625863;2889.9277518061795;2893.348996475776;2893.8697758600915;5054.974725126424;5069.847904562869;5071.518205770446;5077.339945807022;5089.67668406217;5320.893582128413;5477.534409575151;5524.392316845144;5529.30883639545;5531.446855314436;5075.096838685493;5076.847694569169;5077.111505486525;5083.923741143886;5095.337606111182;5369.818639899216;5373.6507127038185;5377.516023557899;5377.704226267593;5378.489043540857;5028.23447104084;5268.236105764566;5268.81559145428;5271.578273738015;5291.550218231493;5044.747762611928;5067.949320506896;5078.949210507848;5097.464766199644;5104.821331253537;3776.112613535872;3801.4487899255005;3807.6002019787525;3811.695064394897;3819.6371344722206;5179.730965913224;5247.58019358458;5352.437994010573;5354.705491198021;5385.784568617368;5130.256112863689;5293.206019097166;5327.174287985368;5331.466853314638;5335.653182543122;5232.633715640021;5241.764120614505;5268.473152684701;5269.8682532935445;5276.736163191748;5078.746062696777;5159.122949098587;5176.9741151294;5184.766685499237;5185.533302002837;5304.283921670525;5311.72518595542;5315.893682126413;5336.306280183551;5338.3593968724;5189.221616757516;5196.2725218470205;5199.29809475716;5215.400228973716;5216 06:47:39 INFO - PROCESS | 3385 | |5;yui.html;591.6272748168655;615.1940957345877;653.4151934019052;660.669665167416;693.8751024815531;11350.716232094202;11681.240719353236;11683.883161168385;11720.120990925694;11734.530618775249;10841.078508326802;11311.717207069827;11329.490172942216;11378.886211137886;11416.086713062956;787.6967367563471;821.3757544266371;822.5311572403732;822.9670813167467;823.4688625836332;806.8023334283109;809.9676012959475;817.7546735979212;819.889314942484;820.3437250199846;663.9136912201432;833.3832963606917;843.8059246373307;856.7643897928089;857.4855086947844;845.0197770586121;851.2083762101244;853.2960307746104;853.4537895746727;853.7353420439683;618.2179542878263;621.1304174156218;624.9125122482856;625.0249610607467;625.2372106030635;11915.880841191563;11967.581134660331;11968.760624787456;11978.401079945968;11981.400929953556;12610.74778504434;12843;12863;12875.742485150338;13325.333733313393;9313.627454901864;9397.859032114524;9469.715908522756;9469.763255918588;9529.571169297398;2906.433245517125;2934.1637633274413;2955.497565413885;2988.417258634567;3020.7432368248724;47805.28292075622;48441.515584844055;49828.50171498275;49943.75028124872;49966.7501662493;9794.216462682969;9862.45756483386;9966;10019.849702254473;10431.426271554985;18363.17365718546;18371.26514939414;18377;18391.08044597765;18408.079596020147;5957.970210148921;6147.877042459126;6211.65835879022;6300.2754683212015;6437.420632143129;3594.4248920172645;3615.439606860888;3644.1254099016046;3660.194757153422;3725.1245957200035;2581.612758086302;2680.571108622611;2680.6515153030373;2682.8658567071957;2687.596860470906;477.49385651209826;504.56607317706744;557.1698169727077;557.8259702293934;568.0938902450584;541.442314416152;546.2516352596967;553.8670719027405;562.1511517608359;562.4083842725079;7471.813204669927;7512.5492470451945;7866.803329916798;7948.84102317962;8066.7579972600915;560.9130584759369;565.5306095940359;577.1112486770411;580.9419058094156;580.9651420914759;3742.8502859885843;3830.942535861964;3917;3920.5491368492417;3946.3685810270217;53636.46363536315;54261.72869135629;54782.45217547853;54876.45123548793;55167.72416137894;44275.778621106685;45481;46048;46147;46811.29783053257;41914.58085419168;41985;42066.57933420688;43105.56894431016;43178.568214317456;7815.882761758692;8022.59887005659;8142.918570814216;8159.551224682699;8298.460600060977;29181.7081829179;29332.266693332836;29793.702062979093;29883.70116298809;30399.69600304057;37537.43693844649;38269;38338.6166138335;38667.2266554673;43520.782396087816;11180.608678696206;11235.887641123483;11283;11436.656900293005;11536.942315288705;11429.828552571551;11647.126465514952;11766.941165294118;12132.575359862363;12485;10378.117859981685;10525.89474105249;10772.192085593768;10865.18511111654;10877.292975956538;9983.900160998297;10097.747556311151;10146.797064058825;10300.587976480856;10573.9471302643;9933.850992234979;11013.944930275296;11016.559337626406;11209.607663731731;11269.436528173395;9059.637614495346;9144.63421463134;9330.580123894577;9412.105849944244;9715.271354648288;9401.764955876159;9527.666531671635;9707;9826.5086745661;9857.654982075594 06:47:39 INFO - PROCESS | 3385 | __end_tp_report 06:47:39 INFO - PROCESS | 3385 | __start_cc_report 06:47:39 INFO - PROCESS | 3385 | _x_x_mozilla_cycle_collect,1229 06:47:39 INFO - PROCESS | 3385 | __end_cc_report 06:47:39 INFO - PROCESS | 3385 | __startTimestamp1461332859308__endTimestamp 06:47:39 INFO - PROCESS | 3385 | 06:47:39 INFO - PROCESS | 3385 | ------- Summary: start ------- 06:47:39 INFO - PROCESS | 3385 | Number of tests: 6 06:47:39 INFO - PROCESS | 3385 | 06:47:39 INFO - PROCESS | 3385 | [#0] dojo.html Cycles:165 Average:4578.71 Median:4720.74 stddev:460.30 (9.8%) stddev-sans-first:434.56 06:47:39 INFO - PROCESS | 3385 | Values: 2593.3 2652.8 2677.0 2692.0 2695.8 4480.5 4562.9 4627.1 4660.7 4698.2 4588.0 4612.8 4627.6 4658.8 4691.8 4226.9 4262.4 4283.9 4323.8 4413.4 4317.1 4337.7 4370.8 4382.9 4424.3 4121.2 4210.1 4227.4 4235.8 4315.1 4259.9 4264.4 4270.8 4272.4 4326.3 4266.3 4271.3 4272.7 4297.3 4311.0 4368.3 4437.5 4476.6 4552.1 4557.1 4939.0 4956.7 4957.5 4962.3 4984.7 4958.4 4963.4 4968.8 4974.5 4986.0 4451.9 4616.9 4692.0 4720.7 4723.3 5029.5 5032.1 5035.7 5037.4 5039.1 4665.7 4832.6 4833.0 4835.4 4866.4 4943.7 4992.7 5007.2 5053.4 5054.0 4825.6 4867.7 4867.8 4869.6 4908.5 4668.4 4767.4 4852.0 4910.0 4912.5 4188.7 4196.5 4238.6 4249.5 4256.3 3710.0 3720.2 3725.6 3728.2 3743.5 4159.8 4294.5 4308.2 4310.8 4346.2 4806.3 4839.4 4851.2 4889.9 4894.7 4248.6 4281.8 4288.2 4324.7 4334.4 4324.0 4484.7 4485.8 4488.5 4492.0 4745.6 4748.0 4748.0 4755.7 4799.7 4999.0 5003.2 5005.5 5006.0 5007.3 4566.3 4652.3 4706.4 4741.2 4771.9 4914.5 4920.5 4928.8 4931.3 4935.4 4972.9 5001.8 5007.7 5009.7 5029.6 4638.6 4710.1 4817.5 4844.7 4886.2 4809.2 4832.9 4846.4 4851.1 4911.0 4752.6 4784.7 4789.7 4791.6 4831.0 4641.9 4645.7 4742.5 4778.9 4855.3 4732.3 4776.4 4780.5 4781.7 4796.2 06:47:39 INFO - PROCESS | 3385 | 06:47:39 INFO - PROCESS | 3385 | [#1] ext.html Cycles:180 Average:45714.85 Median:187796.83 stddev:79985.31 (42.6%) stddev-sans-first:80137.83 06:47:39 INFO - PROCESS | 3385 | Values: 558.4 595.6 603.9 616.6 621.9 26071.3 26477.2 26536.6 26550.6 26552.5 26714.6 33568.5 34556.3 34569.0 34609.5 7584.8 7761.5 7771.7 7771.8 7773.9 7466.1 7562.4 7692.2 7695.0 7753.2 7520.3 7613.5 9799.9 10202.3 10206.3 9708.1 9833.9 9834.2 9835.1 9845.7 7424.9 9608.2 9727.8 9745.7 9747.4 33653.0 34856.0 34877.0 34887.0 34924.5 3139.4 3270.4 3282.7 3473.5 3716.9 27000.2 27783.3 29473.7 29701.4 29716.4 3237.6 3342.8 3369.4 3395.1 3477.1 234568.0 236490.0 236987.0 237010.0 237860.0 56916.0 57680.4 57683.4 57785.7 57795.7 61594.1 61873.0 62135.7 62397.8 62445.0 14000.5 14437.9 14473.8 14484.4 14485.0 10829.9 10887.7 10890.9 10898.2 10909.1 16488.3 18385.9 18542.4 19041.6 19370.0 6914.7 7231.7 7236.4 7239.0 7250.2 901.2 909.1 952.7 994.5 1012.2 24788.1 26433.5 26507.0 26808.9 28784.3 994.4 1004.1 1049.5 1063.5 1075.4 14638.3 15110.0 15155.0 15166.2 15404.1 333464.0 338690.0 341536.0 342774.0 343633.0 48310.8 48904.3 48938.0 49054.5 49097.0 1183.3 1220.6 1221.2 1222.9 1254.3 26226.9 27625.6 27874.6 27880.7 28131.3 42467.6 42601.8 43045.8 43061.6 43088.6 325133.0 325304.0 326832.0 327468.0 328013.0 29543.0 31330.5 37654.1 38226.0 38456.0 35733.1 38592.2 40368.8 41017.2 42643.8 33335.7 34505.3 34715.0 34778.7 35126.6 33571.3 33928.8 33950.5 34057.7 34213.5 34758.8 34804.0 35146.0 35575.3 37186.1 29827.4 30990.8 31566.8 31707.2 31796.0 24232.8 24268.2 24471.6 25016.9 25082.4 06:47:39 INFO - PROCESS | 3385 | 06:47:39 INFO - PROCESS | 3385 | [#2] jquery.html Cycles:180 Average:23526.20 Median:25178.71 stddev:62464.21 (248.1%) stddev-sans-first:62615.23 06:47:39 INFO - PROCESS | 3385 | Values: 365.5 383.7 384.8 389.9 394.8 12308.4 15578.1 15884.5 16564.4 16583.3 14826.8 15324.5 15728.5 16195.8 16286.2 4852.7 5054.1 5181.6 5199.3 5223.8 5108.3 5114.4 5128.9 5139.0 5148.5 5037.7 5072.6 5101.0 5110.6 5111.1 4969.1 5091.2 5092.0 5107.2 5131.3 4440.4 4488.3 4560.9 4577.7 4587.0 19593.4 19803.9 19943.9 20121.7 20308.7 1756.5 1873.4 1914.5 1966.1 1987.5 8702.2 9036.5 9116.5 9414.2 9431.6 1705.5 1720.3 1722.7 1742.2 1769.7 66021.3 68282.7 68308.3 68460.7 70467.3 8966.9 9348.2 10077.6 10134.7 10154.0 12652.4 13479.0 13506.7 13516.4 13525.3 6949.9 7047.7 7181.6 7202.6 7203.1 6692.2 6702.7 6705.7 6823.8 6831.0 4264.8 4268.8 4289.8 4318.3 4358.3 1800.2 1817.2 1851.3 1854.9 1875.5 862.2 939.1 940.8 956.1 965.0 15844.2 16424.6 16594.9 16839.4 16968.3 825.1 848.4 881.5 911.0 945.3 8992.9 9248.3 9288.3 9327.0 9653.1 364946.0 374206.0 381341.0 383465.1 384827.0 77829.0 77860.2 78662.0 79467.0 81857.2 934.4 949.5 951.6 965.7 967.9 14440.9 14498.5 14539.6 14551.2 15105.5 30669.8 31163.2 33794.5 33932.8 34985.0 44874.8 45779.8 45999.3 46014.8 46211.0 7727.1 7799.9 7858.1 8075.4 8125.4 11827.2 11958.0 11972.3 12229.6 12448.8 9566.3 10466.4 10738.0 10789.8 10953.6 5187.9 8273.2 10369.0 10600.2 11033.7 10306.5 10551.5 10782.6 11096.2 11223.8 7801.0 7958.9 8010.3 8011.8 8108.7 7592.7 9013.7 9850.9 9869.3 10092.1 06:47:39 INFO - PROCESS | 3385 | 06:47:39 INFO - PROCESS | 3385 | [#3] mootools.html Cycles:180 Average:5161.25 Median:5415.70 stddev:2822.79 (52.1%) stddev-sans-first:2815.69 06:47:39 INFO - PROCESS | 3385 | Values: 1286.7 1423.3 1448.3 1562.5 1755.7 7521.6 7853.1 7862.0 7873.8 7885.8 7638.5 7777.6 7789.2 7793.5 7797.6 1889.4 2129.5 2231.2 2257.8 2260.2 2239.3 2263.0 2263.1 2264.8 2267.6 2193.3 2241.0 2242.3 2246.2 2247.0 1841.2 2131.9 2225.0 2226.4 2229.0 2137.1 2151.9 2159.6 2159.9 2182.3 7603.3 7682.7 7705.1 7706.7 7715.9 4427.8 4613.2 4624.4 4625.8 4657.8 2991.4 3016.5 3048.8 3055.7 3079.5 956.7 1677.4 1703.5 1722.4 1723.5 10333.7 10433.7 10442.7 10464.8 10475.0 3964.8 4073.1 4099.3 4130.2 4161.3 8314.1 8340.5 8348.1 8358.8 8547.7 4015.3 4711.1 4711.3 4715.7 4729.6 4187.3 4265.8 4325.4 4325.5 4334.9 3456.1 3486.8 3544.1 3572.6 3605.2 1087.5 1089.9 1093.8 1100.8 1105.5 721.4 737.8 806.9 893.9 906.0 5477.2 5558.3 5628.9 5760.9 5812.5 883.7 913.7 915.5 919.7 923.5 3542.2 3622.7 3725.7 3832.2 3854.3 9348.6 9768.5 9813.2 9844.0 9847.4 9600.9 9649.6 9667.7 9695.3 9750.9 7058.9 7080.2 7126.8 7138.7 7196.1 5222.3 5361.3 5470.1 5518.2 5597.2 8939.9 8977.7 9090.5 9201.1 9207.1 8793.7 9170.6 9184.4 9306.2 9306.6 5822.1 6051.1 6059.4 6405.2 6587.7 6439.5 7527.1 7595.7 7601.8 7610.4 6710.9 6774.5 6791.0 6910.4 7049.1 6737.4 6820.1 6915.4 6984.7 7044.5 6413.2 6419.3 6436.6 6460.3 6482.8 4568.3 4759.8 4822.6 4841.4 4850.7 4747.7 4749.5 4751.2 4804.0 4870.4 06:47:39 INFO - PROCESS | 3385 | 06:47:39 INFO - PROCESS | 3385 | [#4] prototype.html Cycles:180 Average:4379.12 Median:5032.69 stddev:1257.89 (25.0%) stddev-sans-first:1223.80 06:47:39 INFO - PROCESS | 3385 | Values: 311.3 314.4 321.7 323.7 324.4 5030.8 5074.2 5094.4 5094.7 5099.4 4695.8 4794.6 4942.1 5000.4 5034.5 3979.6 4018.9 4019.5 4021.9 4023.9 4016.4 4017.0 4027.6 4028.2 4034.6 3744.6 3836.7 3982.7 3984.1 4002.7 3965.6 3967.3 3985.1 4000.8 4001.8 3545.5 3549.3 3549.9 3551.4 3555.3 4725.6 4788.9 4852.9 4857.0 4878.7 4484.6 4523.5 4526.5 4529.6 4545.4 5244.7 5275.3 5282.0 5282.2 5285.8 3704.6 3835.0 3838.4 3841.4 3842.0 5495.8 5497.8 5515.7 5525.4 5530.2 3912.6 3915.5 3917.9 3919.6 3920.8 3955.7 3979.2 3986.4 3986.8 3996.9 4165.9 4365.4 4420.5 4436.2 4453.6 5283.7 5299.2 5301.7 5308.2 5312.2 1256.4 1292.4 1342.4 1353.5 1357.7 888.4 899.7 907.6 910.1 911.4 4605.2 4620.2 4631.6 4633.6 4636.4 5364.7 5383.5 5388.2 5389.0 5391.3 4552.9 4629.3 4634.9 4636.7 4639.0 2803.6 2884.1 2889.9 2893.3 2893.9 5055.0 5069.8 5071.5 5077.3 5089.7 5320.9 5477.5 5524.4 5529.3 5531.4 5075.1 5076.8 5077.1 5083.9 5095.3 5369.8 5373.7 5377.5 5377.7 5378.5 5028.2 5268.2 5268.8 5271.6 5291.6 5044.7 5067.9 5078.9 5097.5 5104.8 3776.1 3801.4 3807.6 3811.7 3819.6 5179.7 5247.6 5352.4 5354.7 5385.8 5130.3 5293.2 5327.2 5331.5 5335.7 5232.6 5241.8 5268.5 5269.9 5276.7 5078.7 5159.1 5177.0 5184.8 5185.5 5304.3 5311.7 5315.9 5336.3 5338.4 5189.2 5196.3 5199.3 5215.4 5216.0 06:47:39 INFO - PROCESS | 3385 | 06:47:39 INFO - PROCESS | 3385 | [#5] yui.html Cycles:180 Average:12832.45 Median:24141.39 stddev:14850.25 (61.5%) stddev-sans-first:14863.46 06:47:39 INFO - PROCESS | 3385 | Values: 591.6 615.2 653.4 660.7 693.9 11350.7 11681.2 11683.9 11720.1 11734.5 10841.1 11311.7 11329.5 11378.9 11416.1 787.7 821.4 822.5 823.0 823.5 806.8 810.0 817.8 819.9 820.3 663.9 833.4 843.8 856.8 857.5 845.0 851.2 853.3 853.5 853.7 618.2 621.1 624.9 625.0 625.2 11915.9 11967.6 11968.8 11978.4 11981.4 12610.7 12843.0 12863.0 12875.7 13325.3 9313.6 9397.9 9469.7 9469.8 9529.6 2906.4 2934.2 2955.5 2988.4 3020.7 47805.3 48441.5 49828.5 49943.8 49966.8 9794.2 9862.5 9966.0 10019.8 10431.4 18363.2 18371.3 18377.0 18391.1 18408.1 5958.0 6147.9 6211.7 6300.3 6437.4 3594.4 3615.4 3644.1 3660.2 3725.1 2581.6 2680.6 2680.7 2682.9 2687.6 477.5 504.6 557.2 557.8 568.1 541.4 546.3 553.9 562.2 562.4 7471.8 7512.5 7866.8 7948.8 8066.8 560.9 565.5 577.1 580.9 581.0 3742.9 3830.9 3917.0 3920.5 3946.4 53636.5 54261.7 54782.5 54876.5 55167.7 44275.8 45481.0 46048.0 46147.0 46811.3 41914.6 41985.0 42066.6 43105.6 43178.6 7815.9 8022.6 8142.9 8159.6 8298.5 29181.7 29332.3 29793.7 29883.7 30399.7 37537.4 38269.0 38338.6 38667.2 43520.8 11180.6 11235.9 11283.0 11436.7 11536.9 11429.8 11647.1 11766.9 12132.6 12485.0 10378.1 10525.9 10772.2 10865.2 10877.3 9983.9 10097.7 10146.8 10300.6 10573.9 9933.9 11013.9 11016.6 11209.6 11269.4 9059.6 9144.6 9330.6 9412.1 9715.3 9401.8 9527.7 9707.0 9826.5 9857.7 06:47:39 INFO - PROCESS | 3385 | -------- Summary: end -------- 06:47:39 INFO - PROCESS | 3385 | 06:47:40 INFO - TEST-INFO | 3385: exit 0 06:47:40 INFO - TEST-OK | dromaeo_css | took 1120617ms 06:47:40 INFO - TEST-START | kraken 06:47:40 INFO - operating with platform_type : linux_ 06:47:40 INFO - Initialising browser for kraken test... 06:47:40 INFO - TEST-INFO | started process 3593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQYQqnH/profile http://localhost:35933/getInfo.html) 06:47:44 INFO - PROCESS | 3593 | __metrics Screen width/height:1600/1200 06:47:44 INFO - PROCESS | 3593 | colorDepth:24 06:47:44 INFO - PROCESS | 3593 | Browser inner width/height: 1024/697 06:47:44 INFO - PROCESS | 3593 | __metrics 06:47:45 ERROR - PROCESS | 3593 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:47:46 INFO - TEST-INFO | 3593: exit 0 06:47:46 INFO - Browser initialized. 06:47:46 INFO - Running cycle 1/1 for kraken test... 06:47:46 INFO - TEST-INFO | started process 3673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQYQqnH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:58 INFO - PROCESS | 3673 | RSS: Main: 155287552 06:47:58 INFO - PROCESS | 3673 | 06:48:01 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35933/tests/kraken/driver.html?testName=audio-beat-detection) 06:48:02 INFO - PROCESS | 3673 | RSS: Main: 209649664 06:48:02 INFO - PROCESS | 3673 | 06:48:04 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35933/tests/kraken/driver.html?testName=audio-dft) 06:48:05 INFO - PROCESS | 3673 | RSS: Main: 195084288 06:48:05 INFO - PROCESS | 3673 | 06:48:08 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35933/tests/kraken/driver.html?testName=audio-fft) 06:48:09 INFO - PROCESS | 3673 | RSS: Main: 266452992 06:48:09 INFO - PROCESS | 3673 | 06:48:11 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35933/tests/kraken/driver.html?testName=audio-oscillator) 06:48:12 INFO - PROCESS | 3673 | RSS: Main: 174555136 06:48:12 INFO - PROCESS | 3673 | 06:48:14 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:48:14 INFO - PROCESS | 3673 | RSS: Main: 179646464 06:48:14 INFO - PROCESS | 3673 | 06:48:18 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35933/tests/kraken/driver.html?testName=imaging-darkroom) 06:48:18 INFO - PROCESS | 3673 | RSS: Main: 214523904 06:48:18 INFO - PROCESS | 3673 | 06:48:22 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35933/tests/kraken/driver.html?testName=imaging-desaturate) 06:48:22 INFO - PROCESS | 3673 | RSS: Main: 212508672 06:48:22 INFO - PROCESS | 3673 | 06:48:25 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35933/tests/kraken/driver.html?testName=json-parse-financial) 06:48:26 INFO - PROCESS | 3673 | RSS: Main: 214323200 06:48:26 INFO - PROCESS | 3673 | 06:48:27 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:48:28 INFO - PROCESS | 3673 | RSS: Main: 202960896 06:48:28 INFO - PROCESS | 3673 | 06:48:30 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35933/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:48:31 INFO - PROCESS | 3673 | RSS: Main: 204320768 06:48:31 INFO - PROCESS | 3673 | 06:48:33 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:48:34 INFO - PROCESS | 3673 | RSS: Main: 219459584 06:48:34 INFO - PROCESS | 3673 | 06:48:36 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:48:37 INFO - PROCESS | 3673 | RSS: Main: 223789056 06:48:37 INFO - PROCESS | 3673 | 06:48:40 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:48:41 INFO - PROCESS | 3673 | RSS: Main: 216940544 06:48:41 INFO - PROCESS | 3673 | 06:48:42 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:35933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35933/tests/kraken/driver.html?testName=ai-astar) 06:48:43 INFO - PROCESS | 3673 | RSS: Main: 280584192 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | __start_tp_report 06:48:43 INFO - PROCESS | 3673 | _x_x_mozilla_page_load 06:48:43 INFO - PROCESS | 3673 | _x_x_mozilla_page_load_details 06:48:43 INFO - PROCESS | 3673 | |i|pagename|runs| 06:48:43 INFO - PROCESS | 3673 | |0;ai-astar;111;114;107;112;113;113;101;110;112;112 06:48:43 INFO - PROCESS | 3673 | |1;audio-beat-detection;163;131;154;183;140;160;167;131;182;141 06:48:43 INFO - PROCESS | 3673 | |2;audio-dft;161;160;161;162;159;161;161;161;159;163 06:48:43 INFO - PROCESS | 3673 | |3;audio-fft;73;77;102;116;85;74;77;113;105;74 06:48:43 INFO - PROCESS | 3673 | |4;audio-oscillator;94;94;146;94;93;93;145;94;93;144 06:48:43 INFO - PROCESS | 3673 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;116;117;116 06:48:43 INFO - PROCESS | 3673 | |6;imaging-darkroom;146;145;148;146;146;146;147;146;146;148 06:48:43 INFO - PROCESS | 3673 | |7;imaging-desaturate;95;95;94;95;95;94;95;95;94;94 06:48:43 INFO - PROCESS | 3673 | |8;json-parse-financial;64;66;65;64;66;65;65;80;64;63 06:48:43 INFO - PROCESS | 3673 | |9;json-stringify-tinderbox;66;66;70;65;66;69;64;64;65;65 06:48:43 INFO - PROCESS | 3673 | |10;stanford-crypto-aes;77;77;79;78;87;78;80;79;79;82 06:48:43 INFO - PROCESS | 3673 | |11;stanford-crypto-ccm;134;143;132;137;131;136;145;130;163;140 06:48:43 INFO - PROCESS | 3673 | |12;stanford-crypto-pbkdf2;172;177;183;178;171;170;175;175;170;169 06:48:43 INFO - PROCESS | 3673 | |13;stanford-crypto-sha256-iterative;74;72;71;73;73;72;72;72;70;71 06:48:43 INFO - PROCESS | 3673 | __end_tp_report 06:48:43 INFO - PROCESS | 3673 | __start_cc_report 06:48:43 INFO - PROCESS | 3673 | _x_x_mozilla_cycle_collect,1909 06:48:43 INFO - PROCESS | 3673 | __end_cc_report 06:48:43 INFO - PROCESS | 3673 | __startTimestamp1461332923104__endTimestamp 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | ------- Summary: start ------- 06:48:43 INFO - PROCESS | 3673 | Number of tests: 14 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.87 (3.5%) stddev-sans-first:4.10 06:48:43 INFO - PROCESS | 3673 | Values: 111.0 114.0 107.0 112.0 113.0 113.0 101.0 110.0 112.0 112.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:161.50 stddev:19.21 (11.9%) stddev-sans-first:20.16 06:48:43 INFO - PROCESS | 3673 | Values: 163.0 131.0 154.0 183.0 140.0 160.0 167.0 131.0 182.0 141.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 06:48:43 INFO - PROCESS | 3673 | Values: 161.0 160.0 161.0 162.0 159.0 161.0 161.0 161.0 159.0 163.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#3] audio-fft Cycles:10 Average:89.60 Median:74.00 stddev:17.44 (23.6%) stddev-sans-first:17.43 06:48:43 INFO - PROCESS | 3673 | Values: 73.0 77.0 102.0 116.0 85.0 74.0 77.0 113.0 105.0 74.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.50 stddev:24.85 (26.6%) stddev-sans-first:25.76 06:48:43 INFO - PROCESS | 3673 | Values: 94.0 94.0 146.0 94.0 93.0 93.0 145.0 94.0 93.0 144.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:48:43 INFO - PROCESS | 3673 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 06:48:43 INFO - PROCESS | 3673 | Values: 146.0 145.0 148.0 146.0 146.0 146.0 147.0 146.0 146.0 148.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:48:43 INFO - PROCESS | 3673 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:65.00 stddev:4.94 (7.6%) stddev-sans-first:5.17 06:48:43 INFO - PROCESS | 3673 | Values: 64.0 66.0 65.0 64.0 66.0 65.0 65.0 80.0 64.0 63.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:2.00 (3.0%) stddev-sans-first:2.12 06:48:43 INFO - PROCESS | 3673 | Values: 66.0 66.0 70.0 65.0 66.0 69.0 64.0 64.0 65.0 65.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.99 (3.8%) stddev-sans-first:3.02 06:48:43 INFO - PROCESS | 3673 | Values: 77.0 77.0 79.0 78.0 87.0 78.0 80.0 79.0 79.0 82.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:138.50 stddev:9.78 (7.1%) stddev-sans-first:10.20 06:48:43 INFO - PROCESS | 3673 | Values: 134.0 143.0 132.0 137.0 131.0 136.0 145.0 130.0 163.0 140.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:175.00 stddev:4.45 (2.5%) stddev-sans-first:4.66 06:48:43 INFO - PROCESS | 3673 | Values: 172.0 177.0 183.0 178.0 171.0 170.0 175.0 175.0 170.0 169.0 06:48:43 INFO - PROCESS | 3673 | 06:48:43 INFO - PROCESS | 3673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.15 (1.6%) stddev-sans-first:0.97 06:48:43 INFO - PROCESS | 3673 | Values: 74.0 72.0 71.0 73.0 73.0 72.0 72.0 72.0 70.0 71.0 06:48:43 INFO - PROCESS | 3673 | -------- Summary: end -------- 06:48:43 INFO - PROCESS | 3673 | 06:48:44 INFO - TEST-INFO | 3673: exit 0 06:48:44 INFO - TEST-OK | kraken | took 64049ms 06:48:44 INFO - SUITE-END | took 1184s 06:48:44 INFO - Completed test suite (00:19:44) 06:48:44 INFO - javascript benchmark 06:48:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.286846117318, 2652.814302998791, 2676.9866150669245, 2691.9596206056913, 2695.8382497050166, 4480.462344518663, 4562.885927851806, 4627.07458508298, 4660.697054691447, 4698.201305778018, 4587.954120458794, 4612.769361531927, 4627.5603817637275, 4658.836940707076, 4691.835785747499, 4226.873193804191, 4262.445882035338, 4283.87148385549, 4323.783810809463, 4413.360062790894, 4317.13657268546, 4337.652987760972, 4370.825166993316, 4382.868513944571, 4424.336349547578, 4121.196366708493, 4210.136921930997, 4227.408162857202, 4235.767032813194, 4315.072259464199, 4259.936100958488, 4264.381664658638, 4270.7864606769535, 4272.359146128075, 4326.264535029021, 4266.338717498793, 4271.316589345721, 4272.658187345036, 4297.290946993742, 4310.978445107754, 4368.344748287782, 4437.511873693891, 4476.574725401082, 4552.066826300634, 4557.088582283556, 4939.0, 4956.653034287601, 4957.479464656195, 4962.280469331927, 4984.700917944899, 4958.355413796219, 4963.404391473046, 4968.801247950078, 4974.502549745032, 4986.0, 4451.9332210016555, 4616.884577885579, 4691.9530804692195, 4720.740359280273, 4723.315119307681, 5029.471905449948, 5032.069067222503, 5035.723035233024, 5037.4458809530925, 5039.0929632666475, 4665.6734028617675, 4832.613390928787, 4833.0, 4835.419749629997, 4866.367372241657, 4943.678660887031, 4992.700437973734, 5007.24891266313, 5053.444121146671, 5053.9747301264, 4825.613950883921, 4867.66139311685, 4867.756612169377, 4869.63477739171, 4908.533689299511, 4668.3697700810635, 4767.427908650984, 4852.0, 4909.968906529597, 4912.508749125131, 4188.68584856137, 4196.538380778112, 4238.6397156242065, 4249.511306199826, 4256.2551553478015, 3710.0, 3720.2001569662652, 3725.6088110748524, 3728.217074414349, 3743.457198706227, 4159.771212583337, 4294.506131794884, 4308.224519586442, 4310.762908040025, 4346.174226896943, 4806.327114204014, 4839.395075615548, 4851.175300198975, 4889.877753056131, 4894.730789806524, 4248.553901840324, 4281.764502952367, 4288.2066817638215, 4324.718893271927, 4334.41485399467, 4324.0, 4484.663650226246, 4485.820567177277, 4488.506264310923, 4492.034212644297, 4745.572898439157, 4747.976260118747, 4748.026654535881, 4755.667103302736, 4799.688020278671, 4998.975005124951, 5003.174476211384, 5005.524475174852, 5005.974970125126, 5007.3240112584335, 4566.26939689648, 4652.348671185969, 4706.388169537938, 4741.193997020584, 4771.904561908812, 4914.459409464885, 4920.532549407801, 4928.802847886044, 4931.260310953386, 4935.383077115361, 4972.8508144755715, 5001.849944501525, 5007.674501157413, 5009.674371165863, 5029.572486338702, 4638.582527572535, 4710.081534100817, 4817.494163112963, 4844.709317440965, 4886.242632391985, 4809.2305231162845, 4832.927506087482, 4846.418429788448, 4851.102546028996, 4910.975445122752, 4752.572268495852, 4784.688995215439, 4789.688670236424, 4791.6406269529225, 4831.033793241296, 4641.86074417768, 4645.6980296280635, 4742.478327383916, 4778.904421911612, 4855.271709243641, 4732.290156476556, 4776.355192049168, 4780.521947805191, 4781.713097214179, 4796.160671882476], "value": 4550.894284782972, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.4387690371179, 595.603923390945, 603.879224155169, 616.5560796226721, 621.8973869311562, 26071.348216294602, 26477.205683829492, 26536.60195097075, 26550.6017409739, 26552.468950620976, 26714.599281010753, 33568.49647255293, 34556.308873822505, 34569.0, 34609.48085778715, 7584.810379740496, 7761.495502792301, 7771.650275737577, 7771.766846994599, 7773.883391749128, 7466.104067511907, 7562.395008399315, 7692.230776922291, 7694.961525192366, 7753.185915478878, 7520.323170914617, 7613.467057305991, 9799.853002204973, 10202.285839991204, 10206.336588121785, 9708.126268635822, 9833.901660983442, 9834.164096051773, 9835.065668761456, 9845.704628861109, 7424.85150296991, 9608.183304419133, 9727.805443891153, 9745.707628771148, 9747.3664211826, 33652.99041028773, 34856.0, 34877.0, 34887.0, 34924.47613285803, 3139.4192074466296, 3270.3622793555264, 3282.7045565898943, 3473.513708080871, 3716.9256614867822, 27000.189994300203, 27783.305417364525, 29473.70526294731, 29701.405971880442, 29716.405671886656, 3237.6114866216203, 3342.8495717692763, 3369.4271973764276, 3395.066356751888, 3477.113336099304, 234568.0, 236490.0, 236987.0, 237010.0, 237860.0, 56916.0, 57680.423195768344, 57683.42316576865, 57785.71107144438, 57795.71102144462, 61594.0760888587, 61873.0, 62135.689321554004, 62397.76022397724, 62445.0, 14000.50998215078, 14437.927810360881, 14473.78289325661, 14484.420623175165, 14485.0, 10829.891701082888, 10887.727806804734, 10890.891091088988, 10898.18263630215, 10909.07272881798, 16488.25802838875, 18385.92262977763, 18542.351017714314, 19041.61916761657, 19370.0, 6914.688839002257, 7231.674574644154, 7236.38490728294, 7238.963805180941, 7250.2024777274455, 901.2384535067857, 909.0591238068567, 952.7379970508166, 994.4828689081637, 1012.2458768217725, 24788.132415365737, 26433.47133057328, 26506.958250497017, 26808.8659556701, 28784.280392990342, 994.433173091331, 1004.1013293102632, 1049.4700176410863, 1063.4629512096496, 1075.3709080188178, 14638.341274642667, 15110.0, 15155.0, 15166.165860877758, 15404.075755454709, 333464.0, 338690.0, 341536.0, 342774.0, 343633.0, 48310.75844620755, 48904.26643600349, 48938.0, 49054.50945490571, 49097.0, 1183.260606907844, 1220.558882235529, 1221.2245224282467, 1222.9205101668363, 1254.2850575172065, 26226.86886565555, 27625.585616215372, 27874.581881272203, 27880.721192787812, 28131.296717582223, 42467.5753242476, 42601.786991064844, 43045.784771075945, 43061.56938430575, 43088.569114308455, 325133.0, 325304.0, 326832.0, 327468.0, 328013.0, 29543.0, 31330.530042048933, 37654.058648534, 38226.0, 38456.0, 35733.1066723334, 38592.2281554373, 40368.798156009034, 41017.1796564073, 42643.78678106589, 33335.666643334225, 34505.309893802485, 34715.0, 34778.652213477544, 35126.64873351234, 33571.328573427905, 33928.83035584806, 33950.49074263839, 34057.65942340545, 34213.486797698555, 34758.82620586881, 34804.0, 35146.0, 35575.288494229455, 37186.07034824151, 29827.403451931274, 30990.845045774626, 31566.842165789025, 31707.20731981719, 31796.0, 24232.75767242305, 24268.150614728398, 24471.60847824292, 25016.874915625307, 25082.37294067663], "value": 17600.60577986329, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.5138665574786, 383.7390574409402, 384.7883663984808, 389.89464867101765, 394.82430318508256, 12308.384580770959, 15578.143202123878, 15884.52346429606, 16564.420245291418, 16583.258757830434, 14826.777598336006, 15324.540263792076, 15728.528144155665, 16195.83804161958, 16286.185690715476, 4852.665516982823, 5054.064997975377, 5181.6113791465605, 5199.298094757197, 5223.791048358061, 5108.310378098946, 5114.360704911886, 5128.871778205537, 5139.0, 5148.485151484841, 5037.672551284173, 5072.644914855961, 5101.0, 5110.616703747234, 5111.105556527611, 4969.080720066781, 5091.185410334366, 5092.032513822381, 5107.1828507439, 5131.332926719521, 4440.400545926291, 4488.349189367524, 4560.8859778505475, 4577.656675749332, 4587.0, 19593.412197634094, 19803.900980495004, 19943.90028049865, 20121.698174527395, 20308.69536956932, 1756.5345183526376, 1873.3536929759348, 1914.5309399197286, 1966.1447270437407, 1987.5329297615049, 8702.173293537104, 9036.50299233542, 9116.498592577405, 9414.246860251164, 9431.575579098888, 1705.4968784208688, 1720.3032771727471, 1722.7071397862394, 1742.198588649223, 1769.6637638848706, 66021.339786602, 68282.65858670724, 68308.31691683119, 68460.6576967117, 70467.2953270471, 8966.910330896739, 9348.20540254086, 10077.596896124072, 10134.695959121238, 10154.0, 12652.367381630882, 13479.0, 13506.729865402636, 13516.391762370717, 13525.256110913797, 6949.89575156373, 7047.68285427157, 7181.569105853561, 7202.567845929261, 7203.063601731741, 6692.230393504809, 6702.664866756642, 6705.6982435790505, 6823.795286141423, 6830.965845170842, 4264.808083636244, 4268.786560671954, 4289.785510724451, 4318.330658747899, 4358.280883654225, 1800.198911484403, 1817.2095138614745, 1851.3242666426656, 1854.9165287562091, 1875.4561177258715, 862.2067697717989, 939.145377706284, 940.844760614491, 956.1346980982222, 964.9855252171224, 15844.207789610704, 16424.589385265226, 16594.917025414794, 16839.410620628463, 16968.321267149422, 825.1310781080857, 848.3891598049395, 881.5460038080394, 911.0034931724421, 945.3099237556485, 8992.8651070234, 9248.26013918885, 9288.303377246733, 9326.95336523313, 9653.082957119062, 364946.0, 374206.0, 381341.0, 383465.0826745848, 384827.0, 77829.0, 77860.22139778643, 78662.0, 79467.0, 81857.18142818495, 934.4486752815872, 949.4635530924867, 951.5908159491485, 965.710286913923, 967.8790151231096, 14440.855591443951, 14498.492552760603, 14539.636509087357, 14551.19893891278, 15105.47130850415, 30669.8466507666, 31163.220919476287, 33794.49308260329, 33932.830335848164, 34985.0, 44874.775626121664, 45779.77110114428, 45999.31001035054, 46014.769926150155, 46211.0, 7727.11138219112, 7799.9220007799195, 7858.0570331560575, 8075.434719569574, 8125.390595705464, 11827.231229970024, 11958.0, 11972.281663100242, 12229.571964981538, 12448.813267801172, 9566.282528810229, 10466.372017678963, 10738.033576978109, 10789.784204316027, 10953.56185752561, 5187.896242075062, 8273.214044665747, 10369.0, 10600.151987841109, 11033.724156896142, 10306.48467576633, 10551.525181366704, 10782.568697252022, 11096.167787415814, 11223.775524489627, 7801.024871891013, 7958.880616790869, 8010.279074883289, 8011.799705007422, 8108.675652973815, 7592.696292148252, 9013.729588112366, 9850.852237216304, 9869.25980551476, 10092.14216791581], "value": 8007.038677924981, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.7040580666453, 1423.3310344138251, 1448.3265281644035, 1562.4921900382378, 1755.7263343969557, 7521.623918804058, 7853.096893857201, 7861.960690196541, 7873.842523149548, 7885.763427097197, 7638.54168749874, 7777.572233527154, 7789.182135875736, 7793.493422927506, 7797.610119494031, 1889.3859495663896, 2129.4676330917273, 2231.241377931503, 2257.762934891829, 2260.2315212827634, 2239.261043855532, 2262.954740905181, 2263.106073101124, 2264.8074913632363, 2267.6031694453404, 2193.2981445937307, 2241.0139538603044, 2242.2936774915847, 2246.168917500527, 2247.0337754765446, 1841.2174825699092, 2131.8507704460694, 2225.0, 2226.4100013496436, 2229.041512149775, 2137.10241698487, 2151.9462013449634, 2159.6436587962967, 2159.8704077755383, 2182.34529641107, 7603.2776886195725, 7682.654280557388, 7705.075390953066, 7706.653200605986, 7715.884261736079, 4427.800748966304, 4613.1696294666945, 4624.352590637313, 4625.791839367236, 4657.767111644438, 2991.3867657130454, 3016.502277124272, 3048.786584939055, 3055.679153688875, 3079.4610943085095, 956.6699488676395, 1677.3877534699868, 1703.4548944337816, 1722.431597572798, 1723.5346456456812, 10333.689989300334, 10433.739156521071, 10442.738931526697, 10464.790704185874, 10475.0, 3964.7621142731527, 4073.103917138284, 4099.323611604052, 4130.153318569686, 4161.25097482456, 8314.127016663164, 8340.499570025819, 8348.081711011784, 8358.791030224293, 8547.700830470903, 4015.2772500949527, 4711.104890070944, 4711.316859055418, 4715.669903106818, 4729.574338309569, 4187.330027195634, 4265.786710664454, 4325.394444777734, 4325.4593175853015, 4334.869953901325, 3456.1186897341017, 3486.825658717054, 3544.149404142987, 3572.624874388204, 3605.170810713498, 1087.456271864068, 1089.9073578745738, 1093.8085834978847, 1100.834874768791, 1105.5135740274254, 721.3579913876654, 737.8007937856856, 806.9475484093515, 893.883795106632, 906.0214967834722, 5477.20580515823, 5558.305211848519, 5628.887422251532, 5760.913586296209, 5812.534997200214, 883.7097837157693, 913.7304495173939, 915.5239275576663, 919.7102912582515, 923.5105394141116, 3542.1852973815653, 3622.673959343672, 3725.701943844486, 3832.156925476391, 3854.2869569129803, 9348.626054957726, 9768.462734549526, 9813.16588090006, 9843.950780246196, 9847.359921605215, 9600.903990960142, 9649.614015439303, 9667.661631842851, 9695.272854535797, 9750.90249097514, 7058.9294107059295, 7080.185778635523, 7126.821829454201, 7138.714451421989, 7196.0645116134565, 5222.294990176278, 5361.329833770778, 5470.070088084955, 5518.199861020049, 5597.160425936142, 8939.865902011345, 8977.685780997634, 9090.545472726206, 9201.125893040151, 9207.079292070739, 8793.736187914374, 9170.587323570322, 9184.403013804082, 9306.162445379949, 9306.627734890799, 5822.126680997884, 6051.122587224916, 6059.3637668045985, 6405.167328247298, 6587.736490540325, 6439.45264652491, 7527.059117610299, 7595.696172153052, 7601.809954751176, 7610.353119984863, 6710.899336509859, 6774.458043356618, 6791.0, 6910.412614927787, 7049.083619129686, 6737.393634572912, 6820.113385259884, 6915.446764258747, 6984.7206111757, 7044.542104763174, 6413.198350206224, 6419.325970773001, 6436.613803171825, 6460.25707043696, 6482.805515834532, 4568.269076947672, 4759.833405830779, 4822.590079843252, 4841.419029716316, 4850.684705494132, 4747.715137091785, 4749.477557468745, 4751.216049351819, 4803.951960480351, 4870.439899411613], "value": 4212.739900682366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.30889425475436, 314.4026349935123, 321.68796267620405, 323.6795572383341, 324.388527625426, 5030.823921162755, 5074.188129899217, 5094.439611642716, 5094.7197904115255, 5099.4390617032095, 4695.765211739416, 4794.640401969848, 4942.135126352892, 5000.399952005755, 5034.5468907798295, 3979.602039796012, 4018.9196216075807, 4019.4677353267402, 4021.8592349267783, 4023.879283621496, 4016.3975403689533, 4017.0, 4027.5771044040393, 4028.154087641599, 4034.5561988181275, 3744.6068162842917, 3836.6547010769027, 3982.721209515335, 3984.1434091670285, 4002.7198096133284, 3965.643092121694, 3967.305721498726, 3985.143194213258, 4000.7999600019884, 4001.779902105383, 3545.503629491873, 3549.343371476259, 3549.94675079874, 3551.4317709166667, 3555.253396786678, 4725.64557658177, 4788.856334309941, 4852.927206091911, 4856.951430485685, 4878.658493905428, 4484.573965473275, 4523.457185137771, 4526.456825181, 4529.637628989706, 4545.38637283969, 5244.711540865251, 5275.26146339509, 5282.0, 5282.2076688496645, 5285.7621407036395, 3704.555453345589, 3835.0, 3838.4434257032854, 3841.4429907663234, 3842.0010797192654, 5495.752691128909, 5497.780088796443, 5515.696636684981, 5525.364583072957, 5530.170474428827, 3912.628300311466, 3915.5105611798526, 3917.9020524487114, 3919.5884432134785, 3920.8039598019986, 3955.7033222508426, 3979.2041591681777, 3986.402039694011, 3986.820593073319, 3996.900077498086, 4165.875023749292, 4365.432493775789, 4420.535843736426, 4436.223660859337, 4453.55464453552, 5283.682979021271, 5299.205119232146, 5301.66726640277, 5308.150695888639, 5312.1766126250495, 1256.3655354046148, 1292.38611659461, 1342.4026308292716, 1353.4856754433251, 1357.7148798752373, 888.4003297773977, 899.6536333511646, 907.5961197267285, 910.1171863292728, 911.4349103555838, 4605.194091034055, 4620.214563524209, 4631.606313463326, 4633.559811817872, 4636.397268355092, 5364.678119312854, 5383.515483606494, 5388.191771234347, 5389.0, 5391.272178255886, 4552.863414097583, 4629.328747331618, 4634.86095417138, 4636.678546614199, 4638.95361046392, 2803.649543807024, 2884.1059271625863, 2889.9277518061795, 2893.348996475776, 2893.8697758600915, 5054.974725126424, 5069.847904562869, 5071.518205770446, 5077.339945807022, 5089.67668406217, 5320.893582128413, 5477.534409575151, 5524.392316845144, 5529.30883639545, 5531.446855314436, 5075.096838685493, 5076.847694569169, 5077.111505486525, 5083.923741143886, 5095.337606111182, 5369.818639899216, 5373.6507127038185, 5377.516023557899, 5377.704226267593, 5378.489043540857, 5028.23447104084, 5268.236105764566, 5268.81559145428, 5271.578273738015, 5291.550218231493, 5044.747762611928, 5067.949320506896, 5078.949210507848, 5097.464766199644, 5104.821331253537, 3776.112613535872, 3801.4487899255005, 3807.6002019787525, 3811.695064394897, 3819.6371344722206, 5179.730965913224, 5247.58019358458, 5352.437994010573, 5354.705491198021, 5385.784568617368, 5130.256112863689, 5293.206019097166, 5327.174287985368, 5331.466853314638, 5335.653182543122, 5232.633715640021, 5241.764120614505, 5268.473152684701, 5269.8682532935445, 5276.736163191748, 5078.746062696777, 5159.122949098587, 5176.9741151294, 5184.766685499237, 5185.533302002837, 5304.283921670525, 5311.72518595542, 5315.893682126413, 5336.306280183551, 5338.3593968724, 5189.221616757516, 5196.2725218470205, 5199.29809475716, 5215.400228973716, 5216.0], "value": 3979.888787281518, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6272748168655, 615.1940957345877, 653.4151934019052, 660.669665167416, 693.8751024815531, 11350.716232094202, 11681.240719353236, 11683.883161168385, 11720.120990925694, 11734.530618775249, 10841.078508326802, 11311.717207069827, 11329.490172942216, 11378.886211137886, 11416.086713062956, 787.6967367563471, 821.3757544266371, 822.5311572403732, 822.9670813167467, 823.4688625836332, 806.8023334283109, 809.9676012959475, 817.7546735979212, 819.889314942484, 820.3437250199846, 663.9136912201432, 833.3832963606917, 843.8059246373307, 856.7643897928089, 857.4855086947844, 845.0197770586121, 851.2083762101244, 853.2960307746104, 853.4537895746727, 853.7353420439683, 618.2179542878263, 621.1304174156218, 624.9125122482856, 625.0249610607467, 625.2372106030635, 11915.880841191563, 11967.581134660331, 11968.760624787456, 11978.401079945968, 11981.400929953556, 12610.74778504434, 12843.0, 12863.0, 12875.742485150338, 13325.333733313393, 9313.627454901864, 9397.859032114524, 9469.715908522756, 9469.763255918588, 9529.571169297398, 2906.433245517125, 2934.1637633274413, 2955.497565413885, 2988.417258634567, 3020.7432368248724, 47805.28292075622, 48441.515584844055, 49828.50171498275, 49943.75028124872, 49966.7501662493, 9794.216462682969, 9862.45756483386, 9966.0, 10019.849702254473, 10431.426271554985, 18363.17365718546, 18371.26514939414, 18377.0, 18391.08044597765, 18408.079596020147, 5957.970210148921, 6147.877042459126, 6211.65835879022, 6300.2754683212015, 6437.420632143129, 3594.4248920172645, 3615.439606860888, 3644.1254099016046, 3660.194757153422, 3725.1245957200035, 2581.612758086302, 2680.571108622611, 2680.6515153030373, 2682.8658567071957, 2687.596860470906, 477.49385651209826, 504.56607317706744, 557.1698169727077, 557.8259702293934, 568.0938902450584, 541.442314416152, 546.2516352596967, 553.8670719027405, 562.1511517608359, 562.4083842725079, 7471.813204669927, 7512.5492470451945, 7866.803329916798, 7948.84102317962, 8066.7579972600915, 560.9130584759369, 565.5306095940359, 577.1112486770411, 580.9419058094156, 580.9651420914759, 3742.8502859885843, 3830.942535861964, 3917.0, 3920.5491368492417, 3946.3685810270217, 53636.46363536315, 54261.72869135629, 54782.45217547853, 54876.45123548793, 55167.72416137894, 44275.778621106685, 45481.0, 46048.0, 46147.0, 46811.29783053257, 41914.58085419168, 41985.0, 42066.57933420688, 43105.56894431016, 43178.568214317456, 7815.882761758692, 8022.59887005659, 8142.918570814216, 8159.551224682699, 8298.460600060977, 29181.7081829179, 29332.266693332836, 29793.702062979093, 29883.70116298809, 30399.69600304057, 37537.43693844649, 38269.0, 38338.6166138335, 38667.2266554673, 43520.782396087816, 11180.608678696206, 11235.887641123483, 11283.0, 11436.656900293005, 11536.942315288705, 11429.828552571551, 11647.126465514952, 11766.941165294118, 12132.575359862363, 12485.0, 10378.117859981685, 10525.89474105249, 10772.192085593768, 10865.18511111654, 10877.292975956538, 9983.900160998297, 10097.747556311151, 10146.797064058825, 10300.587976480856, 10573.9471302643, 9933.850992234979, 11013.944930275296, 11016.559337626406, 11209.607663731731, 11269.436528173395, 9059.637614495346, 9144.63421463134, 9330.580123894577, 9412.105849944244, 9715.271354648288, 9401.764955876159, 9527.666531671635, 9707.0, 9826.5086745661, 9857.654982075594], "value": 5852.592611358927, "unit": "score"}], "name": "dromaeo_css", "value": 6306.977667871339, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 107.0, 112.0, 113.0, 113.0, 101.0, 110.0, 112.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 154.0, 183.0, 140.0, 160.0, 167.0, 131.0, 182.0, 141.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 159.0, 161.0, 161.0, 161.0, 159.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 102.0, 116.0, 85.0, 74.0, 77.0, 113.0, 105.0, 74.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 146.0, 94.0, 93.0, 93.0, 145.0, 94.0, 93.0, 144.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 64.0, 66.0, 65.0, 65.0, 80.0, 64.0, 63.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 70.0, 65.0, 66.0, 69.0, 64.0, 64.0, 65.0, 65.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 79.0, 78.0, 87.0, 78.0, 80.0, 79.0, 79.0, 82.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 143.0, 132.0, 137.0, 131.0, 136.0, 145.0, 130.0, 163.0, 140.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 177.0, 183.0, 178.0, 171.0, 170.0, 175.0, 175.0, 170.0, 169.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 71.0, 73.0, 73.0, 72.0, 72.0, 72.0, 70.0, 71.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1579.6, "alertThreshold": 2.0}]} 06:48:44 INFO - Return code: 0 06:48:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:48:44 ERROR - # TBPL SUCCESS # 06:48:44 INFO - Running post-action listener: _resource_record_post_action 06:48:44 INFO - Running post-run listener: _resource_record_post_run 06:48:45 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 10477568; Write bytes: 383778816; Read time: 2824; Write time: 331136 06:48:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 704512; Read time: 0; Write time: 184 06:48:45 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 10473472; Write bytes: 316461056; Read time: 2716; Write time: 269532 06:48:45 INFO - Running post-run listener: _upload_blobber_files 06:48:45 INFO - Blob upload gear active. 06:48:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:48:45 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:48:45 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:48:45 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:48:45 INFO - (blobuploader) - INFO - Open directory for files ... 06:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:46 INFO - (blobuploader) - INFO - Done attempting. 06:48:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:48:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:48:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:47 INFO - (blobuploader) - INFO - Done attempting. 06:48:47 INFO - (blobuploader) - INFO - Iteration through files over. 06:48:47 INFO - Return code: 0 06:48:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:48:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:48:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32ccc348f6d7b70847d43e321793851f4ac2410ba716e91511cabf36922ea8952217ffd72fb01e732e72f0c15f988192bc6df51ebadfc8e2b866f9c3d33b86ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8efa5f3a733d8d6813afbb0b5118c75397b94ee8a2016ea6f2c643b3df56b0b12933f5dd3b92975dbea2aa34984d83383ee7ae3c09e5e46dcce093126bf2d6df"} 06:48:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:48:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:48:47 INFO - Contents: 06:48:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32ccc348f6d7b70847d43e321793851f4ac2410ba716e91511cabf36922ea8952217ffd72fb01e732e72f0c15f988192bc6df51ebadfc8e2b866f9c3d33b86ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8efa5f3a733d8d6813afbb0b5118c75397b94ee8a2016ea6f2c643b3df56b0b12933f5dd3b92975dbea2aa34984d83383ee7ae3c09e5e46dcce093126bf2d6df"} 06:48:47 INFO - Running post-run listener: copy_logs_to_upload_dir 06:48:47 INFO - Copying logs to upload dir... 06:48:47 INFO - mkdir: /builds/slave/test/build/upload/logs 06:48:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.176538 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-22 06:48:47.511947) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:48:47.515450) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911 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/32ccc348f6d7b70847d43e321793851f4ac2410ba716e91511cabf36922ea8952217ffd72fb01e732e72f0c15f988192bc6df51ebadfc8e2b866f9c3d33b86ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8efa5f3a733d8d6813afbb0b5118c75397b94ee8a2016ea6f2c643b3df56b0b12933f5dd3b92975dbea2aa34984d83383ee7ae3c09e5e46dcce093126bf2d6df"} build_url:https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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/32ccc348f6d7b70847d43e321793851f4ac2410ba716e91511cabf36922ea8952217ffd72fb01e732e72f0c15f988192bc6df51ebadfc8e2b866f9c3d33b86ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8efa5f3a733d8d6813afbb0b5118c75397b94ee8a2016ea6f2c643b3df56b0b12933f5dd3b92975dbea2aa34984d83383ee7ae3c09e5e46dcce093126bf2d6df"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:48:47.540948) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:48:47.541335) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461331675.310163-300526911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:48:47.625657) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:48:47.625993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:48:47.626312) ========= ========= Total master_lag: 0.16 =========