builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1461584801.0 results: success (0) buildid: 20160422035709 builduid: 3af33a9a7de54ba3986a82f34ab86caa revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.002919) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.003494) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.003785) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.484143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.484387) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 04:46:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 70.8M=0s 2016-04-25 04:46:42 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.591492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.591774) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019639 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.677973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.678314) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80598be5d80e695727ff74e712faa623b02f3c70 --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 80598be5d80e695727ff74e712faa623b02f3c70 --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=8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 04:46:42,704 truncating revision to first 12 chars 2016-04-25 04:46:42,704 Setting DEBUG logging. 2016-04-25 04:46:42,704 attempt 1/10 2016-04-25 04:46:42,704 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80598be5d80e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 04:46:42,936 unpacking tar archive at: fx-team-80598be5d80e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.519653 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.210741) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.211001) ========= script_repo_revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.211354) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.211608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.220877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-25 04:46:42.221138) ========= /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=8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:46:43 INFO - MultiFileLogger online at 20160425 04:46:43 in /builds/slave/test 04:46:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:46:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:43 INFO - {'append_to_log': False, 04:46:43 INFO - 'base_work_dir': '/builds/slave/test', 04:46:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:46:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:43 INFO - 'branch': 'Fx-Team-Non-PGO', 04:46:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:43 INFO - 'config_files': ('talos/linux_config.py',), 04:46:43 INFO - 'default_actions': ('clobber', 04:46:43 INFO - 'read-buildbot-config', 04:46:43 INFO - 'download-and-extract', 04:46:43 INFO - 'populate-webroot', 04:46:43 INFO - 'create-virtualenv', 04:46:43 INFO - 'install', 04:46:43 INFO - 'run-tests'), 04:46:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:43 INFO - 'download_minidump_stackwalk': True, 04:46:43 INFO - 'download_symbols': 'ondemand', 04:46:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:43 INFO - 'installer_path': 'installer.exe', 04:46:43 INFO - 'log_level': 'info', 04:46:43 INFO - 'log_name': 'talos', 04:46:43 INFO - 'log_to_console': True, 04:46:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:46:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:46:43 INFO - 'opt_config_files': (), 04:46:43 INFO - 'pip_index': False, 04:46:43 INFO - 'sps_profile': False, 04:46:43 INFO - 'sps_profile_interval': 0, 04:46:43 INFO - 'suite': 'dromaeojs', 04:46:43 INFO - 'system_bits': '32', 04:46:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:43 INFO - 'title': 'talos-linux64-ix-049', 04:46:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:43 INFO - 'use_talos_json': True, 04:46:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:43 INFO - 'work_dir': 'build'} 04:46:43 INFO - ##### 04:46:43 INFO - ##### Running clobber step. 04:46:43 INFO - ##### 04:46:43 INFO - Running pre-action listener: _resource_record_pre_action 04:46:43 INFO - Running main action method: clobber 04:46:43 INFO - rmtree: /builds/slave/test/build 04:46:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:43 INFO - Running post-action listener: _resource_record_post_action 04:46:43 INFO - ##### 04:46:43 INFO - ##### Running read-buildbot-config step. 04:46:43 INFO - ##### 04:46:43 INFO - Running pre-action listener: _resource_record_pre_action 04:46:43 INFO - Running main action method: read_buildbot_config 04:46:43 INFO - Using buildbot properties: 04:46:43 INFO - { 04:46:43 INFO - "project": "", 04:46:43 INFO - "product": "firefox", 04:46:43 INFO - "script_repo_revision": "production", 04:46:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:46:43 INFO - "repository": "", 04:46:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:46:43 INFO - "buildid": "20160422035709", 04:46:43 INFO - "pgo_build": "False", 04:46:43 INFO - "basedir": "/builds/slave/test", 04:46:43 INFO - "buildnumber": 2878, 04:46:43 INFO - "slavename": "talos-linux64-ix-049", 04:46:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:46:43 INFO - "platform": "ubuntu64_hw", 04:46:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:46:43 INFO - "branch": "fx-team", 04:46:43 INFO - "repo_path": "integration/fx-team", 04:46:43 INFO - "revision": "80598be5d80e695727ff74e712faa623b02f3c70", 04:46:43 INFO - "stage_platform": "linux64", 04:46:43 INFO - "builduid": "3af33a9a7de54ba3986a82f34ab86caa", 04:46:43 INFO - "slavebuilddir": "test" 04:46:43 INFO - } 04:46:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:46:43 INFO - Running post-action listener: _resource_record_post_action 04:46:43 INFO - ##### 04:46:43 INFO - ##### Running download-and-extract step. 04:46:43 INFO - ##### 04:46:43 INFO - Running pre-action listener: _resource_record_pre_action 04:46:43 INFO - Running main action method: download_and_extract 04:46:43 INFO - mkdir: /builds/slave/test/build/tests 04:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:43 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:46:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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 04:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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 04:46:52 INFO - Downloaded 1361 bytes. 04:46:52 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:52 INFO - Using the following test package requirements: 04:46:52 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:52 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:46:52 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:46:52 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'jsshell-linux-x86_64.zip'], 04:46:52 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:46:52 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:52 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:46:52 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:46:52 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:46:52 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:46:52 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:52 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:46:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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 04:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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 04:47:03 INFO - Downloaded 22281373 bytes. 04:47:03 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'] 04:47:03 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 04:47:04 INFO - Return code: 0 04:47:04 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 04:47:04 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')]} 04:47:04 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:47:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:47:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:47:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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 04:47:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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 04:47:05 INFO - Downloaded 22281373 bytes. 04:47:05 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'] 04:47:05 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 04:47:06 INFO - Return code: 0 04:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:06 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:47:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:47:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:47:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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 04:47:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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 04:47:07 INFO - Downloaded 10845952 bytes. 04:47:07 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'] 04:47:07 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 04:47:08 INFO - Return code: 0 04:47: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')]} 04:47:08 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:47:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:47:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:47:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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 04:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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 04:47:09 INFO - Downloaded 54650321 bytes. 04:47:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:47:09 INFO - mkdir: /builds/slave/test/properties 04:47:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:09 INFO - Contents: 04:47:09 INFO - build_url:https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:47:10 INFO - Running post-action listener: _resource_record_post_action 04:47:10 INFO - Running post-action listener: set_extra_try_arguments 04:47:10 INFO - ##### 04:47:10 INFO - ##### Running populate-webroot step. 04:47:10 INFO - ##### 04:47:10 INFO - Running pre-action listener: _resource_record_pre_action 04:47:10 INFO - Running main action method: populate_webroot 04:47:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:47:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:47:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:47:10 INFO - '--tppagecycles', 04:47:10 INFO - '7'], 04:47:10 INFO - 'tests': ['tsvgm']}}, 04:47:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:47:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:47:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:47:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:47:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:10 INFO - 'talos_options': ['--disable-e10s'], 04:47:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:10 INFO - 'talos_options': ['--disable-e10s'], 04:47:10 INFO - 'tests': ['damp', 'tps']}, 04:47:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:10 INFO - 'tests': ['damp', 'tps']}, 04:47:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:47:10 INFO - 'tests': ['dromaeo_dom']}, 04:47:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:47:10 INFO - 'tests': ['a11yr', 04:47:10 INFO - 'ts_paint', 04:47:10 INFO - 'tpaint', 04:47:10 INFO - 'sessionrestore', 04:47:10 INFO - 'sessionrestore_no_auto_restore', 04:47:10 INFO - 'tabpaint']}, 04:47:10 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:10 INFO - 'ts_paint', 04:47:10 INFO - 'tpaint', 04:47:10 INFO - 'sessionrestore', 04:47:10 INFO - 'sessionrestore_no_auto_restore', 04:47:10 INFO - 'tabpaint']}, 04:47:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:47:10 INFO - 'ts_paint', 04:47:10 INFO - 'tpaint', 04:47:10 INFO - 'sessionrestore', 04:47:10 INFO - 'sessionrestore_no_auto_restore', 04:47:10 INFO - 'tabpaint']}, 04:47:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:47:10 INFO - 'ts_paint', 04:47:10 INFO - 'tpaint', 04:47:10 INFO - 'sessionrestore', 04:47:10 INFO - 'sessionrestore_no_auto_restore', 04:47:10 INFO - 'tabpaint']}, 04:47:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:47:10 INFO - 'tests': ['a11yr', 04:47:10 INFO - 'ts_paint', 04:47:10 INFO - 'tpaint', 04:47:10 INFO - 'sessionrestore', 04:47:10 INFO - 'sessionrestore_no_auto_restore', 04:47:10 INFO - 'tabpaint']}, 04:47:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:47:10 INFO - 'tests': ['a11yr', 04:47:10 INFO - 'ts_paint', 04:47:10 INFO - 'tpaint', 04:47:10 INFO - 'sessionrestore', 04:47:10 INFO - 'sessionrestore_no_auto_restore', 04:47:10 INFO - 'tabpaint']}, 04:47:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:47:10 INFO - 'tests': ['tsvgx', 04:47:10 INFO - 'tsvgr_opacity', 04:47:10 INFO - 'tart', 04:47:10 INFO - 'tscrollx', 04:47:10 INFO - 'cart']}, 04:47:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:10 INFO - 'tsvgr_opacity', 04:47:10 INFO - 'tart', 04:47:10 INFO - 'tscrollx', 04:47:10 INFO - 'cart']}, 04:47:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:10 INFO - 'talos_options': ['--disable-e10s'], 04:47:10 INFO - 'tests': ['tp5o']}, 04:47:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:10 INFO - 'tests': ['tp5o']}, 04:47:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:10 INFO - 'talos_options': ['--disable-e10s', 04:47:10 INFO - '--xperf_path', 04:47:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:10 INFO - 'tests': ['tp5n']}, 04:47:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:10 INFO - 'talos_options': ['--xperf_path', 04:47:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:10 INFO - 'tests': ['tp5n']}}, 04:47:10 INFO - 'talos.zip': {'path': '', 04:47:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:47:10 INFO - Running post-action listener: _resource_record_post_action 04:47:10 INFO - ##### 04:47:10 INFO - ##### Running create-virtualenv step. 04:47:10 INFO - ##### 04:47:10 INFO - Running pre-action listener: _resource_record_pre_action 04:47:10 INFO - Running main action method: create_virtualenv 04:47:10 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:10 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 04:47:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:10 INFO - Using real prefix '/usr' 04:47:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:12 INFO - Installing pip.................done. 04:47:12 INFO - Return code: 0 04:47:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 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 0x7ff026f54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2454410>, '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 0x2455310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24557a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', '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 04:47:12 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 04:47:12 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 04:47:12 INFO - Using env: {'DISPLAY': ':0', 04:47:12 INFO - 'HOME': '/home/cltbld', 04:47:12 INFO - 'LANG': 'en_US.UTF-8', 04:47:12 INFO - 'LANGUAGE': 'en_US:en', 04:47:12 INFO - 'LOGNAME': 'cltbld', 04:47:12 INFO - 'MAIL': '/var/mail/cltbld', 04:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:12 INFO - 'MOZ_NO_REMOTE': '1', 04:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:12 INFO - 'NO_EM_RESTART': '1', 04:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:12 INFO - 'PWD': '/builds/slave/test', 04:47:12 INFO - 'SHELL': '/bin/bash', 04:47:12 INFO - 'SHLVL': '1', 04:47:12 INFO - 'TERM': 'linux', 04:47:12 INFO - 'TMOUT': '86400', 04:47:12 INFO - 'USER': 'cltbld', 04:47:12 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', 04:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:12 INFO - '_': '/tools/buildbot/bin/python'} 04:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:13 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 04:47:13 INFO - Cleaning up... 04:47:13 INFO - Return code: 0 04:47:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff026f54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2454410>, '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 0x2455310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24557a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', '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 04:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:47:13 INFO - Using env: {'DISPLAY': ':0', 04:47:13 INFO - 'HOME': '/home/cltbld', 04:47:13 INFO - 'LANG': 'en_US.UTF-8', 04:47:13 INFO - 'LANGUAGE': 'en_US:en', 04:47:13 INFO - 'LOGNAME': 'cltbld', 04:47:13 INFO - 'MAIL': '/var/mail/cltbld', 04:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:13 INFO - 'MOZ_NO_REMOTE': '1', 04:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:13 INFO - 'NO_EM_RESTART': '1', 04:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:13 INFO - 'PWD': '/builds/slave/test', 04:47:13 INFO - 'SHELL': '/bin/bash', 04:47:13 INFO - 'SHLVL': '1', 04:47:13 INFO - 'TERM': 'linux', 04:47:13 INFO - 'TMOUT': '86400', 04:47:13 INFO - 'USER': 'cltbld', 04:47:13 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', 04:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:13 INFO - '_': '/tools/buildbot/bin/python'} 04:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:13 INFO - Downloading/unpacking psutil>=0.7.1 04:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:15 INFO - Installing collected packages: psutil 04:47:15 INFO - Running setup.py install for psutil 04:47:15 INFO - building 'psutil._psutil_linux' extension 04:47:15 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 04:47:15 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 04:47:15 INFO - building 'psutil._psutil_posix' extension 04:47:15 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 04:47:15 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 04:47:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:15 INFO - Successfully installed psutil 04:47:15 INFO - Cleaning up... 04:47:15 INFO - Return code: 0 04:47:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff026f54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2454410>, '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 0x2455310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24557a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', '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 04:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:47:15 INFO - Using env: {'DISPLAY': ':0', 04:47:15 INFO - 'HOME': '/home/cltbld', 04:47:15 INFO - 'LANG': 'en_US.UTF-8', 04:47:15 INFO - 'LANGUAGE': 'en_US:en', 04:47:15 INFO - 'LOGNAME': 'cltbld', 04:47:15 INFO - 'MAIL': '/var/mail/cltbld', 04:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:15 INFO - 'MOZ_NO_REMOTE': '1', 04:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:15 INFO - 'NO_EM_RESTART': '1', 04:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:15 INFO - 'PWD': '/builds/slave/test', 04:47:15 INFO - 'SHELL': '/bin/bash', 04:47:15 INFO - 'SHLVL': '1', 04:47:15 INFO - 'TERM': 'linux', 04:47:15 INFO - 'TMOUT': '86400', 04:47:15 INFO - 'USER': 'cltbld', 04:47:15 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', 04:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:15 INFO - '_': '/tools/buildbot/bin/python'} 04:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:47:17 INFO - Installing collected packages: mozsystemmonitor 04:47:17 INFO - Running setup.py install for mozsystemmonitor 04:47:17 INFO - Successfully installed mozsystemmonitor 04:47:17 INFO - Cleaning up... 04:47:18 INFO - Return code: 0 04:47:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff026f54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2454410>, '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 0x2455310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24557a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', '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 04:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:47:18 INFO - Using env: {'DISPLAY': ':0', 04:47:18 INFO - 'HOME': '/home/cltbld', 04:47:18 INFO - 'LANG': 'en_US.UTF-8', 04:47:18 INFO - 'LANGUAGE': 'en_US:en', 04:47:18 INFO - 'LOGNAME': 'cltbld', 04:47:18 INFO - 'MAIL': '/var/mail/cltbld', 04:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:18 INFO - 'MOZ_NO_REMOTE': '1', 04:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:18 INFO - 'NO_EM_RESTART': '1', 04:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:18 INFO - 'PWD': '/builds/slave/test', 04:47:18 INFO - 'SHELL': '/bin/bash', 04:47:18 INFO - 'SHLVL': '1', 04:47:18 INFO - 'TERM': 'linux', 04:47:18 INFO - 'TMOUT': '86400', 04:47:18 INFO - 'USER': 'cltbld', 04:47:18 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', 04:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:18 INFO - '_': '/tools/buildbot/bin/python'} 04:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:20 INFO - Downloading docopt-0.6.1.tar.gz 04:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:20 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:20 INFO - Running setup.py install for blobuploader 04:47:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:20 INFO - Running setup.py install for requests 04:47:21 INFO - Running setup.py install for docopt 04:47:21 INFO - Successfully installed blobuploader requests docopt 04:47:21 INFO - Cleaning up... 04:47:21 INFO - Return code: 0 04:47:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:21 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')]} 04:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:21 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')]} 04:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:21 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 0x7ff026f54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2454410>, '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 0x2455310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24557a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', '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 04:47:21 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 04:47:21 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 04:47:21 INFO - Using env: {'DISPLAY': ':0', 04:47:21 INFO - 'HOME': '/home/cltbld', 04:47:21 INFO - 'LANG': 'en_US.UTF-8', 04:47:21 INFO - 'LANGUAGE': 'en_US:en', 04:47:21 INFO - 'LOGNAME': 'cltbld', 04:47:21 INFO - 'MAIL': '/var/mail/cltbld', 04:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:21 INFO - 'MOZ_NO_REMOTE': '1', 04:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:21 INFO - 'NO_EM_RESTART': '1', 04:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:21 INFO - 'PWD': '/builds/slave/test', 04:47:21 INFO - 'SHELL': '/bin/bash', 04:47:21 INFO - 'SHLVL': '1', 04:47:21 INFO - 'TERM': 'linux', 04:47:21 INFO - 'TMOUT': '86400', 04:47:21 INFO - 'USER': 'cltbld', 04:47:21 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', 04:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:21 INFO - '_': '/tools/buildbot/bin/python'} 04:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:21 INFO - Running setup.py (path:/tmp/pip-KmqdSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:21 INFO - Running setup.py (path:/tmp/pip-yhn3sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:21 INFO - Running setup.py (path:/tmp/pip-oBqKPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:21 INFO - Running setup.py (path:/tmp/pip-2lAs69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:22 INFO - Running setup.py (path:/tmp/pip-Gaxp67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:22 INFO - Running setup.py (path:/tmp/pip-NUT4de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:22 INFO - Running setup.py (path:/tmp/pip-4M2ggr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:22 INFO - Running setup.py (path:/tmp/pip-33jwjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:22 INFO - Running setup.py (path:/tmp/pip-1yNK_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:22 INFO - Running setup.py (path:/tmp/pip-HteUym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:22 INFO - Running setup.py (path:/tmp/pip-GLbULD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:22 INFO - Running setup.py (path:/tmp/pip-vVhHNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:22 INFO - Running setup.py (path:/tmp/pip-yUJPmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:22 INFO - Running setup.py (path:/tmp/pip-H1LKGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:22 INFO - Running setup.py (path:/tmp/pip-8aRR6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:22 INFO - Running setup.py (path:/tmp/pip-3N2I21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:22 INFO - Running setup.py (path:/tmp/pip-bwtS3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:22 INFO - Running setup.py install for manifestparser 04:47:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:23 INFO - Running setup.py install for mozcrash 04:47:23 INFO - Running setup.py install for mozdebug 04:47:23 INFO - Running setup.py install for mozdevice 04:47:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:47:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:23 INFO - Running setup.py install for mozfile 04:47:23 INFO - Running setup.py install for mozhttpd 04:47:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:23 INFO - Running setup.py install for mozinfo 04:47:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:23 INFO - Running setup.py install for mozInstall 04:47:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:23 INFO - Running setup.py install for mozleak 04:47:23 INFO - Running setup.py install for mozlog 04:47:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:23 INFO - Running setup.py install for moznetwork 04:47:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:24 INFO - Running setup.py install for mozprocess 04:47:24 INFO - Running setup.py install for mozprofile 04:47:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:24 INFO - Running setup.py install for mozrunner 04:47:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:24 INFO - Running setup.py install for mozscreenshot 04:47:24 INFO - Running setup.py install for moztest 04:47:24 INFO - Running setup.py install for mozversion 04:47:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:24 INFO - Cleaning up... 04:47:24 INFO - Return code: 0 04:47:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:24 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 0x7ff026f54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2454410>, '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 0x2455310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24557a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', '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 04:47:24 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 04:47:24 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 04:47:24 INFO - Using env: {'DISPLAY': ':0', 04:47:24 INFO - 'HOME': '/home/cltbld', 04:47:24 INFO - 'LANG': 'en_US.UTF-8', 04:47:24 INFO - 'LANGUAGE': 'en_US:en', 04:47:24 INFO - 'LOGNAME': 'cltbld', 04:47:24 INFO - 'MAIL': '/var/mail/cltbld', 04:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:24 INFO - 'MOZ_NO_REMOTE': '1', 04:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:24 INFO - 'NO_EM_RESTART': '1', 04:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:24 INFO - 'PWD': '/builds/slave/test', 04:47:24 INFO - 'SHELL': '/bin/bash', 04:47:24 INFO - 'SHLVL': '1', 04:47:24 INFO - 'TERM': 'linux', 04:47:24 INFO - 'TMOUT': '86400', 04:47:24 INFO - 'USER': 'cltbld', 04:47:24 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', 04:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:24 INFO - '_': '/tools/buildbot/bin/python'} 04:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:24 INFO - Running setup.py (path:/tmp/pip-48xjUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:25 INFO - Running setup.py (path:/tmp/pip-gzxnA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:25 INFO - Running setup.py (path:/tmp/pip-4pdRQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:25 INFO - Running setup.py (path:/tmp/pip-DtTwul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:25 INFO - Running setup.py (path:/tmp/pip-dyEbrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:25 INFO - Running setup.py (path:/tmp/pip-fFgaA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:25 INFO - Running setup.py (path:/tmp/pip-mAdW4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:25 INFO - Running setup.py (path:/tmp/pip-tk7_Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:25 INFO - Running setup.py (path:/tmp/pip-LAy6sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:25 INFO - Running setup.py (path:/tmp/pip-pzSONy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:25 INFO - Running setup.py (path:/tmp/pip-ktuA9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:25 INFO - Running setup.py (path:/tmp/pip-yWg6kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:25 INFO - Running setup.py (path:/tmp/pip-CHIdJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:25 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)) 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:25 INFO - Running setup.py (path:/tmp/pip-P6LuF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:26 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)) 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:26 INFO - Running setup.py (path:/tmp/pip-jk8uxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:26 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)) 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:26 INFO - Running setup.py (path:/tmp/pip-PuSl1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:26 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)) 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:26 INFO - Running setup.py (path:/tmp/pip-ojypD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:26 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)) 04:47:26 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)) 04:47:26 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)) 04:47:26 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)) 04:47:26 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)) 04:47:26 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)) 04:47:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:28 INFO - Downloading blessings-1.6.tar.gz 04:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:28 INFO - Installing collected packages: blessings 04:47:28 INFO - Running setup.py install for blessings 04:47:28 INFO - Successfully installed blessings 04:47:28 INFO - Cleaning up... 04:47:28 INFO - Return code: 0 04:47:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:28 INFO - Reading from file tmpfile_stdout 04:47:28 INFO - Current package versions: 04:47:28 INFO - argparse == 1.2.1 04:47:28 INFO - blessings == 1.6 04:47:28 INFO - blobuploader == 1.2.4 04:47:28 INFO - docopt == 0.6.1 04:47:28 INFO - manifestparser == 1.1 04:47:28 INFO - mozInstall == 1.12 04:47:28 INFO - mozcrash == 0.17 04:47:28 INFO - mozdebug == 0.1 04:47:28 INFO - mozdevice == 0.48 04:47:28 INFO - mozfile == 1.2 04:47:28 INFO - mozhttpd == 0.7 04:47:28 INFO - mozinfo == 0.9 04:47:28 INFO - mozleak == 0.1 04:47:28 INFO - mozlog == 3.1 04:47:28 INFO - moznetwork == 0.27 04:47:28 INFO - mozprocess == 0.22 04:47:28 INFO - mozprofile == 0.28 04:47:28 INFO - mozrunner == 6.11 04:47:28 INFO - mozscreenshot == 0.1 04:47:28 INFO - mozsystemmonitor == 0.0 04:47:28 INFO - moztest == 0.7 04:47:28 INFO - mozversion == 1.4 04:47:28 INFO - psutil == 3.1.1 04:47:28 INFO - requests == 1.2.3 04:47:28 INFO - wsgiref == 0.1.2 04:47:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:28 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 0x7ff026f54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2454410>, '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 0x2455310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24557a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', '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 04:47:28 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 04:47:28 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 04:47:28 INFO - Using env: {'DISPLAY': ':0', 04:47:28 INFO - 'HOME': '/home/cltbld', 04:47:28 INFO - 'LANG': 'en_US.UTF-8', 04:47:28 INFO - 'LANGUAGE': 'en_US:en', 04:47:28 INFO - 'LOGNAME': 'cltbld', 04:47:28 INFO - 'MAIL': '/var/mail/cltbld', 04:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:28 INFO - 'MOZ_NO_REMOTE': '1', 04:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:28 INFO - 'NO_EM_RESTART': '1', 04:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:28 INFO - 'PWD': '/builds/slave/test', 04:47:28 INFO - 'SHELL': '/bin/bash', 04:47:28 INFO - 'SHLVL': '1', 04:47:28 INFO - 'TERM': 'linux', 04:47:28 INFO - 'TMOUT': '86400', 04:47:28 INFO - 'USER': 'cltbld', 04:47:28 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', 04:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:28 INFO - '_': '/tools/buildbot/bin/python'} 04:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 INFO - Cleaning up... 04:47:28 INFO - Return code: 0 04:47:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:28 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 0x7ff026f54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2454410>, '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 0x2455310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24557a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', '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 04:47:28 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 04:47:28 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 04:47:28 INFO - Using env: {'DISPLAY': ':0', 04:47:28 INFO - 'HOME': '/home/cltbld', 04:47:28 INFO - 'LANG': 'en_US.UTF-8', 04:47:28 INFO - 'LANGUAGE': 'en_US:en', 04:47:28 INFO - 'LOGNAME': 'cltbld', 04:47:28 INFO - 'MAIL': '/var/mail/cltbld', 04:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:28 INFO - 'MOZ_NO_REMOTE': '1', 04:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:28 INFO - 'NO_EM_RESTART': '1', 04:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:28 INFO - 'PWD': '/builds/slave/test', 04:47:28 INFO - 'SHELL': '/bin/bash', 04:47:28 INFO - 'SHLVL': '1', 04:47:28 INFO - 'TERM': 'linux', 04:47:28 INFO - 'TMOUT': '86400', 04:47:28 INFO - 'USER': 'cltbld', 04:47:28 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', 04:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:28 INFO - '_': '/tools/buildbot/bin/python'} 04:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:28 INFO - Downloading/unpacking jsonschema 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:30 INFO - Downloading/unpacking functools32 (from jsonschema) 04:47:30 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 04:47:30 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 04:47:30 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 04:47:30 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 04:47:30 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 04:47:30 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 04:47:31 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:31 INFO - warning: no files found matching '*.txt' 04:47:31 INFO - no previously-included directories found matching 'build' 04:47:31 INFO - no previously-included directories found matching 'dist' 04:47:31 INFO - no previously-included directories found matching '.git*' 04:47:31 INFO - Installing collected packages: jsonschema, functools32 04:47:31 INFO - Running setup.py install for functools32 04:47:31 INFO - warning: no files found matching '*.txt' 04:47:31 INFO - no previously-included directories found matching 'build' 04:47:31 INFO - no previously-included directories found matching 'dist' 04:47:31 INFO - no previously-included directories found matching '.git*' 04:47:31 INFO - Successfully installed jsonschema functools32 04:47:31 INFO - Cleaning up... 04:47:31 INFO - Return code: 0 04:47:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:47:31 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')]} 04:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:31 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')]} 04:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:31 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 0x7ff026f54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2454410>, '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 0x2455310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24557a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', '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 04:47:31 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 04:47:31 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 04:47:31 INFO - Using env: {'DISPLAY': ':0', 04:47:31 INFO - 'HOME': '/home/cltbld', 04:47:31 INFO - 'LANG': 'en_US.UTF-8', 04:47:31 INFO - 'LANGUAGE': 'en_US:en', 04:47:31 INFO - 'LOGNAME': 'cltbld', 04:47:31 INFO - 'MAIL': '/var/mail/cltbld', 04:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:31 INFO - 'MOZ_NO_REMOTE': '1', 04:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:31 INFO - 'NO_EM_RESTART': '1', 04:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:31 INFO - 'PWD': '/builds/slave/test', 04:47:31 INFO - 'SHELL': '/bin/bash', 04:47:31 INFO - 'SHLVL': '1', 04:47:31 INFO - 'TERM': 'linux', 04:47:31 INFO - 'TMOUT': '86400', 04:47:31 INFO - 'USER': 'cltbld', 04:47:31 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', 04:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:31 INFO - '_': '/tools/buildbot/bin/python'} 04:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:31 INFO - Downloading/unpacking flake8 04:47:31 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 04:47:31 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 04:47:31 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 04:47:31 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 04:47:31 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 04:47:31 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 04:47:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:47:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:47:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:47:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:34 INFO - no previously-included directories found matching 'docs/_build' 04:47:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:47:34 INFO - Running setup.py install for pep8 04:47:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:34 INFO - no previously-included directories found matching 'docs/_build' 04:47:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:47:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:47:34 INFO - Cleaning up... 04:47:34 INFO - Return code: 0 04:47:34 INFO - Running post-action listener: _resource_record_post_action 04:47:34 INFO - Running post-action listener: _start_resource_monitoring 04:47:34 INFO - Starting resource monitoring. 04:47:34 INFO - ##### 04:47:34 INFO - ##### Running install step. 04:47:34 INFO - ##### 04:47:34 INFO - Running pre-action listener: _resource_record_pre_action 04:47:34 INFO - Running main action method: install 04:47:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:34 INFO - Reading from file tmpfile_stdout 04:47:34 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:34 INFO - Reading from file tmpfile_stdout 04:47:34 INFO - Output received: 04:47:34 INFO - Usage: mozinstall [options] installer 04:47:34 INFO - Options: 04:47:34 INFO - -h, --help show this help message and exit 04:47:34 INFO - -d DEST, --destination=DEST 04:47:34 INFO - Directory to install application into. [default: 04:47:34 INFO - "/builds/slave/test"] 04:47:34 INFO - --app=APP Application being installed. [default: firefox] 04:47:34 INFO - mkdir: /builds/slave/test/build/application 04:47:34 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'] 04:47:34 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 04:47:50 INFO - Reading from file tmpfile_stdout 04:47:50 INFO - Output received: 04:47:50 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:50 INFO - Running post-action listener: _resource_record_post_action 04:47:50 INFO - ##### 04:47:50 INFO - ##### Running run-tests step. 04:47:50 INFO - ##### 04:47:50 INFO - Running pre-action listener: _resource_record_pre_action 04:47:50 INFO - Running main action method: run_tests 04:47:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:50 INFO - Python 2.7.3 04:47:50 INFO - Return code: 0 04:47:50 INFO - grabbing minidump binary from tooltool 04:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:50 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 0x2454410>, '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 0x2455310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24557a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:50 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 04:47:50 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 04:47:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:50 INFO - Return code: 0 04:47:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:47:51 INFO - Return code: 0 04:47:51 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/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 04:47:51 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/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 04:47:51 INFO - Using env: {'DISPLAY': ':0', 04:47:51 INFO - 'HOME': '/home/cltbld', 04:47:51 INFO - 'LANG': 'en_US.UTF-8', 04:47:51 INFO - 'LANGUAGE': 'en_US:en', 04:47:51 INFO - 'LOGNAME': 'cltbld', 04:47:51 INFO - 'MAIL': '/var/mail/cltbld', 04:47:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:51 INFO - 'MOZ_NO_REMOTE': '1', 04:47:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:51 INFO - 'NO_EM_RESTART': '1', 04:47:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:51 INFO - 'PWD': '/builds/slave/test', 04:47:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:51 INFO - 'SHELL': '/bin/bash', 04:47:51 INFO - 'SHLVL': '1', 04:47:51 INFO - 'TERM': 'linux', 04:47:51 INFO - 'TMOUT': '86400', 04:47:51 INFO - 'USER': 'cltbld', 04:47:51 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467', 04:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:51 INFO - '_': '/tools/buildbot/bin/python'} 04:47:51 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/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 04:47:51 INFO - mozversion application_buildid: 20160422035709 04:47:51 INFO - mozversion application_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:47:51 INFO - mozversion application_display_name: Nightly 04:47:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:51 INFO - mozversion application_name: Firefox 04:47:51 INFO - mozversion application_remotingname: firefox 04:47:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:47:51 INFO - mozversion application_vendor: Mozilla 04:47:51 INFO - mozversion application_version: 48.0a1 04:47:51 INFO - mozversion platform_buildid: 20160422035709 04:47:51 INFO - mozversion platform_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:47:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:47:51 INFO - mozversion platform_version: 48.0a1 04:47:51 INFO - using testdate: 1461584871 04:47:51 INFO - actual date: 1461584871 04:47:51 INFO - starting webserver on 'localhost:59079' 04:47:51 INFO - SUITE-START | Running 2 tests 04:47:51 INFO - TEST-START | dromaeo_css 04:47:51 INFO - operating with platform_type : linux_ 04:47:51 INFO - Initialising browser for dromaeo_css test... 04:47:51 INFO - TEST-INFO | started process 20466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplSQuS7/profile http://localhost:59079/getInfo.html) 04:47:56 INFO - PROCESS | 20466 | __metrics Screen width/height:1600/1200 04:47:56 INFO - PROCESS | 20466 | colorDepth:24 04:47:56 INFO - PROCESS | 20466 | Browser inner width/height: 1024/697 04:47:56 INFO - PROCESS | 20466 | __metrics 04:47:57 ERROR - PROCESS | 20466 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:47:58 INFO - TEST-INFO | 20466: exit 0 04:47:58 INFO - Browser initialized. 04:47:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:58 INFO - TEST-INFO | started process 20546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplSQuS7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:10 INFO - PROCESS | 20546 | RSS: Main: 155287552 04:48:10 INFO - PROCESS | 20546 | 04:49:01 INFO - PROCESS | 20546 | 1461584941422 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] 04:51:12 INFO - PROCESS | 20546 | Cycle 1(1): loaded http://localhost:59079/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59079/tests/dromaeo/cssquery-ext.html) 04:51:13 INFO - PROCESS | 20546 | RSS: Main: 269664256 04:51:13 INFO - PROCESS | 20546 | 04:54:16 INFO - PROCESS | 20546 | Cycle 1(1): loaded http://localhost:59079/tests/dromaeo/cssquery-ext.html (next: http://localhost:59079/tests/dromaeo/cssquery-jquery.html) 04:54:17 INFO - PROCESS | 20546 | RSS: Main: 233578496 04:54:17 INFO - PROCESS | 20546 | 04:57:19 INFO - PROCESS | 20546 | Cycle 1(1): loaded http://localhost:59079/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59079/tests/dromaeo/cssquery-mootools.html) 04:57:19 INFO - PROCESS | 20546 | RSS: Main: 230428672 04:57:19 INFO - PROCESS | 20546 | 05:00:22 INFO - PROCESS | 20546 | Cycle 1(1): loaded http://localhost:59079/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59079/tests/dromaeo/cssquery-prototype.html) 05:00:22 INFO - PROCESS | 20546 | RSS: Main: 223510528 05:00:22 INFO - PROCESS | 20546 | 05:03:25 INFO - PROCESS | 20546 | Cycle 1(1): loaded http://localhost:59079/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59079/tests/dromaeo/cssquery-yui.html) 05:03:26 INFO - PROCESS | 20546 | RSS: Main: 216272896 05:03:26 INFO - PROCESS | 20546 | 05:06:28 INFO - PROCESS | 20546 | Cycle 1(1): loaded http://localhost:59079/tests/dromaeo/cssquery-yui.html (next: http://localhost:59079/tests/dromaeo/cssquery-dojo.html) 05:06:29 INFO - PROCESS | 20546 | RSS: Main: 270151680 05:06:29 INFO - PROCESS | 20546 | 05:06:29 INFO - PROCESS | 20546 | __start_tp_report 05:06:29 INFO - PROCESS | 20546 | _x_x_mozilla_page_load 05:06:29 INFO - PROCESS | 20546 | _x_x_mozilla_page_load_details 05:06:29 INFO - PROCESS | 20546 | |i|pagename|runs| 05:06:29 INFO - PROCESS | 20546 | |0;dojo.html;2610.8694565271735;2619.305883940757;2662.4675064987;2673.1846786730052;2676.1436340371088;4597.3104034394855;4646.535346465352;4656.999999999995;4676.181668208059;4681.508441613629;4677.415323084614;4733.621310295177;4743.762811859402;4768.47546769855;4770.117528257275;4271.103068355634;4287.078278170201;4322.200392927302;4354.934675979863;4457.621102206316;4359.629431498311;4393.428854248943;4409.735415875058;4421.977890110545;4456.754878481682;4193.2242535130945;4280.101178752435;4282.100758840647;4306.6124048835445;4367.978160109179;4331.415258940035;4363.149185908749;4365.236083685342;4366.8034938427845;4415.977920110379;4331.155424692186;4346.826126954918;4360.847370342054;4380.408644832939;4394.538573449806;4444.000099977511;4513.571210734975;4559.088182363507;4646.53534646536;4661.510541393139;5022.27177059328;5041.218611115283;5054.62090343222;5058.266551350033;5115.514026167545;5065.797368105272;5080.110980578384;5086.109930762102;5091.974540127313;5098.133317336062;4565.269556870918;4571.657125715585;4616.099860527165;4658.254679251304;4661.510541393105;5079.212722028092;5081.923771143436;5089.8727531812;5090.389153301553;5097.592192624581;4849.733264670406;4873.975630121898;4875.293082503017;4880;4943.456219815817;5009.824656137091;5086.4659210783075;5097.8215762448135;5106.412762532356;5115.462876397999;4983.9252411213865;4985.077760614298;4985.875353116201;4991.301217829507;5033.345665063518;4947.480514545993;4954.677945933503;4957.355543779286;4970.130227210224;5010.574101201439;4143.399207114951;4204.285271503791;4207.305794543927;4222.704410691222;4304.397384366192;3688.7971161585833;3698.6301369863336;3703.185299234164;3726.366517691999;3730.850765969385;4326.675499337499;4330.978345108254;4338.848140315137;4373.365861950063;4377.584129507692;4913;4976.751162441936;5002.424721157041;5027.698338099653;5061.493850614909;4321.719088259316;4340.283853164256;4352.173087113439;4356;4376.343548467756;4486.282194848808;4512.413386259831;4513.932291015637;4524.615407690383;4562.475315338778;4548.317752337242;4730.6215502759005;4794.161021821167;4811.807527698993;4815.590674792542;5080.695158290514;5085.720285384339;5104.3619547556555;5113.977204559029;5154.690718556899;4784.210605250095;4792.568668819684;4793.664443488922;4794.544518270759;4795.640326975421;4827.155247831685;4947.975260123821;5004.924926126038;5043;5053.646244762831;5035.521625445577;5079;5080.568151707146;5082.923756143735;5130.923036154386;4760.666753327234;4920.335754673073;4931.728754918514;4934.55588996992;4981.501849814989;4824.662273640812;4896.730679812645;4918.188498897642;4975.10448119342;4975.228839529878;4788.808447662054;4801.279808028824;4801.927971080367;4815.061063092663;4817.542333478314;4762.261849413347;4874.8537543873745;4927.01459708067;4945.282933974626;4950.455449900436;4728.97635511834;4828.03439312146;4850.733209673502;4852.17513022794;4931.284963680175 05:06:29 INFO - PROCESS | 20546 | |1;ext.html;563.2621266141355;601.1013534765526;611.0315150486479;613.7514306705783;627.4666533446571;26684;33367.16582085449;34367.828160859164;34459;34497.655023449755;39718.602813971855;40333.19333613326;40478;40536.594634053654;40547.79726101373;7251.6374181290985;7462.664180111908;7464.141623713288;7825.060992680872;8020.879686804703;7386.335229829314;9866.210703143766;10241.897581024168;10251.846222306634;10252.74368140795;10065.698029059104;10165.186785057178;10169.54237059334;10170.084692377684;10170.186385089175;7519.586422746746;9882.802343953117;9951.154151897097;10001.29990900641;10021;9837.065478779505;9972.301938864282;9998.500074996222;10002.89997100027;10013.299069065168;34142.6585734142;34664.480032799525;34731.30537389263;34762;34846.6515334846;2758.2828464599147;2843.8720257588457;2934.4717950768854;3262.402892849329;3445.104272889067;26873;27343.179704608894;27929;28656;28904.566431503543;3450.913727156816;3521.4893840393;3534.134137136418;3549.769264997767;3563.198280386918;239482;240677;240841;241186.7940660303;241953;33877.49183762245;34975;56316;57166.7141664289;57319.14021289684;32448.83775581107;32499.837500812344;32645.67354326474;32651.18372040718;32656.510152347735;12495.812562811565;12633.684157896127;12641.810372844415;12649.177803442746;12688.302143382018;9649.855252171223;9815.411075335503;9936.950315248378;10311.432871192006;10362.378257304586;8147.75556733299;8148;8222.766585012176;8242.793930151794;8291.709790157316;3220.726238269773;3262.070309961697;3291.6050073991273;3316.054924346598;3342.448495998182;908.8227795579799;946.3091942881734;968.3366893677853;992.5235886774389;993.9751506212402;26063.609045864327;27324.180274591796;27526.724732752416;27747.722522774515;27822;954.0888451528773;988.8022395520925;1001.3491230700104;1020.2093377632394;1032.6437379104198;14213.289335533182;14581.781273280909;14595.78106328406;14842.851571484363;15016.774748378783;336661;341090;341389;341593;342988;44928.101437971054;46212;46300;46308.3053754194;46411.30383044257;1129.8022846001916;1227.3188380448937;1230.1819290171936;1232.778099942001;1345.5425155447194;24839.130630427848;25480;25488.872555637103;26075.087371941892;26162.215133546026;35625.1093722659;35786.28427431489;36147.096322592144;36163.457548137325;36227.63772362243;194562;195403;195695;195983;196372;23010.76989230086;25356.239312820646;26194.86902565475;26218.21345359642;26262.86868565645;35633;35651.70749150757;35925.1018724534;36326.09184770402;36517;29954.25114372158;31011.379772404878;31268.218294542818;31363.68636313699;31374.686253137177;32116.357672845945;33079;33194.170145745586;33474;33942;33216.83391583027;33972;34194.48708269428;34287.65712342845;34314.14214644654;29651.40697186001;30641;30802.537961931037;31009.844950776005;31241;23406.220819622144;23589;23598.410039749142;23621.52756944886;23796.0170185564 05:06:29 INFO - PROCESS | 20546 | |2;jquery.html;380.70305161973664;381.98663046793365;386.1639550373442;393.18806664238326;393.8168751530538;15704.52886413408;16647.66704665906;16990.915045424787;17144.314227430918;17150.485485435427;14787.778183327258;15313;15576.844231557681;15578.922105389485;15603;4639.118567472178;4725.692829966041;4795.0889331027165;4796.184648609745;4797.688150270239;3431.279431319426;5033.496650334974;5298.125809241471;5309.707966061865;5327.413984461726;5247.580193584504;5279.736013199344;5303.522682958533;5318.946810531903;5327.254184414185;5471.452854714516;5923.5853490255695;5932.822015339547;5946.821595352147;5971.134185543072;5156.458571849977;5243.082460569423;5284.233786101032;5331.946680533184;5334.946650533484;12471.625851224479;13713.588592342247;19838.40484785459;20027.89986050075;20031.89984050085;1823.917923693437;1919.4145785535407;1939.0111043367983;1951.375559820858;2006.3379084902094;5666.348369937468;8658.610362533702;9374.484403357812;9513.429194248367;9611.759706007337;1743.102302314309;1810.7555480010162;1829.1768704083215;1853.8053504382115;1855.1188185611861;67321.66339168322;68261.31738682599;68794.96807547941;68854.65572672155;71084.6445767773;10011.899881001242;10099.545520451597;10108.24188185889;10315.544292661893;10360.740981475372;14096.577102686935;14215.289235538181;14236.217008064448;14253.928730356489;14256.287185640676;6954.930450695429;7008.159020917421;7072.540284881569;7251;7262.854742905218;6634.336566343327;6698.363655452724;6726.22648395431;6749.3250674932115;6855.931440685529;4382.737035777864;4387.934180987288;4434.866953991385;4440.0241892358235;4441.933370999438;1697.2701738252424;1800.450862486928;1857.5449014991143;1860.1722233606185;1876.483966909111;775.2983549887362;857.9013413457533;867.3061550759494;885.7298523950128;947.3131979314942;15447.150406727738;15779.763303550455;16646.83353166477;16980.74528882068;17426.21582028812;842.3008902610818;898.2813749000774;950.1211379474097;954.0840792838814;969.576059850374;9162.496062716482;9583.137517623447;9617.807643847224;9622.182114520345;9781.657641982496;404897;408144;439269;448547;450034;78393;85639.57180214184;85848;86048.56975715082;87195.56402217949;954.6420092465326;956.1155930764015;977.61384253221;988.1304452082265;991.251605038206;15661.84338156604;15876.2061896907;15913.522594322189;15930.920345398663;16412.589685257964;30943.690563094082;31796.205094871886;33025.83487082549;33637.495437567966;33707.83146084352;46843.29735053909;47638.523614763406;48691.269630956274;48703;49211.50788492069;7650.923490765021;8020.598970051591;8045.477043992122;8119.863219149442;8154.14381489935;6260.593061450991;8052.315553177811;8207.1426429578;8480.279176270085;8483.74548763538;7418.36943859778;7458.403327733877;7462.701491940479;7570.432217583593;7772.261635144652;7344.339009489172;7568.772936811904;7585.2035536270105;7743.728969486041;7758.650860711395;7565.546067235983;7658.617069146632;7714.884276735966;7715.845683086419;7776.377889768692;10913.890861091606;10970.341779493256;11821.113416493625;11996.940015299868;12065.336406497376;11143.498542565441;11163.72090697739;11374;11404.144689148514;11542.711432213926 05:06:29 INFO - PROCESS | 20546 | |3;mootools.html;1242.689327668083;1289.6324547503964;1387.2092907042984;1406.2546850169408;1745.6421433606104;6935.375816176543;7698.307152356294;8026.879596806038;8089.191080891908;8091.595420228994;7667.808304792383;7830.41271904608;7848.8037799055055;7858.096318923325;7861.842763144734;2000.4998750312423;2044.8057434543769;2048.0988365119374;2288.9084436622516;2300.8849557522058;2302.7236731592234;2331.9766802332015;2350.1304517328613;2368.1829768729763;2371.537550177716;2239.7200349956256;2246.7528571857083;2249.3589327041796;2265.0713207584895;2332.370260029791;1919.184346652667;2252;2305.700258966332;2321.9535609287886;2325.813934885205;2293.334932869466;2304.2971893572453;2310.653401989698;2312.06361423622;2314.67594536765;7664.348530374925;7730.613469326511;7732;7737.3036426721865;7758.301752842215;4489.595936365743;4698.7650617469335;4705.1765940960195;4718.716876987358;4719.4100737407825;2750.6286651302016;2976.419598178356;2990.3421247325555;3010.2323907403693;3014.668386477486;946.5437190490734;952.1430712358863;953.918916892065;959.7744530035505;1006.6879267427121;11050.060744836617;11052.115830733523;11058.170637202242;11074.889251107466;11087.445627718662;4246.150769846043;4310.418093557392;4467.106578684211;4503.797329120198;4504.61710754583;9336.206422454032;9357.39176953496;9380.437173769596;9389.624415023323;9401.200897923616;4774.379330686988;4786.922942337947;4790.568848803555;4803.18345881201;4806.4712881583;3735.234276973214;3998.9600103998587;4345.152695224464;4367.47590289161;4404.185225733249;3730.813459327023;3737.028372623138;3808.3716186828865;3871.6515513603913;3873.8063096845044;1226.8957138643316;1228.5638598297476;1236.913416060885;1242.2236102435977;1249.5001999200392;746.5259560179217;750.9962450187714;760.4562737642501;768.8462307538515;769.6998170713426;4917.827876024394;4981.651284410129;5030.647854650212;5041.470645582161;5079.492050794891;428.6463667474346;431.1850602361539;431.6611460003882;433.06674117277316;436.13862621322636;3221.3557288542384;3257.9674203258137;3267.575215222006;3329.1011426914597;3341.5990081189925;9576.47329396876;9919.553620087114;10040.899591004143;10046.14607758334;10060.24548158891;9843.409395436296;9954.701358959242;9956.502174891226;9965.701028969142;9982.900170998342;7308.853822923512;7391.445641576904;7521.9247807522315;7542.962285188649;7582.35549978247;4917.0903382874285;4998.400191976986;5027.4218464877;5102.948970510396;5122.1804511278015;8772.429792063496;8830.984436789595;8945.686900958435;8991;9101.453912765255;8721.520316382406;9031.638734450811;9107.453552786854;9123.087691230823;9238.722838314861;6178.104174894705;6546.967265163644;6593.868122637617;6725.932740672531;6741.2921643226755;7299.452541059548;7326.743563975236;7332.30343117403;7365.1530074042175;7378.9631051846545;6476.935230647633;6520.967395162994;6539.869202616016;6550.115734375799;6769.830754231184;6445.581037232565;6471.094046833353;6483.286838447862;6498.187726534184;6499.6750162492635;6144.539159562962;6147.784827531015;6178.752849885954;6184;6201.596896201732;4312.741235525878;4318.740875547477;4327;4352.93470597935;4436.334549817424;4439.334099885043;4441.689081764374;4480.462344518679;4569.383133276965;4619.838305659286 05:06:29 INFO - PROCESS | 20546 | |4;prototype.html;315.6575115999141;322.40516247523317;326.5281667989754;327.17388593800666;327.2767184522209;5174.456682048382;5221.347331583552;5229.111051121309;5233.607479439038;5240.502152295536;5172.560332371743;5179.171332586787;5179.611529135311;5183.17069268917;5200.323957885479;3852.0947577319375;3930.253251882133;3983.760974341534;4049.919001619966;4065.085355794952;4016.236914986158;4037.313656678372;4059.127287633158;4059.3707975263883;4066.430699702044;3782.829772660223;4011.4785077939828;4016.3373043447796;4025.9597404026026;4030.8186131624147;3859.7298189126773;4001.459802926626;4007.939880901789;4018.276710192164;4022.5374081980654;3534.3461459630053;3550.804705741183;3554.0759402555263;3559.697425718817;3585.2829434113023;4942.382202224722;4945.480724523945;4949.059678661043;4969.552740253358;4997.85006449807;4544.250198717207;4591.265397536378;4632.0967411354795;4640.559146881041;4644.837430689943;5371.248025276464;5391.595630327741;5412.485813847678;5422.349318081855;5436.184572314145;3903.5315762108444;3915;3916.687909550304;3916.921661566781;3930.8034598269974;5513.3108361454815;5691.772329106872;5706.600537962386;5717.628354157008;5721.742521586497;3969.5236571611013;3995.880123596297;3997.220541994341;4007.5591684914634;4009.4787677601726;4053.7365071270274;4058.6347228748964;4059.1475790084414;4061.472008638858;4071.328230841878;4358.455193100863;4596.678232523758;4619.376384188159;4626.398568186181;4634.189016922025;5395.2986111806;5399.271098401744;5436.347638283352;5454.4545545445135;5466.781328746885;1422.2888555722138;1440.3302464354126;1446.240723620108;1448.7971683964254;1452.8111345525226;930.9813803723888;976.9755756106013;978.5303054533864;999.695092996643;1011.8330475471465;4746.121967435966;4763.785629646674;4765.142274390643;4766.713997160182;4800.903981920412;5599.944000560024;5615.438456154352;5641.379448260688;5641.943580564224;5641.9970910327065;4652.720836749806;4715.952840471551;4771.379720636364;4785.569298763058;4797.664163508521;2977.553366994968;2998;3017.532282496217;3021.6676165621766;3025.909222723322;5239.659422137549;5239.738013099406;5245.632805703641;5250.816221432308;5270;5497.240882917428;5737.569682273846;5850.882982340329;5851.356350801409;5856.882862342729;5324.653897496651;5332.33345831771;5339.466053394707;5349.117395629678;5354.839354819362;5410.675359478444;5689.975804355256;5691.069099413722;5721.427857214412;5737.942620573741;5526.088195447706;5526.309211348582;5534.142207957773;5549.112142057252;5557.833265002057;5280.471952804689;5288.259643649969;5292.100342941632;5341.41244463101;5352.116900711339;3728.5898551158807;3910.530736311661;3936.1340505088833;3959.703022273399;3973.7615743055508;5588.552915766811;5632.380438151718;5638.182463542846;5641;5644.8306550803545;5414.648047876875;5423.755930983037;5426.2674538936735;5455.754491047833;5465.234867118686;5323.707196104251;5386.8383948481605;5398.568114550748;5429.429909859408;5451.918221226764;5096.286519887145;5303.443138470405;5303.443138470405;5322.574194064543;5322.935412917354;5273.103572392626;5377.919331210113;5381.408045115112;5395.325584301962;5417.972910135424;5355;5365.114756065362;5393.40672526014;5402.217857803156;5403.891922161456 05:06:29 INFO - PROCESS | 20546 | |5;yui.html;632.8449529865184;635.0759644716934;639.4564620072936;706.580900544285;747.2154238050047;11724.062075033999;12096.637100886965;12275.63173104806;12277.079219058583;12304.93847530761;11229.382383968878;11242.775144497105;11256.38089905057;11294.943525282382;11295;640.378832532444;772.2277722277722;778.7702627724807;779.4310153587884;779.8752199648058;775.5269285735696;778.521209456186;786.3159051625095;786.8583654942108;787.8621241282781;813.9226773456512;816.9918300817005;817.6279792694339;817.9918200818005;818.3248819723722;815.3395749442941;816.1308206759782;817.166490180016;825.3727167352795;828.5028982610446;601.4196300569971;603.7856560920853;605.8788242351548;606.0727087556046;606.472369038939;12382.504699811996;12417.93791031048;12430.813537796941;12464.314462704548;12564.497420103186;12528.123031387806;12710.745785084338;12846.871531284754;12882.677933051655;13072.86927130726;9365.11031452011;9412.717618471457;9430.528473576294;9464.432134071909;9539.18916892065;3285.5400243965864;3323.567936168283;3336.548601358417;3392.0332705179153;3451.8964431067106;38270.23459530822;40884.591154088674;43058;43338.566614333766;44477.555224447664;10237.129843963197;10308.742281443025;10416.843747343795;10441.791164176673;10732.356058636507;17935.192916318796;18075.186616602285;18084.18621162051;18138.909305453653;18139.818601814077;7002.649867506706;7161.498695091398;7169.068021157216;7283.526570772989;7299.343059124704;3506.701930335899;3547.592026916938;3606;3684.8341824617955;3687.041369244016;3235.6764323567454;3391.542141810873;3392.5928888533535;3401.2347221875375;3408.5398471206568;545.5008667069666;548.7201527221066;552.4365147549557;555.7415801652251;561.0238185557183;505.8128492457814;517.9922301165485;542.4196110162168;545.3237984898776;563.4253061876944;7080.129000248077;7200.71197152108;7280.708771649075;7397.482176247719;7763.1848655891445;463.9211334073216;490.3478373762887;562.6680258647336;592.4135106244872;593.2465768474013;3344.4481660526226;3397.8980630581123;3414.9146271343416;3435.4159792835276;3574.088607405147;51463.48536514662;51553.48446515487;51735.48264517382;51949;52042.73978630082;47437;48550.27174592384;48766.512334876905;49096;49292.75353623209;42405.57594424016;42410.57589424128;43740;44235.77882110504;45670;6773.153355830521;6899.344562266577;6968.163820341591;7022.789316320519;7034.437245020488;30050;30485.54271685971;31158.22104447407;31308.843455782575;32162.678373216906;33019.17452063718;38161.6183838158;40590.39114413227;41325.38011929884;41349.8987575939;10046.196304295785;10091.24315676342;10105;10138.391696498235;10155.492225388552;10385.792284154426;10823.56705731762;10934.507947142556;11059.889401105886;11188.944055279671;10458.58165673395;10496.580136794748;10611.257211995395;10639;10802.297850639683;11005.119590432907;11084.224104312943;11207.327560346079;11275.887241127484;11673.416329183337;10120.746981325232;10128.392296462236;10614.1508679307;10615.416152111398;10648.946755266174;8408.747737567883;8551.315894728283;8640.481571105754;8766.736997890073;8817.647294108421;8237.382196335178;8421.663133474593;8490.73520621623;8541.273991710774;8693.130686931256 05:06:29 INFO - PROCESS | 20546 | __end_tp_report 05:06:29 INFO - PROCESS | 20546 | __start_cc_report 05:06:29 INFO - PROCESS | 20546 | _x_x_mozilla_cycle_collect,1057 05:06:29 INFO - PROCESS | 20546 | __end_cc_report 05:06:29 INFO - PROCESS | 20546 | __startTimestamp1461585989203__endTimestamp 05:06:29 INFO - PROCESS | 20546 | 05:06:29 INFO - PROCESS | 20546 | ------- Summary: start ------- 05:06:29 INFO - PROCESS | 20546 | Number of tests: 6 05:06:29 INFO - PROCESS | 20546 | 05:06:29 INFO - PROCESS | 20546 | [#0] dojo.html Cycles:165 Average:4646.72 Median:4792.57 stddev:485.37 (10.1%) stddev-sans-first:459.83 05:06:29 INFO - PROCESS | 20546 | Values: 2610.9 2619.3 2662.5 2673.2 2676.1 4597.3 4646.5 4657.0 4676.2 4681.5 4677.4 4733.6 4743.8 4768.5 4770.1 4271.1 4287.1 4322.2 4354.9 4457.6 4359.6 4393.4 4409.7 4422.0 4456.8 4193.2 4280.1 4282.1 4306.6 4368.0 4331.4 4363.1 4365.2 4366.8 4416.0 4331.2 4346.8 4360.8 4380.4 4394.5 4444.0 4513.6 4559.1 4646.5 4661.5 5022.3 5041.2 5054.6 5058.3 5115.5 5065.8 5080.1 5086.1 5092.0 5098.1 4565.3 4571.7 4616.1 4658.3 4661.5 5079.2 5081.9 5089.9 5090.4 5097.6 4849.7 4874.0 4875.3 4880.0 4943.5 5009.8 5086.5 5097.8 5106.4 5115.5 4983.9 4985.1 4985.9 4991.3 5033.3 4947.5 4954.7 4957.4 4970.1 5010.6 4143.4 4204.3 4207.3 4222.7 4304.4 3688.8 3698.6 3703.2 3726.4 3730.9 4326.7 4331.0 4338.8 4373.4 4377.6 4913.0 4976.8 5002.4 5027.7 5061.5 4321.7 4340.3 4352.2 4356.0 4376.3 4486.3 4512.4 4513.9 4524.6 4562.5 4548.3 4730.6 4794.2 4811.8 4815.6 5080.7 5085.7 5104.4 5114.0 5154.7 4784.2 4792.6 4793.7 4794.5 4795.6 4827.2 4948.0 5004.9 5043.0 5053.6 5035.5 5079.0 5080.6 5082.9 5130.9 4760.7 4920.3 4931.7 4934.6 4981.5 4824.7 4896.7 4918.2 4975.1 4975.2 4788.8 4801.3 4801.9 4815.1 4817.5 4762.3 4874.9 4927.0 4945.3 4950.5 4729.0 4828.0 4850.7 4852.2 4931.3 05:06:29 INFO - PROCESS | 20546 | 05:06:29 INFO - PROCESS | 20546 | [#1] ext.html Cycles:180 Average:40221.49 Median:18185.30 stddev:69874.78 (384.2%) stddev-sans-first:70007.35 05:06:29 INFO - PROCESS | 20546 | Values: 563.3 601.1 611.0 613.8 627.5 26684.0 33367.2 34367.8 34459.0 34497.7 39718.6 40333.2 40478.0 40536.6 40547.8 7251.6 7462.7 7464.1 7825.1 8020.9 7386.3 9866.2 10241.9 10251.8 10252.7 10065.7 10165.2 10169.5 10170.1 10170.2 7519.6 9882.8 9951.2 10001.3 10021.0 9837.1 9972.3 9998.5 10002.9 10013.3 34142.7 34664.5 34731.3 34762.0 34846.7 2758.3 2843.9 2934.5 3262.4 3445.1 26873.0 27343.2 27929.0 28656.0 28904.6 3450.9 3521.5 3534.1 3549.8 3563.2 239482.0 240677.0 240841.0 241186.8 241953.0 33877.5 34975.0 56316.0 57166.7 57319.1 32448.8 32499.8 32645.7 32651.2 32656.5 12495.8 12633.7 12641.8 12649.2 12688.3 9649.9 9815.4 9937.0 10311.4 10362.4 8147.8 8148.0 8222.8 8242.8 8291.7 3220.7 3262.1 3291.6 3316.1 3342.4 908.8 946.3 968.3 992.5 994.0 26063.6 27324.2 27526.7 27747.7 27822.0 954.1 988.8 1001.3 1020.2 1032.6 14213.3 14581.8 14595.8 14842.9 15016.8 336661.0 341090.0 341389.0 341593.0 342988.0 44928.1 46212.0 46300.0 46308.3 46411.3 1129.8 1227.3 1230.2 1232.8 1345.5 24839.1 25480.0 25488.9 26075.1 26162.2 35625.1 35786.3 36147.1 36163.5 36227.6 194562.0 195403.0 195695.0 195983.0 196372.0 23010.8 25356.2 26194.9 26218.2 26262.9 35633.0 35651.7 35925.1 36326.1 36517.0 29954.3 31011.4 31268.2 31363.7 31374.7 32116.4 33079.0 33194.2 33474.0 33942.0 33216.8 33972.0 34194.5 34287.7 34314.1 29651.4 30641.0 30802.5 31009.8 31241.0 23406.2 23589.0 23598.4 23621.5 23796.0 05:06:29 INFO - PROCESS | 20546 | 05:06:29 INFO - PROCESS | 20546 | [#2] jquery.html Cycles:180 Average:25093.46 Median:27122.50 stddev:71051.54 (262.0%) stddev-sans-first:71226.63 05:06:29 INFO - PROCESS | 20546 | Values: 380.7 382.0 386.2 393.2 393.8 15704.5 16647.7 16990.9 17144.3 17150.5 14787.8 15313.0 15576.8 15578.9 15603.0 4639.1 4725.7 4795.1 4796.2 4797.7 3431.3 5033.5 5298.1 5309.7 5327.4 5247.6 5279.7 5303.5 5318.9 5327.3 5471.5 5923.6 5932.8 5946.8 5971.1 5156.5 5243.1 5284.2 5331.9 5334.9 12471.6 13713.6 19838.4 20027.9 20031.9 1823.9 1919.4 1939.0 1951.4 2006.3 5666.3 8658.6 9374.5 9513.4 9611.8 1743.1 1810.8 1829.2 1853.8 1855.1 67321.7 68261.3 68795.0 68854.7 71084.6 10011.9 10099.5 10108.2 10315.5 10360.7 14096.6 14215.3 14236.2 14253.9 14256.3 6954.9 7008.2 7072.5 7251.0 7262.9 6634.3 6698.4 6726.2 6749.3 6855.9 4382.7 4387.9 4434.9 4440.0 4441.9 1697.3 1800.5 1857.5 1860.2 1876.5 775.3 857.9 867.3 885.7 947.3 15447.2 15779.8 16646.8 16980.7 17426.2 842.3 898.3 950.1 954.1 969.6 9162.5 9583.1 9617.8 9622.2 9781.7 404897.0 408144.0 439269.0 448547.0 450034.0 78393.0 85639.6 85848.0 86048.6 87195.6 954.6 956.1 977.6 988.1 991.3 15661.8 15876.2 15913.5 15930.9 16412.6 30943.7 31796.2 33025.8 33637.5 33707.8 46843.3 47638.5 48691.3 48703.0 49211.5 7650.9 8020.6 8045.5 8119.9 8154.1 6260.6 8052.3 8207.1 8480.3 8483.7 7418.4 7458.4 7462.7 7570.4 7772.3 7344.3 7568.8 7585.2 7743.7 7758.7 7565.5 7658.6 7714.9 7715.8 7776.4 10913.9 10970.3 11821.1 11996.9 12065.3 11143.5 11163.7 11374.0 11404.1 11542.7 05:06:29 INFO - PROCESS | 20546 | 05:06:29 INFO - PROCESS | 20546 | [#3] mootools.html Cycles:180 Average:5145.47 Median:4788.75 stddev:2940.19 (61.4%) stddev-sans-first:2933.81 05:06:29 INFO - PROCESS | 20546 | Values: 1242.7 1289.6 1387.2 1406.3 1745.6 6935.4 7698.3 8026.9 8089.2 8091.6 7667.8 7830.4 7848.8 7858.1 7861.8 2000.5 2044.8 2048.1 2288.9 2300.9 2302.7 2332.0 2350.1 2368.2 2371.5 2239.7 2246.8 2249.4 2265.1 2332.4 1919.2 2252.0 2305.7 2322.0 2325.8 2293.3 2304.3 2310.7 2312.1 2314.7 7664.3 7730.6 7732.0 7737.3 7758.3 4489.6 4698.8 4705.2 4718.7 4719.4 2750.6 2976.4 2990.3 3010.2 3014.7 946.5 952.1 953.9 959.8 1006.7 11050.1 11052.1 11058.2 11074.9 11087.4 4246.2 4310.4 4467.1 4503.8 4504.6 9336.2 9357.4 9380.4 9389.6 9401.2 4774.4 4786.9 4790.6 4803.2 4806.5 3735.2 3999.0 4345.2 4367.5 4404.2 3730.8 3737.0 3808.4 3871.7 3873.8 1226.9 1228.6 1236.9 1242.2 1249.5 746.5 751.0 760.5 768.8 769.7 4917.8 4981.7 5030.6 5041.5 5079.5 428.6 431.2 431.7 433.1 436.1 3221.4 3258.0 3267.6 3329.1 3341.6 9576.5 9919.6 10040.9 10046.1 10060.2 9843.4 9954.7 9956.5 9965.7 9982.9 7308.9 7391.4 7521.9 7543.0 7582.4 4917.1 4998.4 5027.4 5102.9 5122.2 8772.4 8831.0 8945.7 8991.0 9101.5 8721.5 9031.6 9107.5 9123.1 9238.7 6178.1 6547.0 6593.9 6725.9 6741.3 7299.5 7326.7 7332.3 7365.2 7379.0 6476.9 6521.0 6539.9 6550.1 6769.8 6445.6 6471.1 6483.3 6498.2 6499.7 6144.5 6147.8 6178.8 6184.0 6201.6 4312.7 4318.7 4327.0 4352.9 4436.3 4439.3 4441.7 4480.5 4569.4 4619.8 05:06:29 INFO - PROCESS | 20546 | 05:06:29 INFO - PROCESS | 20546 | [#4] prototype.html Cycles:180 Average:4519.16 Median:5181.39 stddev:1307.84 (25.2%) stddev-sans-first:1272.88 05:06:29 INFO - PROCESS | 20546 | Values: 315.7 322.4 326.5 327.2 327.3 5174.5 5221.3 5229.1 5233.6 5240.5 5172.6 5179.2 5179.6 5183.2 5200.3 3852.1 3930.3 3983.8 4049.9 4065.1 4016.2 4037.3 4059.1 4059.4 4066.4 3782.8 4011.5 4016.3 4026.0 4030.8 3859.7 4001.5 4007.9 4018.3 4022.5 3534.3 3550.8 3554.1 3559.7 3585.3 4942.4 4945.5 4949.1 4969.6 4997.9 4544.3 4591.3 4632.1 4640.6 4644.8 5371.2 5391.6 5412.5 5422.3 5436.2 3903.5 3915.0 3916.7 3916.9 3930.8 5513.3 5691.8 5706.6 5717.6 5721.7 3969.5 3995.9 3997.2 4007.6 4009.5 4053.7 4058.6 4059.1 4061.5 4071.3 4358.5 4596.7 4619.4 4626.4 4634.2 5395.3 5399.3 5436.3 5454.5 5466.8 1422.3 1440.3 1446.2 1448.8 1452.8 931.0 977.0 978.5 999.7 1011.8 4746.1 4763.8 4765.1 4766.7 4800.9 5599.9 5615.4 5641.4 5641.9 5642.0 4652.7 4716.0 4771.4 4785.6 4797.7 2977.6 2998.0 3017.5 3021.7 3025.9 5239.7 5239.7 5245.6 5250.8 5270.0 5497.2 5737.6 5850.9 5851.4 5856.9 5324.7 5332.3 5339.5 5349.1 5354.8 5410.7 5690.0 5691.1 5721.4 5737.9 5526.1 5526.3 5534.1 5549.1 5557.8 5280.5 5288.3 5292.1 5341.4 5352.1 3728.6 3910.5 3936.1 3959.7 3973.8 5588.6 5632.4 5638.2 5641.0 5644.8 5414.6 5423.8 5426.3 5455.8 5465.2 5323.7 5386.8 5398.6 5429.4 5451.9 5096.3 5303.4 5303.4 5322.6 5322.9 5273.1 5377.9 5381.4 5395.3 5418.0 5355.0 5365.1 5393.4 5402.2 5403.9 05:06:29 INFO - PROCESS | 20546 | 05:06:29 INFO - PROCESS | 20546 | [#5] yui.html Cycles:180 Average:12619.01 Median:43539.28 stddev:14488.01 (33.3%) stddev-sans-first:14500.69 05:06:29 INFO - PROCESS | 20546 | Values: 632.8 635.1 639.5 706.6 747.2 11724.1 12096.6 12275.6 12277.1 12304.9 11229.4 11242.8 11256.4 11294.9 11295.0 640.4 772.2 778.8 779.4 779.9 775.5 778.5 786.3 786.9 787.9 813.9 817.0 817.6 818.0 818.3 815.3 816.1 817.2 825.4 828.5 601.4 603.8 605.9 606.1 606.5 12382.5 12417.9 12430.8 12464.3 12564.5 12528.1 12710.7 12846.9 12882.7 13072.9 9365.1 9412.7 9430.5 9464.4 9539.2 3285.5 3323.6 3336.5 3392.0 3451.9 38270.2 40884.6 43058.0 43338.6 44477.6 10237.1 10308.7 10416.8 10441.8 10732.4 17935.2 18075.2 18084.2 18138.9 18139.8 7002.6 7161.5 7169.1 7283.5 7299.3 3506.7 3547.6 3606.0 3684.8 3687.0 3235.7 3391.5 3392.6 3401.2 3408.5 545.5 548.7 552.4 555.7 561.0 505.8 518.0 542.4 545.3 563.4 7080.1 7200.7 7280.7 7397.5 7763.2 463.9 490.3 562.7 592.4 593.2 3344.4 3397.9 3414.9 3435.4 3574.1 51463.5 51553.5 51735.5 51949.0 52042.7 47437.0 48550.3 48766.5 49096.0 49292.8 42405.6 42410.6 43740.0 44235.8 45670.0 6773.2 6899.3 6968.2 7022.8 7034.4 30050.0 30485.5 31158.2 31308.8 32162.7 33019.2 38161.6 40590.4 41325.4 41349.9 10046.2 10091.2 10105.0 10138.4 10155.5 10385.8 10823.6 10934.5 11059.9 11188.9 10458.6 10496.6 10611.3 10639.0 10802.3 11005.1 11084.2 11207.3 11275.9 11673.4 10120.7 10128.4 10614.2 10615.4 10648.9 8408.7 8551.3 8640.5 8766.7 8817.6 8237.4 8421.7 8490.7 8541.3 8693.1 05:06:29 INFO - PROCESS | 20546 | -------- Summary: end -------- 05:06:29 INFO - PROCESS | 20546 | 05:06:29 INFO - TEST-INFO | 20546: exit 0 05:06:30 INFO - TEST-OK | dromaeo_css | took 1118308ms 05:06:30 INFO - TEST-START | kraken 05:06:30 INFO - operating with platform_type : linux_ 05:06:30 INFO - Initialising browser for kraken test... 05:06:30 INFO - TEST-INFO | started process 20725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXdrGEs/profile http://localhost:59079/getInfo.html) 05:06:34 INFO - PROCESS | 20725 | __metrics Screen width/height:1600/1200 05:06:34 INFO - PROCESS | 20725 | colorDepth:24 05:06:34 INFO - PROCESS | 20725 | Browser inner width/height: 1024/697 05:06:34 INFO - PROCESS | 20725 | __metrics 05:06:35 ERROR - PROCESS | 20725 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:06:35 INFO - TEST-INFO | 20725: exit 0 05:06:35 INFO - Browser initialized. 05:06:35 INFO - Running cycle 1/1 for kraken test... 05:06:35 INFO - TEST-INFO | started process 20803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXdrGEs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:47 INFO - PROCESS | 20803 | RSS: Main: 155680768 05:06:47 INFO - PROCESS | 20803 | 05:06:50 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59079/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:51 INFO - PROCESS | 20803 | RSS: Main: 209645568 05:06:51 INFO - PROCESS | 20803 | 05:06:54 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59079/tests/kraken/driver.html?testName=audio-dft) 05:06:54 INFO - PROCESS | 20803 | RSS: Main: 195706880 05:06:54 INFO - PROCESS | 20803 | 05:06:58 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59079/tests/kraken/driver.html?testName=audio-fft) 05:06:58 INFO - PROCESS | 20803 | RSS: Main: 266575872 05:06:58 INFO - PROCESS | 20803 | 05:07:00 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59079/tests/kraken/driver.html?testName=audio-oscillator) 05:07:01 INFO - PROCESS | 20803 | RSS: Main: 175013888 05:07:01 INFO - PROCESS | 20803 | 05:07:03 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59079/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:07:04 INFO - PROCESS | 20803 | RSS: Main: 179806208 05:07:04 INFO - PROCESS | 20803 | 05:07:07 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59079/tests/kraken/driver.html?testName=imaging-darkroom) 05:07:07 INFO - PROCESS | 20803 | RSS: Main: 215699456 05:07:07 INFO - PROCESS | 20803 | 05:07:11 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59079/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:11 INFO - PROCESS | 20803 | RSS: Main: 216121344 05:07:11 INFO - PROCESS | 20803 | 05:07:14 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59079/tests/kraken/driver.html?testName=json-parse-financial) 05:07:15 INFO - PROCESS | 20803 | RSS: Main: 215969792 05:07:15 INFO - PROCESS | 20803 | 05:07:17 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59079/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:17 INFO - PROCESS | 20803 | RSS: Main: 201420800 05:07:17 INFO - PROCESS | 20803 | 05:07:19 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59079/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:20 INFO - PROCESS | 20803 | RSS: Main: 204742656 05:07:20 INFO - PROCESS | 20803 | 05:07:22 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59079/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:23 INFO - PROCESS | 20803 | RSS: Main: 218734592 05:07:23 INFO - PROCESS | 20803 | 05:07:25 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:26 INFO - PROCESS | 20803 | RSS: Main: 224243712 05:07:26 INFO - PROCESS | 20803 | 05:07:29 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:30 INFO - PROCESS | 20803 | RSS: Main: 217698304 05:07:30 INFO - PROCESS | 20803 | 05:07:31 INFO - PROCESS | 20803 | Cycle 1(1): loaded http://localhost:59079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59079/tests/kraken/driver.html?testName=ai-astar) 05:07:32 INFO - PROCESS | 20803 | RSS: Main: 281546752 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | __start_tp_report 05:07:32 INFO - PROCESS | 20803 | _x_x_mozilla_page_load 05:07:32 INFO - PROCESS | 20803 | _x_x_mozilla_page_load_details 05:07:32 INFO - PROCESS | 20803 | |i|pagename|runs| 05:07:32 INFO - PROCESS | 20803 | |0;ai-astar;111;113;106;112;112;112;103;114;111;113 05:07:32 INFO - PROCESS | 20803 | |1;audio-beat-detection;164;132;153;188;133;161;154;142;192;132 05:07:32 INFO - PROCESS | 20803 | |2;audio-dft;161;162;161;162;162;162;161;164;160;160 05:07:32 INFO - PROCESS | 20803 | |3;audio-fft;75;77;124;103;75;73;74;112;99;73 05:07:32 INFO - PROCESS | 20803 | |4;audio-oscillator;94;94;144;93;94;94;142;93;93;143 05:07:32 INFO - PROCESS | 20803 | |5;imaging-gaussian-blur;116;117;117;116;116;116;117;117;117;116 05:07:32 INFO - PROCESS | 20803 | |6;imaging-darkroom;147;145;147;147;146;145;147;146;145;146 05:07:32 INFO - PROCESS | 20803 | |7;imaging-desaturate;95;95;94;95;95;95;95;94;94;95 05:07:32 INFO - PROCESS | 20803 | |8;json-parse-financial;66;65;66;65;66;66;66;83;65;63 05:07:32 INFO - PROCESS | 20803 | |9;json-stringify-tinderbox;64;64;65;65;65;65;66;64;65;65 05:07:32 INFO - PROCESS | 20803 | |10;stanford-crypto-aes;80;78;79;78;88;80;79;79;81;80 05:07:32 INFO - PROCESS | 20803 | |11;stanford-crypto-ccm;135;142;146;132;131;142;134;132;167;137 05:07:32 INFO - PROCESS | 20803 | |12;stanford-crypto-pbkdf2;193;177;175;178;177;178;176;176;186;176 05:07:32 INFO - PROCESS | 20803 | |13;stanford-crypto-sha256-iterative;82;72;73;72;72;71;82;71;71;72 05:07:32 INFO - PROCESS | 20803 | __end_tp_report 05:07:32 INFO - PROCESS | 20803 | __start_cc_report 05:07:32 INFO - PROCESS | 20803 | _x_x_mozilla_cycle_collect,1908 05:07:32 INFO - PROCESS | 20803 | __end_cc_report 05:07:32 INFO - PROCESS | 20803 | __startTimestamp1461586052180__endTimestamp 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | ------- Summary: start ------- 05:07:32 INFO - PROCESS | 20803 | Number of tests: 14 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.47 (3.1%) stddev-sans-first:3.67 05:07:32 INFO - PROCESS | 20803 | Values: 111.0 113.0 106.0 112.0 112.0 112.0 103.0 114.0 111.0 113.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:157.50 stddev:21.83 (13.9%) stddev-sans-first:22.92 05:07:32 INFO - PROCESS | 20803 | Values: 164.0 132.0 153.0 188.0 133.0 161.0 154.0 142.0 192.0 132.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 05:07:32 INFO - PROCESS | 20803 | Values: 161.0 162.0 161.0 162.0 162.0 162.0 161.0 164.0 160.0 160.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#3] audio-fft Cycles:10 Average:88.50 Median:74.50 stddev:19.21 (25.8%) stddev-sans-first:19.74 05:07:32 INFO - PROCESS | 20803 | Values: 75.0 77.0 124.0 103.0 75.0 73.0 74.0 112.0 99.0 73.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.50 stddev:23.88 (25.5%) stddev-sans-first:24.76 05:07:32 INFO - PROCESS | 20803 | Values: 94.0 94.0 144.0 93.0 94.0 94.0 142.0 93.0 93.0 143.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:07:32 INFO - PROCESS | 20803 | Values: 116.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 05:07:32 INFO - PROCESS | 20803 | Values: 147.0 145.0 147.0 147.0 146.0 145.0 147.0 146.0 145.0 146.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:07:32 INFO - PROCESS | 20803 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:66.00 stddev:5.67 (8.6%) stddev-sans-first:6.00 05:07:32 INFO - PROCESS | 20803 | Values: 66.0 65.0 66.0 65.0 66.0 66.0 66.0 83.0 65.0 63.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 05:07:32 INFO - PROCESS | 20803 | Values: 64.0 64.0 65.0 65.0 65.0 65.0 66.0 64.0 65.0 65.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:2.90 (3.6%) stddev-sans-first:3.07 05:07:32 INFO - PROCESS | 20803 | Values: 80.0 78.0 79.0 78.0 88.0 80.0 79.0 79.0 81.0 80.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:139.50 stddev:10.81 (7.7%) stddev-sans-first:11.32 05:07:32 INFO - PROCESS | 20803 | Values: 135.0 142.0 146.0 132.0 131.0 142.0 134.0 132.0 167.0 137.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:177.50 stddev:5.75 (3.2%) stddev-sans-first:3.28 05:07:32 INFO - PROCESS | 20803 | Values: 193.0 177.0 175.0 178.0 177.0 178.0 176.0 176.0 186.0 176.0 05:07:32 INFO - PROCESS | 20803 | 05:07:32 INFO - PROCESS | 20803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:72.00 stddev:4.37 (6.1%) stddev-sans-first:3.48 05:07:32 INFO - PROCESS | 20803 | Values: 82.0 72.0 73.0 72.0 72.0 71.0 82.0 71.0 71.0 72.0 05:07:32 INFO - PROCESS | 20803 | -------- Summary: end -------- 05:07:32 INFO - PROCESS | 20803 | 05:07:33 INFO - TEST-INFO | 20803: exit 0 05:07:33 INFO - TEST-OK | kraken | took 63219ms 05:07:33 INFO - SUITE-END | took 1181s 05:07:33 INFO - Completed test suite (00:19:41) 05:07:33 INFO - javascript benchmark 05:07:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.8694565271735, 2619.305883940757, 2662.4675064987, 2673.1846786730052, 2676.1436340371088, 4597.3104034394855, 4646.535346465352, 4656.999999999995, 4676.181668208059, 4681.508441613629, 4677.415323084614, 4733.621310295177, 4743.762811859402, 4768.47546769855, 4770.117528257275, 4271.103068355634, 4287.078278170201, 4322.200392927302, 4354.934675979863, 4457.621102206316, 4359.629431498311, 4393.428854248943, 4409.735415875058, 4421.977890110545, 4456.754878481682, 4193.2242535130945, 4280.101178752435, 4282.100758840647, 4306.6124048835445, 4367.978160109179, 4331.415258940035, 4363.149185908749, 4365.236083685342, 4366.8034938427845, 4415.977920110379, 4331.155424692186, 4346.826126954918, 4360.847370342054, 4380.408644832939, 4394.538573449806, 4444.000099977511, 4513.571210734975, 4559.088182363507, 4646.53534646536, 4661.510541393139, 5022.27177059328, 5041.218611115283, 5054.62090343222, 5058.266551350033, 5115.514026167545, 5065.797368105272, 5080.110980578384, 5086.109930762102, 5091.974540127313, 5098.133317336062, 4565.269556870918, 4571.657125715585, 4616.099860527165, 4658.254679251304, 4661.510541393105, 5079.212722028092, 5081.923771143436, 5089.8727531812, 5090.389153301553, 5097.592192624581, 4849.733264670406, 4873.975630121898, 4875.293082503017, 4880.0, 4943.456219815817, 5009.824656137091, 5086.4659210783075, 5097.8215762448135, 5106.412762532356, 5115.462876397999, 4983.9252411213865, 4985.077760614298, 4985.875353116201, 4991.301217829507, 5033.345665063518, 4947.480514545993, 4954.677945933503, 4957.355543779286, 4970.130227210224, 5010.574101201439, 4143.399207114951, 4204.285271503791, 4207.305794543927, 4222.704410691222, 4304.397384366192, 3688.7971161585833, 3698.6301369863336, 3703.185299234164, 3726.366517691999, 3730.850765969385, 4326.675499337499, 4330.978345108254, 4338.848140315137, 4373.365861950063, 4377.584129507692, 4913.0, 4976.751162441936, 5002.424721157041, 5027.698338099653, 5061.493850614909, 4321.719088259316, 4340.283853164256, 4352.173087113439, 4356.0, 4376.343548467756, 4486.282194848808, 4512.413386259831, 4513.932291015637, 4524.615407690383, 4562.475315338778, 4548.317752337242, 4730.6215502759005, 4794.161021821167, 4811.807527698993, 4815.590674792542, 5080.695158290514, 5085.720285384339, 5104.3619547556555, 5113.977204559029, 5154.690718556899, 4784.210605250095, 4792.568668819684, 4793.664443488922, 4794.544518270759, 4795.640326975421, 4827.155247831685, 4947.975260123821, 5004.924926126038, 5043.0, 5053.646244762831, 5035.521625445577, 5079.0, 5080.568151707146, 5082.923756143735, 5130.923036154386, 4760.666753327234, 4920.335754673073, 4931.728754918514, 4934.55588996992, 4981.501849814989, 4824.662273640812, 4896.730679812645, 4918.188498897642, 4975.10448119342, 4975.228839529878, 4788.808447662054, 4801.279808028824, 4801.927971080367, 4815.061063092663, 4817.542333478314, 4762.261849413347, 4874.8537543873745, 4927.01459708067, 4945.282933974626, 4950.455449900436, 4728.97635511834, 4828.03439312146, 4850.733209673502, 4852.17513022794, 4931.284963680175], "value": 4616.009845491313, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2621266141355, 601.1013534765526, 611.0315150486479, 613.7514306705783, 627.4666533446571, 26684.0, 33367.16582085449, 34367.828160859164, 34459.0, 34497.655023449755, 39718.602813971855, 40333.19333613326, 40478.0, 40536.594634053654, 40547.79726101373, 7251.6374181290985, 7462.664180111908, 7464.141623713288, 7825.060992680872, 8020.879686804703, 7386.335229829314, 9866.210703143766, 10241.897581024168, 10251.846222306634, 10252.74368140795, 10065.698029059104, 10165.186785057178, 10169.54237059334, 10170.084692377684, 10170.186385089175, 7519.586422746746, 9882.802343953117, 9951.154151897097, 10001.29990900641, 10021.0, 9837.065478779505, 9972.301938864282, 9998.500074996222, 10002.89997100027, 10013.299069065168, 34142.6585734142, 34664.480032799525, 34731.30537389263, 34762.0, 34846.6515334846, 2758.2828464599147, 2843.8720257588457, 2934.4717950768854, 3262.402892849329, 3445.104272889067, 26873.0, 27343.179704608894, 27929.0, 28656.0, 28904.566431503543, 3450.913727156816, 3521.4893840393, 3534.134137136418, 3549.769264997767, 3563.198280386918, 239482.0, 240677.0, 240841.0, 241186.7940660303, 241953.0, 33877.49183762245, 34975.0, 56316.0, 57166.7141664289, 57319.14021289684, 32448.83775581107, 32499.837500812344, 32645.67354326474, 32651.18372040718, 32656.510152347735, 12495.812562811565, 12633.684157896127, 12641.810372844415, 12649.177803442746, 12688.302143382018, 9649.855252171223, 9815.411075335503, 9936.950315248378, 10311.432871192006, 10362.378257304586, 8147.75556733299, 8148.0, 8222.766585012176, 8242.793930151794, 8291.709790157316, 3220.726238269773, 3262.070309961697, 3291.6050073991273, 3316.054924346598, 3342.448495998182, 908.8227795579799, 946.3091942881734, 968.3366893677853, 992.5235886774389, 993.9751506212402, 26063.609045864327, 27324.180274591796, 27526.724732752416, 27747.722522774515, 27822.0, 954.0888451528773, 988.8022395520925, 1001.3491230700104, 1020.2093377632394, 1032.6437379104198, 14213.289335533182, 14581.781273280909, 14595.78106328406, 14842.851571484363, 15016.774748378783, 336661.0, 341090.0, 341389.0, 341593.0, 342988.0, 44928.101437971054, 46212.0, 46300.0, 46308.3053754194, 46411.30383044257, 1129.8022846001916, 1227.3188380448937, 1230.1819290171936, 1232.778099942001, 1345.5425155447194, 24839.130630427848, 25480.0, 25488.872555637103, 26075.087371941892, 26162.215133546026, 35625.1093722659, 35786.28427431489, 36147.096322592144, 36163.457548137325, 36227.63772362243, 194562.0, 195403.0, 195695.0, 195983.0, 196372.0, 23010.76989230086, 25356.239312820646, 26194.86902565475, 26218.21345359642, 26262.86868565645, 35633.0, 35651.70749150757, 35925.1018724534, 36326.09184770402, 36517.0, 29954.25114372158, 31011.379772404878, 31268.218294542818, 31363.68636313699, 31374.686253137177, 32116.357672845945, 33079.0, 33194.170145745586, 33474.0, 33942.0, 33216.83391583027, 33972.0, 34194.48708269428, 34287.65712342845, 34314.14214644654, 29651.40697186001, 30641.0, 30802.537961931037, 31009.844950776005, 31241.0, 23406.220819622144, 23589.0, 23598.410039749142, 23621.52756944886, 23796.0170185564], "value": 16015.93730911987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.70305161973664, 381.98663046793365, 386.1639550373442, 393.18806664238326, 393.8168751530538, 15704.52886413408, 16647.66704665906, 16990.915045424787, 17144.314227430918, 17150.485485435427, 14787.778183327258, 15313.0, 15576.844231557681, 15578.922105389485, 15603.0, 4639.118567472178, 4725.692829966041, 4795.0889331027165, 4796.184648609745, 4797.688150270239, 3431.279431319426, 5033.496650334974, 5298.125809241471, 5309.707966061865, 5327.413984461726, 5247.580193584504, 5279.736013199344, 5303.522682958533, 5318.946810531903, 5327.254184414185, 5471.452854714516, 5923.5853490255695, 5932.822015339547, 5946.821595352147, 5971.134185543072, 5156.458571849977, 5243.082460569423, 5284.233786101032, 5331.946680533184, 5334.946650533484, 12471.625851224479, 13713.588592342247, 19838.40484785459, 20027.89986050075, 20031.89984050085, 1823.917923693437, 1919.4145785535407, 1939.0111043367983, 1951.375559820858, 2006.3379084902094, 5666.348369937468, 8658.610362533702, 9374.484403357812, 9513.429194248367, 9611.759706007337, 1743.102302314309, 1810.7555480010162, 1829.1768704083215, 1853.8053504382115, 1855.1188185611861, 67321.66339168322, 68261.31738682599, 68794.96807547941, 68854.65572672155, 71084.6445767773, 10011.899881001242, 10099.545520451597, 10108.24188185889, 10315.544292661893, 10360.740981475372, 14096.577102686935, 14215.289235538181, 14236.217008064448, 14253.928730356489, 14256.287185640676, 6954.930450695429, 7008.159020917421, 7072.540284881569, 7251.0, 7262.854742905218, 6634.336566343327, 6698.363655452724, 6726.22648395431, 6749.3250674932115, 6855.931440685529, 4382.737035777864, 4387.934180987288, 4434.866953991385, 4440.0241892358235, 4441.933370999438, 1697.2701738252424, 1800.450862486928, 1857.5449014991143, 1860.1722233606185, 1876.483966909111, 775.2983549887362, 857.9013413457533, 867.3061550759494, 885.7298523950128, 947.3131979314942, 15447.150406727738, 15779.763303550455, 16646.83353166477, 16980.74528882068, 17426.21582028812, 842.3008902610818, 898.2813749000774, 950.1211379474097, 954.0840792838814, 969.576059850374, 9162.496062716482, 9583.137517623447, 9617.807643847224, 9622.182114520345, 9781.657641982496, 404897.0, 408144.0, 439269.0, 448547.0, 450034.0, 78393.0, 85639.57180214184, 85848.0, 86048.56975715082, 87195.56402217949, 954.6420092465326, 956.1155930764015, 977.61384253221, 988.1304452082265, 991.251605038206, 15661.84338156604, 15876.2061896907, 15913.522594322189, 15930.920345398663, 16412.589685257964, 30943.690563094082, 31796.205094871886, 33025.83487082549, 33637.495437567966, 33707.83146084352, 46843.29735053909, 47638.523614763406, 48691.269630956274, 48703.0, 49211.50788492069, 7650.923490765021, 8020.598970051591, 8045.477043992122, 8119.863219149442, 8154.14381489935, 6260.593061450991, 8052.315553177811, 8207.1426429578, 8480.279176270085, 8483.74548763538, 7418.36943859778, 7458.403327733877, 7462.701491940479, 7570.432217583593, 7772.261635144652, 7344.339009489172, 7568.772936811904, 7585.2035536270105, 7743.728969486041, 7758.650860711395, 7565.546067235983, 7658.617069146632, 7714.884276735966, 7715.845683086419, 7776.377889768692, 10913.890861091606, 10970.341779493256, 11821.113416493625, 11996.940015299868, 12065.336406497376, 11143.498542565441, 11163.72090697739, 11374.0, 11404.144689148514, 11542.711432213926], "value": 7986.625030502528, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.689327668083, 1289.6324547503964, 1387.2092907042984, 1406.2546850169408, 1745.6421433606104, 6935.375816176543, 7698.307152356294, 8026.879596806038, 8089.191080891908, 8091.595420228994, 7667.808304792383, 7830.41271904608, 7848.8037799055055, 7858.096318923325, 7861.842763144734, 2000.4998750312423, 2044.8057434543769, 2048.0988365119374, 2288.9084436622516, 2300.8849557522058, 2302.7236731592234, 2331.9766802332015, 2350.1304517328613, 2368.1829768729763, 2371.537550177716, 2239.7200349956256, 2246.7528571857083, 2249.3589327041796, 2265.0713207584895, 2332.370260029791, 1919.184346652667, 2252.0, 2305.700258966332, 2321.9535609287886, 2325.813934885205, 2293.334932869466, 2304.2971893572453, 2310.653401989698, 2312.06361423622, 2314.67594536765, 7664.348530374925, 7730.613469326511, 7732.0, 7737.3036426721865, 7758.301752842215, 4489.595936365743, 4698.7650617469335, 4705.1765940960195, 4718.716876987358, 4719.4100737407825, 2750.6286651302016, 2976.419598178356, 2990.3421247325555, 3010.2323907403693, 3014.668386477486, 946.5437190490734, 952.1430712358863, 953.918916892065, 959.7744530035505, 1006.6879267427121, 11050.060744836617, 11052.115830733523, 11058.170637202242, 11074.889251107466, 11087.445627718662, 4246.150769846043, 4310.418093557392, 4467.106578684211, 4503.797329120198, 4504.61710754583, 9336.206422454032, 9357.39176953496, 9380.437173769596, 9389.624415023323, 9401.200897923616, 4774.379330686988, 4786.922942337947, 4790.568848803555, 4803.18345881201, 4806.4712881583, 3735.234276973214, 3998.9600103998587, 4345.152695224464, 4367.47590289161, 4404.185225733249, 3730.813459327023, 3737.028372623138, 3808.3716186828865, 3871.6515513603913, 3873.8063096845044, 1226.8957138643316, 1228.5638598297476, 1236.913416060885, 1242.2236102435977, 1249.5001999200392, 746.5259560179217, 750.9962450187714, 760.4562737642501, 768.8462307538515, 769.6998170713426, 4917.827876024394, 4981.651284410129, 5030.647854650212, 5041.470645582161, 5079.492050794891, 428.6463667474346, 431.1850602361539, 431.6611460003882, 433.06674117277316, 436.13862621322636, 3221.3557288542384, 3257.9674203258137, 3267.575215222006, 3329.1011426914597, 3341.5990081189925, 9576.47329396876, 9919.553620087114, 10040.899591004143, 10046.14607758334, 10060.24548158891, 9843.409395436296, 9954.701358959242, 9956.502174891226, 9965.701028969142, 9982.900170998342, 7308.853822923512, 7391.445641576904, 7521.9247807522315, 7542.962285188649, 7582.35549978247, 4917.0903382874285, 4998.400191976986, 5027.4218464877, 5102.948970510396, 5122.1804511278015, 8772.429792063496, 8830.984436789595, 8945.686900958435, 8991.0, 9101.453912765255, 8721.520316382406, 9031.638734450811, 9107.453552786854, 9123.087691230823, 9238.722838314861, 6178.104174894705, 6546.967265163644, 6593.868122637617, 6725.932740672531, 6741.2921643226755, 7299.452541059548, 7326.743563975236, 7332.30343117403, 7365.1530074042175, 7378.9631051846545, 6476.935230647633, 6520.967395162994, 6539.869202616016, 6550.115734375799, 6769.830754231184, 6445.581037232565, 6471.094046833353, 6483.286838447862, 6498.187726534184, 6499.6750162492635, 6144.539159562962, 6147.784827531015, 6178.752849885954, 6184.0, 6201.596896201732, 4312.741235525878, 4318.740875547477, 4327.0, 4352.93470597935, 4436.334549817424, 4439.334099885043, 4441.689081764374, 4480.462344518679, 4569.383133276965, 4619.838305659286], "value": 4070.7416701936068, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.6575115999141, 322.40516247523317, 326.5281667989754, 327.17388593800666, 327.2767184522209, 5174.456682048382, 5221.347331583552, 5229.111051121309, 5233.607479439038, 5240.502152295536, 5172.560332371743, 5179.171332586787, 5179.611529135311, 5183.17069268917, 5200.323957885479, 3852.0947577319375, 3930.253251882133, 3983.760974341534, 4049.919001619966, 4065.085355794952, 4016.236914986158, 4037.313656678372, 4059.127287633158, 4059.3707975263883, 4066.430699702044, 3782.829772660223, 4011.4785077939828, 4016.3373043447796, 4025.9597404026026, 4030.8186131624147, 3859.7298189126773, 4001.459802926626, 4007.939880901789, 4018.276710192164, 4022.5374081980654, 3534.3461459630053, 3550.804705741183, 3554.0759402555263, 3559.697425718817, 3585.2829434113023, 4942.382202224722, 4945.480724523945, 4949.059678661043, 4969.552740253358, 4997.85006449807, 4544.250198717207, 4591.265397536378, 4632.0967411354795, 4640.559146881041, 4644.837430689943, 5371.248025276464, 5391.595630327741, 5412.485813847678, 5422.349318081855, 5436.184572314145, 3903.5315762108444, 3915.0, 3916.687909550304, 3916.921661566781, 3930.8034598269974, 5513.3108361454815, 5691.772329106872, 5706.600537962386, 5717.628354157008, 5721.742521586497, 3969.5236571611013, 3995.880123596297, 3997.220541994341, 4007.5591684914634, 4009.4787677601726, 4053.7365071270274, 4058.6347228748964, 4059.1475790084414, 4061.472008638858, 4071.328230841878, 4358.455193100863, 4596.678232523758, 4619.376384188159, 4626.398568186181, 4634.189016922025, 5395.2986111806, 5399.271098401744, 5436.347638283352, 5454.4545545445135, 5466.781328746885, 1422.2888555722138, 1440.3302464354126, 1446.240723620108, 1448.7971683964254, 1452.8111345525226, 930.9813803723888, 976.9755756106013, 978.5303054533864, 999.695092996643, 1011.8330475471465, 4746.121967435966, 4763.785629646674, 4765.142274390643, 4766.713997160182, 4800.903981920412, 5599.944000560024, 5615.438456154352, 5641.379448260688, 5641.943580564224, 5641.9970910327065, 4652.720836749806, 4715.952840471551, 4771.379720636364, 4785.569298763058, 4797.664163508521, 2977.553366994968, 2998.0, 3017.532282496217, 3021.6676165621766, 3025.909222723322, 5239.659422137549, 5239.738013099406, 5245.632805703641, 5250.816221432308, 5270.0, 5497.240882917428, 5737.569682273846, 5850.882982340329, 5851.356350801409, 5856.882862342729, 5324.653897496651, 5332.33345831771, 5339.466053394707, 5349.117395629678, 5354.839354819362, 5410.675359478444, 5689.975804355256, 5691.069099413722, 5721.427857214412, 5737.942620573741, 5526.088195447706, 5526.309211348582, 5534.142207957773, 5549.112142057252, 5557.833265002057, 5280.471952804689, 5288.259643649969, 5292.100342941632, 5341.41244463101, 5352.116900711339, 3728.5898551158807, 3910.530736311661, 3936.1340505088833, 3959.703022273399, 3973.7615743055508, 5588.552915766811, 5632.380438151718, 5638.182463542846, 5641.0, 5644.8306550803545, 5414.648047876875, 5423.755930983037, 5426.2674538936735, 5455.754491047833, 5465.234867118686, 5323.707196104251, 5386.8383948481605, 5398.568114550748, 5429.429909859408, 5451.918221226764, 5096.286519887145, 5303.443138470405, 5303.443138470405, 5322.574194064543, 5322.935412917354, 5273.103572392626, 5377.919331210113, 5381.408045115112, 5395.325584301962, 5417.972910135424, 5355.0, 5365.114756065362, 5393.40672526014, 5402.217857803156, 5403.891922161456], "value": 4110.0017936255545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.8449529865184, 635.0759644716934, 639.4564620072936, 706.580900544285, 747.2154238050047, 11724.062075033999, 12096.637100886965, 12275.63173104806, 12277.079219058583, 12304.93847530761, 11229.382383968878, 11242.775144497105, 11256.38089905057, 11294.943525282382, 11295.0, 640.378832532444, 772.2277722277722, 778.7702627724807, 779.4310153587884, 779.8752199648058, 775.5269285735696, 778.521209456186, 786.3159051625095, 786.8583654942108, 787.8621241282781, 813.9226773456512, 816.9918300817005, 817.6279792694339, 817.9918200818005, 818.3248819723722, 815.3395749442941, 816.1308206759782, 817.166490180016, 825.3727167352795, 828.5028982610446, 601.4196300569971, 603.7856560920853, 605.8788242351548, 606.0727087556046, 606.472369038939, 12382.504699811996, 12417.93791031048, 12430.813537796941, 12464.314462704548, 12564.497420103186, 12528.123031387806, 12710.745785084338, 12846.871531284754, 12882.677933051655, 13072.86927130726, 9365.11031452011, 9412.717618471457, 9430.528473576294, 9464.432134071909, 9539.18916892065, 3285.5400243965864, 3323.567936168283, 3336.548601358417, 3392.0332705179153, 3451.8964431067106, 38270.23459530822, 40884.591154088674, 43058.0, 43338.566614333766, 44477.555224447664, 10237.129843963197, 10308.742281443025, 10416.843747343795, 10441.791164176673, 10732.356058636507, 17935.192916318796, 18075.186616602285, 18084.18621162051, 18138.909305453653, 18139.818601814077, 7002.649867506706, 7161.498695091398, 7169.068021157216, 7283.526570772989, 7299.343059124704, 3506.701930335899, 3547.592026916938, 3606.0, 3684.8341824617955, 3687.041369244016, 3235.6764323567454, 3391.542141810873, 3392.5928888533535, 3401.2347221875375, 3408.5398471206568, 545.5008667069666, 548.7201527221066, 552.4365147549557, 555.7415801652251, 561.0238185557183, 505.8128492457814, 517.9922301165485, 542.4196110162168, 545.3237984898776, 563.4253061876944, 7080.129000248077, 7200.71197152108, 7280.708771649075, 7397.482176247719, 7763.1848655891445, 463.9211334073216, 490.3478373762887, 562.6680258647336, 592.4135106244872, 593.2465768474013, 3344.4481660526226, 3397.8980630581123, 3414.9146271343416, 3435.4159792835276, 3574.088607405147, 51463.48536514662, 51553.48446515487, 51735.48264517382, 51949.0, 52042.73978630082, 47437.0, 48550.27174592384, 48766.512334876905, 49096.0, 49292.75353623209, 42405.57594424016, 42410.57589424128, 43740.0, 44235.77882110504, 45670.0, 6773.153355830521, 6899.344562266577, 6968.163820341591, 7022.789316320519, 7034.437245020488, 30050.0, 30485.54271685971, 31158.22104447407, 31308.843455782575, 32162.678373216906, 33019.17452063718, 38161.6183838158, 40590.39114413227, 41325.38011929884, 41349.8987575939, 10046.196304295785, 10091.24315676342, 10105.0, 10138.391696498235, 10155.492225388552, 10385.792284154426, 10823.56705731762, 10934.507947142556, 11059.889401105886, 11188.944055279671, 10458.58165673395, 10496.580136794748, 10611.257211995395, 10639.0, 10802.297850639683, 11005.119590432907, 11084.224104312943, 11207.327560346079, 11275.887241127484, 11673.416329183337, 10120.746981325232, 10128.392296462236, 10614.1508679307, 10615.416152111398, 10648.946755266174, 8408.747737567883, 8551.315894728283, 8640.481571105754, 8766.736997890073, 8817.647294108421, 8237.382196335178, 8421.663133474593, 8490.73520621623, 8541.273991710774, 8693.130686931256], "value": 5790.3651511828075, "unit": "score"}], "name": "dromaeo_css", "value": 6207.372923503237, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 106.0, 112.0, 112.0, 112.0, 103.0, 114.0, 111.0, 113.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 153.0, 188.0, 133.0, 161.0, 154.0, 142.0, 192.0, 132.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 164.0, 160.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 124.0, 103.0, 75.0, 73.0, 74.0, 112.0, 99.0, 73.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 144.0, 93.0, 94.0, 94.0, 142.0, 93.0, 93.0, 143.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 147.0, 147.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 83.0, 65.0, 63.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 78.0, 88.0, 80.0, 79.0, 79.0, 81.0, 80.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 142.0, 146.0, 132.0, 131.0, 142.0, 134.0, 132.0, 167.0, 137.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 177.0, 175.0, 178.0, 177.0, 178.0, 176.0, 176.0, 186.0, 176.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 73.0, 72.0, 72.0, 71.0, 82.0, 71.0, 71.0, 72.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1586.3999999999999, "alertThreshold": 2.0}]} 05:07:33 INFO - Return code: 0 05:07:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:07:33 ERROR - # TBPL SUCCESS # 05:07:33 INFO - Running post-action listener: _resource_record_post_action 05:07:33 INFO - Running post-run listener: _resource_record_post_run 05:07:34 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 517623808; Read time: 0; Write time: 508956 05:07:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234545152; Read time: 0; Write time: 296760 05:07:34 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 283078656; Read time: 0; Write time: 212196 05:07:34 INFO - Running post-run listener: _upload_blobber_files 05:07:34 INFO - Blob upload gear active. 05:07:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:34 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 05:07:34 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'] 05:07:34 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 05:07:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:35 INFO - (blobuploader) - INFO - Done attempting. 05:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:36 INFO - (blobuploader) - INFO - Done attempting. 05:07:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:36 INFO - Return code: 0 05:07:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/788445c43d4915e62eeefe27ee7290f12140da0c70aadb61990ea0ba6da73f31efef5f7f7dfde084572f6bcb987d19393618e9aa5711094cffb788b05ea1840a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb1dfb43f570dcb671c6b6ffb866cb12be7085f782a438ab7f64fb67b3b7bf0a19e1d135cd03017d71b8a1f3231f0c41e47d7d4ed21f442f3201ac06881136db"} 05:07:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:36 INFO - Contents: 05:07:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/788445c43d4915e62eeefe27ee7290f12140da0c70aadb61990ea0ba6da73f31efef5f7f7dfde084572f6bcb987d19393618e9aa5711094cffb788b05ea1840a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb1dfb43f570dcb671c6b6ffb866cb12be7085f782a438ab7f64fb67b3b7bf0a19e1d135cd03017d71b8a1f3231f0c41e47d7d4ed21f442f3201ac06881136db"} 05:07:36 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:36 INFO - Copying logs to upload dir... 05:07:36 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.464648 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-25 05:07:35.738045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.742090) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467 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/788445c43d4915e62eeefe27ee7290f12140da0c70aadb61990ea0ba6da73f31efef5f7f7dfde084572f6bcb987d19393618e9aa5711094cffb788b05ea1840a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb1dfb43f570dcb671c6b6ffb866cb12be7085f782a438ab7f64fb67b3b7bf0a19e1d135cd03017d71b8a1f3231f0c41e47d7d4ed21f442f3201ac06881136db"} build_url:https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/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/788445c43d4915e62eeefe27ee7290f12140da0c70aadb61990ea0ba6da73f31efef5f7f7dfde084572f6bcb987d19393618e9aa5711094cffb788b05ea1840a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb1dfb43f570dcb671c6b6ffb866cb12be7085f782a438ab7f64fb67b3b7bf0a19e1d135cd03017d71b8a1f3231f0c41e47d7d4ed21f442f3201ac06881136db"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.766601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.771407) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1461584428.634334-1767383467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.850321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:07:35.850625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:07:35.852926) ========= ========= Total master_lag: 0.24 =========