builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1461248723.19 results: success (0) buildid: 20160421060426 builduid: 2f75b451552b41d5a81a70d69e0cfd47 revision: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:23.194631) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:23.195263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:23.195678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:23.213217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:23.213549) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 07:25:23-- 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% 223M=0s 2016-04-21 07:25:23 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:23.306090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:23.306532) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016166 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:23.356987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:23.357333) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 --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=e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 07:25:23,690 truncating revision to first 12 chars 2016-04-21 07:25:23,690 Setting DEBUG logging. 2016-04-21 07:25:23,690 attempt 1/10 2016-04-21 07:25:23,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1152d99d8c53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 07:25:24,188 unpacking tar archive at: mozilla-central-1152d99d8c53/testing/mozharness/ program finished with exit code 0 elapsedTime=0.794180 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.192850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.193326) ========= script_repo_revision: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.193725) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.194005) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.226879) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-21 07:25:24.227255) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:25:24 INFO - MultiFileLogger online at 20160421 07:25:24 in /builds/slave/test 07:25:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:25:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:25:24 INFO - {'append_to_log': False, 07:25:24 INFO - 'base_work_dir': '/builds/slave/test', 07:25:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:25:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:25:24 INFO - 'branch': 'Firefox-Non-PGO', 07:25:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:25:24 INFO - 'config_files': ('talos/linux_config.py',), 07:25:24 INFO - 'default_actions': ('clobber', 07:25:24 INFO - 'read-buildbot-config', 07:25:24 INFO - 'download-and-extract', 07:25:24 INFO - 'populate-webroot', 07:25:24 INFO - 'create-virtualenv', 07:25:24 INFO - 'install', 07:25:24 INFO - 'run-tests'), 07:25:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:25:24 INFO - 'download_minidump_stackwalk': True, 07:25:24 INFO - 'download_symbols': 'ondemand', 07:25:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:25:24 INFO - 'tooltool.py': '/tools/tooltool.py', 07:25:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:25:24 INFO - '/tools/misc-python/virtualenv.py')}, 07:25:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:25:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:25:24 INFO - 'installer_path': 'installer.exe', 07:25:24 INFO - 'log_level': 'info', 07:25:24 INFO - 'log_name': 'talos', 07:25:24 INFO - 'log_to_console': True, 07:25:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:25:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:25:24 INFO - 'opt_config_files': (), 07:25:24 INFO - 'pip_index': False, 07:25:24 INFO - 'sps_profile': False, 07:25:24 INFO - 'sps_profile_interval': 0, 07:25:24 INFO - 'suite': 'dromaeojs-e10s', 07:25:24 INFO - 'system_bits': '32', 07:25:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:25:24 INFO - 'title': 'talos-linux64-ix-067', 07:25:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:25:24 INFO - 'use_talos_json': True, 07:25:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:25:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:25:24 INFO - 'work_dir': 'build'} 07:25:24 INFO - ##### 07:25:24 INFO - ##### Running clobber step. 07:25:24 INFO - ##### 07:25:24 INFO - Running pre-action listener: _resource_record_pre_action 07:25:24 INFO - Running main action method: clobber 07:25:24 INFO - rmtree: /builds/slave/test/build 07:25:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:25:25 INFO - Running post-action listener: _resource_record_post_action 07:25:25 INFO - ##### 07:25:25 INFO - ##### Running read-buildbot-config step. 07:25:25 INFO - ##### 07:25:25 INFO - Running pre-action listener: _resource_record_pre_action 07:25:25 INFO - Running main action method: read_buildbot_config 07:25:25 INFO - Using buildbot properties: 07:25:25 INFO - { 07:25:25 INFO - "project": "", 07:25:25 INFO - "product": "firefox", 07:25:25 INFO - "script_repo_revision": "production", 07:25:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:25:25 INFO - "repository": "", 07:25:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:25:25 INFO - "buildid": "20160421060426", 07:25:25 INFO - "pgo_build": "False", 07:25:25 INFO - "basedir": "/builds/slave/test", 07:25:25 INFO - "buildnumber": 35, 07:25:25 INFO - "slavename": "talos-linux64-ix-067", 07:25:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:25:25 INFO - "platform": "ubuntu64_hw", 07:25:25 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:25:25 INFO - "branch": "mozilla-central", 07:25:25 INFO - "repo_path": "mozilla-central", 07:25:25 INFO - "revision": "1152d99d8c53ac9dae371a6e6d9fab03d3f98697", 07:25:25 INFO - "stage_platform": "linux64", 07:25:25 INFO - "builduid": "2f75b451552b41d5a81a70d69e0cfd47", 07:25:25 INFO - "slavebuilddir": "test" 07:25:25 INFO - } 07:25:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:25:25 INFO - Running post-action listener: _resource_record_post_action 07:25:25 INFO - ##### 07:25:25 INFO - ##### Running download-and-extract step. 07:25:25 INFO - ##### 07:25:25 INFO - Running pre-action listener: _resource_record_pre_action 07:25:25 INFO - Running main action method: download_and_extract 07:25:25 INFO - mkdir: /builds/slave/test/build/tests 07:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:25 INFO - https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:25:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:25:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:25:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/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 07:25:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/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 07:25:25 INFO - Downloaded 1361 bytes. 07:25:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:25:25 INFO - Using the following test package requirements: 07:25:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:25:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:25:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:25 INFO - u'jsshell-linux-x86_64.zip'], 07:25:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:25:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:25:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:25:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:25:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:25:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:25 INFO - https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:25:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:25:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/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 07:25:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/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 07:25:27 INFO - Downloaded 22274940 bytes. 07:25:27 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'] 07:25:27 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 07:25:28 INFO - Return code: 0 07:25:28 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 07:25: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')]} 07:25:28 INFO - https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:25:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:25:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/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 07:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/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 07:25:30 INFO - Downloaded 22274940 bytes. 07:25:30 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'] 07:25:30 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 07:25:31 INFO - Return code: 0 07:25: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')]} 07:25:31 INFO - https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:25:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/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 07:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/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 07:25:33 INFO - Downloaded 10845952 bytes. 07:25:33 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'] 07:25:33 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 07:25:33 INFO - Return code: 0 07:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:33 INFO - https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:25:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:25:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:25:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/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 07:25:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/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 07:25:35 INFO - Downloaded 54611704 bytes. 07:25:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:25:35 INFO - mkdir: /builds/slave/test/properties 07:25:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:25:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:25:35 INFO - Contents: 07:25:35 INFO - build_url:https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:25:37 INFO - Running post-action listener: _resource_record_post_action 07:25:37 INFO - Running post-action listener: set_extra_try_arguments 07:25:37 INFO - ##### 07:25:37 INFO - ##### Running populate-webroot step. 07:25:37 INFO - ##### 07:25:37 INFO - Running pre-action listener: _resource_record_pre_action 07:25:37 INFO - Running main action method: populate_webroot 07:25:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:25:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:25:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:25:37 INFO - '--tppagecycles', 07:25:37 INFO - '7'], 07:25:37 INFO - 'tests': ['tsvgm']}}, 07:25:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:25:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:25:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:25:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:25:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:25:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:25:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:37 INFO - 'talos_options': ['--disable-e10s'], 07:25:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:37 INFO - 'talos_options': ['--disable-e10s'], 07:25:37 INFO - 'tests': ['damp', 'tps']}, 07:25:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:37 INFO - 'tests': ['damp', 'tps']}, 07:25:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:25:37 INFO - 'tests': ['dromaeo_dom']}, 07:25:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:25:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:25:37 INFO - 'tests': ['a11yr', 07:25:37 INFO - 'ts_paint', 07:25:37 INFO - 'tpaint', 07:25:37 INFO - 'sessionrestore', 07:25:37 INFO - 'sessionrestore_no_auto_restore', 07:25:37 INFO - 'tabpaint']}, 07:25:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:25:37 INFO - 'ts_paint', 07:25:37 INFO - 'tpaint', 07:25:37 INFO - 'sessionrestore', 07:25:37 INFO - 'sessionrestore_no_auto_restore', 07:25:37 INFO - 'tabpaint']}, 07:25:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:25:37 INFO - 'ts_paint', 07:25:37 INFO - 'tpaint', 07:25:37 INFO - 'sessionrestore', 07:25:37 INFO - 'sessionrestore_no_auto_restore', 07:25:37 INFO - 'tabpaint']}, 07:25:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:25:37 INFO - 'ts_paint', 07:25:37 INFO - 'tpaint', 07:25:37 INFO - 'sessionrestore', 07:25:37 INFO - 'sessionrestore_no_auto_restore', 07:25:37 INFO - 'tabpaint']}, 07:25:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:25:37 INFO - 'tests': ['a11yr', 07:25:37 INFO - 'ts_paint', 07:25:37 INFO - 'tpaint', 07:25:37 INFO - 'sessionrestore', 07:25:37 INFO - 'sessionrestore_no_auto_restore', 07:25:37 INFO - 'tabpaint']}, 07:25:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:25:37 INFO - 'tests': ['a11yr', 07:25:37 INFO - 'ts_paint', 07:25:37 INFO - 'tpaint', 07:25:37 INFO - 'sessionrestore', 07:25:37 INFO - 'sessionrestore_no_auto_restore', 07:25:37 INFO - 'tabpaint']}, 07:25:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:25:37 INFO - 'tests': ['tsvgx', 07:25:37 INFO - 'tsvgr_opacity', 07:25:37 INFO - 'tart', 07:25:37 INFO - 'tscrollx', 07:25:37 INFO - 'cart']}, 07:25:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:25:37 INFO - 'tsvgr_opacity', 07:25:37 INFO - 'tart', 07:25:37 INFO - 'tscrollx', 07:25:37 INFO - 'cart']}, 07:25:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:37 INFO - 'talos_options': ['--disable-e10s'], 07:25:37 INFO - 'tests': ['tp5o']}, 07:25:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:37 INFO - 'tests': ['tp5o']}, 07:25:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:37 INFO - 'talos_options': ['--disable-e10s', 07:25:37 INFO - '--xperf_path', 07:25:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:37 INFO - 'tests': ['tp5n']}, 07:25:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:37 INFO - 'talos_options': ['--xperf_path', 07:25:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:37 INFO - 'tests': ['tp5n']}}, 07:25:37 INFO - 'talos.zip': {'path': '', 07:25:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:25:37 INFO - Running post-action listener: _resource_record_post_action 07:25:37 INFO - ##### 07:25:37 INFO - ##### Running create-virtualenv step. 07:25:37 INFO - ##### 07:25:37 INFO - Running pre-action listener: _resource_record_pre_action 07:25:37 INFO - Running main action method: create_virtualenv 07:25:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:25:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:25:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:25:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:25:37 INFO - Using real prefix '/usr' 07:25:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:25:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:39 INFO - Installing pip.................done. 07:25:39 INFO - Return code: 0 07:25:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:39 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 0x7fc995ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3410>, '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 0x12f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:25:39 INFO - Using env: {'DISPLAY': ':0', 07:25:39 INFO - 'HOME': '/home/cltbld', 07:25:39 INFO - 'LANG': 'en_US.UTF-8', 07:25:39 INFO - 'LANGUAGE': 'en_US:en', 07:25:39 INFO - 'LOGNAME': 'cltbld', 07:25:39 INFO - 'MAIL': '/var/mail/cltbld', 07:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:39 INFO - 'MOZ_NO_REMOTE': '1', 07:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:39 INFO - 'NO_EM_RESTART': '1', 07:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:39 INFO - 'PWD': '/builds/slave/test', 07:25:39 INFO - 'SHELL': '/bin/bash', 07:25:39 INFO - 'SHLVL': '1', 07:25:39 INFO - 'TERM': 'linux', 07:25:39 INFO - 'TMOUT': '86400', 07:25:39 INFO - 'USER': 'cltbld', 07:25:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 07:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:39 INFO - '_': '/tools/buildbot/bin/python'} 07:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:25:39 INFO - Cleaning up... 07:25:39 INFO - Return code: 0 07:25:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:39 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 0x7fc995ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3410>, '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 0x12f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:25:39 INFO - Using env: {'DISPLAY': ':0', 07:25:39 INFO - 'HOME': '/home/cltbld', 07:25:39 INFO - 'LANG': 'en_US.UTF-8', 07:25:39 INFO - 'LANGUAGE': 'en_US:en', 07:25:39 INFO - 'LOGNAME': 'cltbld', 07:25:39 INFO - 'MAIL': '/var/mail/cltbld', 07:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:39 INFO - 'MOZ_NO_REMOTE': '1', 07:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:39 INFO - 'NO_EM_RESTART': '1', 07:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:39 INFO - 'PWD': '/builds/slave/test', 07:25:39 INFO - 'SHELL': '/bin/bash', 07:25:39 INFO - 'SHLVL': '1', 07:25:39 INFO - 'TERM': 'linux', 07:25:39 INFO - 'TMOUT': '86400', 07:25:39 INFO - 'USER': 'cltbld', 07:25:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 07:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:39 INFO - '_': '/tools/buildbot/bin/python'} 07:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:40 INFO - Downloading/unpacking psutil>=0.7.1 07:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:42 INFO - Installing collected packages: psutil 07:25:42 INFO - Running setup.py install for psutil 07:25:42 INFO - building 'psutil._psutil_linux' extension 07:25:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:25:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:25:42 INFO - building 'psutil._psutil_posix' extension 07:25:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:25:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:25:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:42 INFO - Successfully installed psutil 07:25:42 INFO - Cleaning up... 07:25:42 INFO - Return code: 0 07:25:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:42 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 0x7fc995ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3410>, '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 0x12f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:25:42 INFO - Using env: {'DISPLAY': ':0', 07:25:42 INFO - 'HOME': '/home/cltbld', 07:25:42 INFO - 'LANG': 'en_US.UTF-8', 07:25:42 INFO - 'LANGUAGE': 'en_US:en', 07:25:42 INFO - 'LOGNAME': 'cltbld', 07:25:42 INFO - 'MAIL': '/var/mail/cltbld', 07:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:42 INFO - 'MOZ_NO_REMOTE': '1', 07:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:42 INFO - 'NO_EM_RESTART': '1', 07:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:42 INFO - 'PWD': '/builds/slave/test', 07:25:42 INFO - 'SHELL': '/bin/bash', 07:25:42 INFO - 'SHLVL': '1', 07:25:42 INFO - 'TERM': 'linux', 07:25:42 INFO - 'TMOUT': '86400', 07:25:42 INFO - 'USER': 'cltbld', 07:25:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 07:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:42 INFO - '_': '/tools/buildbot/bin/python'} 07:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:25:44 INFO - Installing collected packages: mozsystemmonitor 07:25:44 INFO - Running setup.py install for mozsystemmonitor 07:25:44 INFO - Successfully installed mozsystemmonitor 07:25:44 INFO - Cleaning up... 07:25:44 INFO - Return code: 0 07:25:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:44 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 0x7fc995ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3410>, '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 0x12f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:25:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:25:44 INFO - Using env: {'DISPLAY': ':0', 07:25:44 INFO - 'HOME': '/home/cltbld', 07:25:44 INFO - 'LANG': 'en_US.UTF-8', 07:25:44 INFO - 'LANGUAGE': 'en_US:en', 07:25:44 INFO - 'LOGNAME': 'cltbld', 07:25:44 INFO - 'MAIL': '/var/mail/cltbld', 07:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:44 INFO - 'MOZ_NO_REMOTE': '1', 07:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:44 INFO - 'NO_EM_RESTART': '1', 07:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:44 INFO - 'PWD': '/builds/slave/test', 07:25:44 INFO - 'SHELL': '/bin/bash', 07:25:44 INFO - 'SHLVL': '1', 07:25:44 INFO - 'TERM': 'linux', 07:25:44 INFO - 'TMOUT': '86400', 07:25:44 INFO - 'USER': 'cltbld', 07:25:44 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 07:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:44 INFO - '_': '/tools/buildbot/bin/python'} 07:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:45 INFO - Downloading/unpacking blobuploader==1.2.4 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:46 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:47 INFO - Downloading docopt-0.6.1.tar.gz 07:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:47 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:47 INFO - Running setup.py install for blobuploader 07:25:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:47 INFO - Running setup.py install for requests 07:25:48 INFO - Running setup.py install for docopt 07:25:48 INFO - Successfully installed blobuploader requests docopt 07:25:48 INFO - Cleaning up... 07:25:48 INFO - Return code: 0 07:25:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:48 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 0x7fc995ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3410>, '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 0x12f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:25:48 INFO - Using env: {'DISPLAY': ':0', 07:25:48 INFO - 'HOME': '/home/cltbld', 07:25:48 INFO - 'LANG': 'en_US.UTF-8', 07:25:48 INFO - 'LANGUAGE': 'en_US:en', 07:25:48 INFO - 'LOGNAME': 'cltbld', 07:25:48 INFO - 'MAIL': '/var/mail/cltbld', 07:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:48 INFO - 'MOZ_NO_REMOTE': '1', 07:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:48 INFO - 'NO_EM_RESTART': '1', 07:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:48 INFO - 'PWD': '/builds/slave/test', 07:25:48 INFO - 'SHELL': '/bin/bash', 07:25:48 INFO - 'SHLVL': '1', 07:25:48 INFO - 'TERM': 'linux', 07:25:48 INFO - 'TMOUT': '86400', 07:25:48 INFO - 'USER': 'cltbld', 07:25:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 07:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:48 INFO - '_': '/tools/buildbot/bin/python'} 07:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:48 INFO - Running setup.py (path:/tmp/pip-oEsh3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:48 INFO - Running setup.py (path:/tmp/pip-BZRZP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:48 INFO - Running setup.py (path:/tmp/pip-sl3I_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:48 INFO - Running setup.py (path:/tmp/pip-mpVzfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:48 INFO - Running setup.py (path:/tmp/pip-lgpD02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:48 INFO - Running setup.py (path:/tmp/pip-9Abm8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:49 INFO - Running setup.py (path:/tmp/pip-iQjvif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:49 INFO - Running setup.py (path:/tmp/pip-aEvCcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:49 INFO - Running setup.py (path:/tmp/pip-moguto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:49 INFO - Running setup.py (path:/tmp/pip-EWsTum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:49 INFO - Running setup.py (path:/tmp/pip-plv3j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:49 INFO - Running setup.py (path:/tmp/pip-7R1hbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:49 INFO - Running setup.py (path:/tmp/pip-neqXHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:49 INFO - Running setup.py (path:/tmp/pip-t7gpBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:49 INFO - Running setup.py (path:/tmp/pip-Z7NAmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:49 INFO - Running setup.py (path:/tmp/pip-0cZv1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:49 INFO - Running setup.py (path:/tmp/pip-0_VELp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:49 INFO - Running setup.py install for manifestparser 07:25:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:49 INFO - Running setup.py install for mozcrash 07:25:50 INFO - Running setup.py install for mozdebug 07:25:50 INFO - Running setup.py install for mozdevice 07:25:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:50 INFO - Running setup.py install for mozfile 07:25:50 INFO - Running setup.py install for mozhttpd 07:25:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:50 INFO - Running setup.py install for mozinfo 07:25:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:50 INFO - Running setup.py install for mozInstall 07:25:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:50 INFO - Running setup.py install for mozleak 07:25:50 INFO - Running setup.py install for mozlog 07:25:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:50 INFO - Running setup.py install for moznetwork 07:25:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:50 INFO - Running setup.py install for mozprocess 07:25:51 INFO - Running setup.py install for mozprofile 07:25:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:51 INFO - Running setup.py install for mozrunner 07:25:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:51 INFO - Running setup.py install for mozscreenshot 07:25:51 INFO - Running setup.py install for moztest 07:25:51 INFO - Running setup.py install for mozversion 07:25:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:51 INFO - Cleaning up... 07:25:51 INFO - Return code: 0 07:25:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:51 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 0x7fc995ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3410>, '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 0x12f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:25:51 INFO - Using env: {'DISPLAY': ':0', 07:25:51 INFO - 'HOME': '/home/cltbld', 07:25:51 INFO - 'LANG': 'en_US.UTF-8', 07:25:51 INFO - 'LANGUAGE': 'en_US:en', 07:25:51 INFO - 'LOGNAME': 'cltbld', 07:25:51 INFO - 'MAIL': '/var/mail/cltbld', 07:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:51 INFO - 'MOZ_NO_REMOTE': '1', 07:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:51 INFO - 'NO_EM_RESTART': '1', 07:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:51 INFO - 'PWD': '/builds/slave/test', 07:25:51 INFO - 'SHELL': '/bin/bash', 07:25:51 INFO - 'SHLVL': '1', 07:25:51 INFO - 'TERM': 'linux', 07:25:51 INFO - 'TMOUT': '86400', 07:25:51 INFO - 'USER': 'cltbld', 07:25:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 07:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:51 INFO - '_': '/tools/buildbot/bin/python'} 07:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:51 INFO - Running setup.py (path:/tmp/pip-Uttx1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:51 INFO - Running setup.py (path:/tmp/pip-uwTBFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:51 INFO - Running setup.py (path:/tmp/pip-nxonfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:52 INFO - Running setup.py (path:/tmp/pip-opNQyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:52 INFO - Running setup.py (path:/tmp/pip-Bai2X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:52 INFO - Running setup.py (path:/tmp/pip-j4LMOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:52 INFO - Running setup.py (path:/tmp/pip-lromT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:52 INFO - Running setup.py (path:/tmp/pip-or9p3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:52 INFO - Running setup.py (path:/tmp/pip-LdfYVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:52 INFO - Running setup.py (path:/tmp/pip-vjFo8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:52 INFO - Running setup.py (path:/tmp/pip-sve47e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:52 INFO - Running setup.py (path:/tmp/pip-pgEgoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:52 INFO - Running setup.py (path:/tmp/pip-eSgLCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:52 INFO - Running setup.py (path:/tmp/pip-PISQ_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:52 INFO - Running setup.py (path:/tmp/pip-y_jl08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:52 INFO - Running setup.py (path:/tmp/pip-eXuD4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:52 INFO - Running setup.py (path:/tmp/pip-C7ZHti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:25:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:54 INFO - Downloading blessings-1.6.tar.gz 07:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:55 INFO - Installing collected packages: blessings 07:25:55 INFO - Running setup.py install for blessings 07:25:55 INFO - Successfully installed blessings 07:25:55 INFO - Cleaning up... 07:25:55 INFO - Return code: 0 07:25:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:55 INFO - Reading from file tmpfile_stdout 07:25:55 INFO - Current package versions: 07:25:55 INFO - argparse == 1.2.1 07:25:55 INFO - blessings == 1.6 07:25:55 INFO - blobuploader == 1.2.4 07:25:55 INFO - docopt == 0.6.1 07:25:55 INFO - manifestparser == 1.1 07:25:55 INFO - mozInstall == 1.12 07:25:55 INFO - mozcrash == 0.17 07:25:55 INFO - mozdebug == 0.1 07:25:55 INFO - mozdevice == 0.48 07:25:55 INFO - mozfile == 1.2 07:25:55 INFO - mozhttpd == 0.7 07:25:55 INFO - mozinfo == 0.9 07:25:55 INFO - mozleak == 0.1 07:25:55 INFO - mozlog == 3.1 07:25:55 INFO - moznetwork == 0.27 07:25:55 INFO - mozprocess == 0.22 07:25:55 INFO - mozprofile == 0.28 07:25:55 INFO - mozrunner == 6.11 07:25:55 INFO - mozscreenshot == 0.1 07:25:55 INFO - mozsystemmonitor == 0.0 07:25:55 INFO - moztest == 0.7 07:25:55 INFO - mozversion == 1.4 07:25:55 INFO - psutil == 3.1.1 07:25:55 INFO - requests == 1.2.3 07:25:55 INFO - wsgiref == 0.1.2 07:25:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:55 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 0x7fc995ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3410>, '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 0x12f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:25:55 INFO - Using env: {'DISPLAY': ':0', 07:25:55 INFO - 'HOME': '/home/cltbld', 07:25:55 INFO - 'LANG': 'en_US.UTF-8', 07:25:55 INFO - 'LANGUAGE': 'en_US:en', 07:25:55 INFO - 'LOGNAME': 'cltbld', 07:25:55 INFO - 'MAIL': '/var/mail/cltbld', 07:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:55 INFO - 'MOZ_NO_REMOTE': '1', 07:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:55 INFO - 'NO_EM_RESTART': '1', 07:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:55 INFO - 'PWD': '/builds/slave/test', 07:25:55 INFO - 'SHELL': '/bin/bash', 07:25:55 INFO - 'SHLVL': '1', 07:25:55 INFO - 'TERM': 'linux', 07:25:55 INFO - 'TMOUT': '86400', 07:25:55 INFO - 'USER': 'cltbld', 07:25:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 07:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:55 INFO - '_': '/tools/buildbot/bin/python'} 07:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:25:55 INFO - Cleaning up... 07:25:55 INFO - Return code: 0 07:25:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:55 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 0x7fc995ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3410>, '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 0x12f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:25:55 INFO - Using env: {'DISPLAY': ':0', 07:25:55 INFO - 'HOME': '/home/cltbld', 07:25:55 INFO - 'LANG': 'en_US.UTF-8', 07:25:55 INFO - 'LANGUAGE': 'en_US:en', 07:25:55 INFO - 'LOGNAME': 'cltbld', 07:25:55 INFO - 'MAIL': '/var/mail/cltbld', 07:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:55 INFO - 'MOZ_NO_REMOTE': '1', 07:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:55 INFO - 'NO_EM_RESTART': '1', 07:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:55 INFO - 'PWD': '/builds/slave/test', 07:25:55 INFO - 'SHELL': '/bin/bash', 07:25:55 INFO - 'SHLVL': '1', 07:25:55 INFO - 'TERM': 'linux', 07:25:55 INFO - 'TMOUT': '86400', 07:25:55 INFO - 'USER': 'cltbld', 07:25:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 07:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:55 INFO - '_': '/tools/buildbot/bin/python'} 07:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:55 INFO - Downloading/unpacking jsonschema 07:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:57 INFO - Downloading/unpacking functools32 (from jsonschema) 07:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:57 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:58 INFO - warning: no files found matching '*.txt' 07:25:58 INFO - no previously-included directories found matching 'build' 07:25:58 INFO - no previously-included directories found matching 'dist' 07:25:58 INFO - no previously-included directories found matching '.git*' 07:25:58 INFO - Installing collected packages: jsonschema, functools32 07:25:58 INFO - Running setup.py install for functools32 07:25:58 INFO - warning: no files found matching '*.txt' 07:25:58 INFO - no previously-included directories found matching 'build' 07:25:58 INFO - no previously-included directories found matching 'dist' 07:25:58 INFO - no previously-included directories found matching '.git*' 07:25:58 INFO - Successfully installed jsonschema functools32 07:25:58 INFO - Cleaning up... 07:25:58 INFO - Return code: 0 07:25:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:58 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 0x7fc995ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3410>, '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 0x12f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:25:58 INFO - Using env: {'DISPLAY': ':0', 07:25:58 INFO - 'HOME': '/home/cltbld', 07:25:58 INFO - 'LANG': 'en_US.UTF-8', 07:25:58 INFO - 'LANGUAGE': 'en_US:en', 07:25:58 INFO - 'LOGNAME': 'cltbld', 07:25:58 INFO - 'MAIL': '/var/mail/cltbld', 07:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:58 INFO - 'MOZ_NO_REMOTE': '1', 07:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:58 INFO - 'NO_EM_RESTART': '1', 07:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:58 INFO - 'PWD': '/builds/slave/test', 07:25:58 INFO - 'SHELL': '/bin/bash', 07:25:58 INFO - 'SHLVL': '1', 07:25:58 INFO - 'TERM': 'linux', 07:25:58 INFO - 'TMOUT': '86400', 07:25:58 INFO - 'USER': 'cltbld', 07:25:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 07:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:58 INFO - '_': '/tools/buildbot/bin/python'} 07:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:58 INFO - Downloading/unpacking flake8 07:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:26:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:26:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:26:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:26:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:26:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:26:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:26:01 INFO - no previously-included directories found matching 'docs/_build' 07:26:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:26:01 INFO - Running setup.py install for pep8 07:26:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:26:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:26:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:26:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:26:01 INFO - no previously-included directories found matching 'docs/_build' 07:26:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:26:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:26:01 INFO - Cleaning up... 07:26:01 INFO - Return code: 0 07:26:01 INFO - Running post-action listener: _resource_record_post_action 07:26:01 INFO - Running post-action listener: _start_resource_monitoring 07:26:01 INFO - Starting resource monitoring. 07:26:01 INFO - ##### 07:26:01 INFO - ##### Running install step. 07:26:01 INFO - ##### 07:26:01 INFO - Running pre-action listener: _resource_record_pre_action 07:26:01 INFO - Running main action method: install 07:26:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:26:01 INFO - Reading from file tmpfile_stdout 07:26:01 INFO - Detecting whether we're running mozinstall >=1.0... 07:26:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:26:01 INFO - Reading from file tmpfile_stdout 07:26:01 INFO - Output received: 07:26:01 INFO - Usage: mozinstall [options] installer 07:26:01 INFO - Options: 07:26:01 INFO - -h, --help show this help message and exit 07:26:01 INFO - -d DEST, --destination=DEST 07:26:01 INFO - Directory to install application into. [default: 07:26:01 INFO - "/builds/slave/test"] 07:26:01 INFO - --app=APP Application being installed. [default: firefox] 07:26:01 INFO - mkdir: /builds/slave/test/build/application 07:26:01 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'] 07:26:01 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 07:26:17 INFO - Reading from file tmpfile_stdout 07:26:17 INFO - Output received: 07:26:17 INFO - /builds/slave/test/build/application/firefox/firefox 07:26:17 INFO - Running post-action listener: _resource_record_post_action 07:26:17 INFO - ##### 07:26:17 INFO - ##### Running run-tests step. 07:26:17 INFO - ##### 07:26:17 INFO - Running pre-action listener: _resource_record_pre_action 07:26:17 INFO - Running main action method: run_tests 07:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:26:17 INFO - Python 2.7.3 07:26:17 INFO - Return code: 0 07:26:17 INFO - grabbing minidump binary from tooltool 07:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:17 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 0x12f3410>, '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 0x12f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:26:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:26:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:26:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:26:17 INFO - Return code: 0 07:26:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:26:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:26:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:26:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:26:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:26:18 INFO - Return code: 0 07:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:26:18 INFO - Using env: {'DISPLAY': ':0', 07:26:18 INFO - 'HOME': '/home/cltbld', 07:26:18 INFO - 'LANG': 'en_US.UTF-8', 07:26:18 INFO - 'LANGUAGE': 'en_US:en', 07:26:18 INFO - 'LOGNAME': 'cltbld', 07:26:18 INFO - 'MAIL': '/var/mail/cltbld', 07:26:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:26:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:18 INFO - 'MOZ_NO_REMOTE': '1', 07:26:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:18 INFO - 'NO_EM_RESTART': '1', 07:26:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:18 INFO - 'PWD': '/builds/slave/test', 07:26:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:26:18 INFO - 'SHELL': '/bin/bash', 07:26:18 INFO - 'SHLVL': '1', 07:26:18 INFO - 'TERM': 'linux', 07:26:18 INFO - 'TMOUT': '86400', 07:26:18 INFO - 'USER': 'cltbld', 07:26:18 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978', 07:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:18 INFO - '_': '/tools/buildbot/bin/python'} 07:26:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:26:18 INFO - mozversion application_buildid: 20160421060426 07:26:18 INFO - mozversion application_changeset: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 07:26:18 INFO - mozversion application_display_name: Nightly 07:26:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:26:18 INFO - mozversion application_name: Firefox 07:26:18 INFO - mozversion application_remotingname: firefox 07:26:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:26:18 INFO - mozversion application_vendor: Mozilla 07:26:18 INFO - mozversion application_version: 48.0a1 07:26:18 INFO - mozversion platform_buildid: 20160421060426 07:26:18 INFO - mozversion platform_changeset: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 07:26:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:26:18 INFO - mozversion platform_version: 48.0a1 07:26:18 INFO - using testdate: 1461248778 07:26:18 INFO - actual date: 1461248778 07:26:18 INFO - starting webserver on 'localhost:47031' 07:26:18 INFO - SUITE-START | Running 2 tests 07:26:18 INFO - TEST-START | dromaeo_css 07:26:18 INFO - operating with platform_type : linux_ 07:26:18 INFO - Initialising browser for dromaeo_css test... 07:26:18 INFO - TEST-INFO | started process 24484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCeeHaS/profile http://localhost:47031/getInfo.html) 07:26:22 INFO - PROCESS | 24484 | 07:26:22 INFO - PROCESS | 24484 | (process:24552): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:26:22 INFO - PROCESS | 24484 | __metrics Screen width/height:1600/1200 07:26:22 INFO - PROCESS | 24484 | colorDepth:24 07:26:22 INFO - PROCESS | 24484 | Browser inner width/height: 1024/697 07:26:22 INFO - PROCESS | 24484 | __metrics 07:26:23 ERROR - PROCESS | 24484 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:26:24 INFO - TEST-INFO | 24484: exit 0 07:26:24 INFO - Browser initialized. 07:26:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:26:24 INFO - TEST-INFO | started process 24603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCeeHaS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:26 INFO - PROCESS | 24603 | 07:26:26 INFO - PROCESS | 24603 | (process:24664): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:26:36 INFO - PROCESS | 24603 | RSS: Main: 164958208 07:26:36 INFO - PROCESS | 24603 | 07:27:25 INFO - PROCESS | 24603 | 1461248845901 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:29:37 INFO - PROCESS | 24603 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47031/tests/dromaeo/cssquery-ext.html) 07:29:38 INFO - PROCESS | 24603 | RSS: Main: 169467904 07:29:38 INFO - PROCESS | 24603 | 07:32:40 INFO - PROCESS | 24603 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-ext.html (next: http://localhost:47031/tests/dromaeo/cssquery-jquery.html) 07:32:40 INFO - PROCESS | 24603 | RSS: Main: 166567936 07:32:40 INFO - PROCESS | 24603 | 07:35:42 INFO - PROCESS | 24603 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47031/tests/dromaeo/cssquery-mootools.html) 07:35:43 INFO - PROCESS | 24603 | RSS: Main: 167260160 07:35:43 INFO - PROCESS | 24603 | 07:38:45 INFO - PROCESS | 24603 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47031/tests/dromaeo/cssquery-prototype.html) 07:38:45 INFO - PROCESS | 24603 | RSS: Main: 164761600 07:38:45 INFO - PROCESS | 24603 | 07:41:48 INFO - PROCESS | 24603 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47031/tests/dromaeo/cssquery-yui.html) 07:41:49 INFO - PROCESS | 24603 | RSS: Main: 166350848 07:41:49 INFO - PROCESS | 24603 | 07:44:51 INFO - PROCESS | 24603 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-yui.html (next: http://localhost:47031/tests/dromaeo/cssquery-dojo.html) 07:44:51 INFO - PROCESS | 24603 | RSS: Main: 168267776 07:44:51 INFO - PROCESS | 24603 | 07:44:51 INFO - PROCESS | 24603 | __start_tp_report 07:44:51 INFO - PROCESS | 24603 | _x_x_mozilla_page_load 07:44:51 INFO - PROCESS | 24603 | _x_x_mozilla_page_load_details 07:44:51 INFO - PROCESS | 24603 | |i|pagename|runs| 07:44:51 INFO - PROCESS | 24603 | |0;dojo.html;2593.610958356246;2602.531544322021;2639.564471862143;2652.1513115802927;2662.8801703923323;4567.269236922093;4593.655475839313;4608.884777880547;4625.468071171812;4654.581087702106;4464.5981861632445;4599.678022538424;4620.7689615519175;4666.696664716791;4667.929981050287;4260.147970405924;4289.678274129437;4330.7401555906745;4339.869803905888;4381.780910954455;4281.571842815724;4320.157569273977;4345.804438800245;4378.496472905609;4379.08039311745;4161.625453709181;4241.681873859473;4283.057727299989;4295;4316.330968699856;4187.769672668002;4196.244675958326;4199.328107502785;4221.261279276115;4262.829486820523;4235.767032813194;4259.254630439661;4263.4031235627035;4278.9730464688255;4291.034517233628;4503.369528266046;4525.32120181972;4559.726416415026;4584.243599806028;4598.494165641777;4833.081714474274;4856.368672072644;4862.781174847105;4878.902421951577;4912.8945987152965;4884.29177769225;4892.8532144035735;4901.191303434929;4914.631402644816;4937.8271760488215;4648.302754586805;4659.953400465952;4671.299305104261;4712.458067322234;4729.668923175379;5002.474740152305;5024.346834911511;5027.698338099725;5029.7736601853;5054.721990290495;4738.431388233434;4828.46886842447;4840.322354870321;4855.902881942341;4896.902061958741;4913.091078150554;4923.384576927884;4941.03649788295;4957.20684690455;4987.301777751118;4713.410823647044;4774.30772537987;4830.95169048305;4860.465348811628;4950.084234416644;4828.106800241966;4828.66199366048;4839;4890.168671325883;4907.607391408679;4021.698372622065;4118.402831589403;4143.295639741251;4162.354835000579;4190.036291652876;3633.4186530155575;3645.434957581579;3652.9817350913077;3688.5573731152435;3694.9815250923575;4241.724287921275;4246;4267.295896177096;4268.359746038119;4272.145570885836;4982.9252561211615;4993.650444468925;4994.550490455877;5048.444671086178;5066.290719299301;4184.7796318151195;4218.957810421918;4235.555266697014;4274.316109422478;4277.080427708058;4406.405135306757;4411.779411029435;4430.8449204277695;4452.84226101216;4520.9827788747925;4715.693479923794;4727.976360118246;4734.479207287196;4760.95239047612;4762.880927976828;4959.355283813081;4997.3253610762085;5019.071471777733;5025;5064.341635587498;4536.56902594253;4681.953180468152;4738.407699037621;4739.502352252964;4760.476347601831;4891.486393928729;4907.705537667752;4912.38595175603;4919.139150648551;4931.309616653743;4957.727324997016;4963.726995015309;4976.452590215001;4993.151164302005;4997.1754660482065;4726.905461890812;4799.112164249625;4833.806647734052;4874.341963834979;4877.3903262092235;4621.907561848677;4782.665213435026;4817.5182481752945;4851.442084160367;4867.075255701406;4761.738104404291;4763.523647635208;4766.046790641954;4804.423469183581;4836.709797412166;4777.259524773665;4843.055604157155;4863.221884498605;4872.6832755870755;4901.9019619608125;4742.241241401359;4745.193317136164;4746.311784791255;4750.714957102585;4802.471728109836 07:44:51 INFO - PROCESS | 24603 | |1;ext.html;573.15459696947;586.4838941731276;605.6699098991049;607.6657838188995;623.2489849731069;34628.48057279143;36039.459408108865;36109.45835812465;36126.63873361266;36204.09489762754;35439.645603543955;35484.82257588708;35996.64003359966;36141.45787813178;36153.45769813448;7675.194104619019;7916.0500739911295;7923.801904952394;7926.960365198166;7927.8414431711335;7805.8829117563;7847.960760196191;7910.762677119696;7926.326262267714;7939.682412703485;7892.644830982619;7967.322777563914;7984.281414672679;8013.799655008613;8026.398020148483;7855.646495907669;7938.880916786253;7942.920570794276;7949.64226609804;7986.480878742921;7821.413393995473;7891.565963871984;7942.570337339276;7950.6422211000645;7960.044794624682;28605.57091643627;35709.10727231814;35903.102422439384;36069.27861442783;36084.278314433825;3051.529232263003;3054.2364408897774;3069.3707789903237;3279.262166012652;3513.789172649649;26788.464230715275;26943.865280673668;27176.32059198516;27236;27748.583771243448;3378.3074469733647;3387.3394688035596;3432.1934345428804;3525.383057964846;3531.99338188615;262894;269599;269618;270665.64667176735;272066;33294;52760.47239527632;53260.73369633205;53416.46583534115;53430.19854702183;33837.830810845786;34237.14407139841;34262.31475370529;34323;34335.484967725504;12580.30808305552;12800.80798788019;12836.101472896995;12860.292683902288;12868.549600763929;9982;10027.699169024942;10066;10106.14097801695;10123.7469063274;8193.221643943816;8259.95870020646;8353.498790072616;8399.580020999048;8452.070272270046;3318.8672453101603;3325.5011748237957;3356.7314614830757;3387.8475468603974;3405.659434056624;932.1610550504464;951.9333646644668;956.5886668732372;1020.698893826323;1033.452270296744;28186;28710.712892871223;29217.85391073031;29246.7075329244;29345.413091738046;1047.8061558611682;1050.9474526273655;1055.7624534479835;1069.0912724184382;1100.9779804403868;14784;15212.695746085237;15285.235738213267;15352.769708454382;15419;360743;367299;368681;369149;369452;48951.265731014064;49506;49738.75130624396;49791.50208497869;49959.500404996215;1223.6390264871884;1228.4594778297521;1236.771197328497;1241.6275117464725;1255.2468518888593;26599.867000665647;27498.45003099887;27816.86091569529;28053.298667533476;28475.572866406605;43450.782746086064;43660.34509482424;44290;44333.11333773371;44379.55620443754;309944;310684;311232;311727;312365;25317.240482785546;25865.612015820156;26054.73945260599;26148.738512615393;26211.868940655175;41120;42018.36972445354;42077.57922420859;42390.5760942399;42427;35742.46386304156;35912.4613130798;35985.460218096225;36172;36403.089922752144;34461.13847153741;35663.64336356707;35894.64105358913;36108.27783444264;36258.4561231587;29532.704672952994;33349;34052.65947340495;36345;36453.63546364608;28327.575086374134;29236.415271694023;29513;31679.36641267208;31967.840160799045;24754.50490990206;24945;24987.87506062458;25246.368840779127;25290.620640690773 07:44:51 INFO - PROCESS | 24603 | |2;jquery.html;366.3735013127552;367.1921772101376;372.37998732111043;375.98872033838995;381.87970789201415;15644.53066408008;16423.83576164238;17621.295148194058;17650.823491765077;17655.117244137775;16174.919125404356;16424.507264782045;17175.227114779835;17350.132493375313;17437.912810435962;4961.503849615027;5081.974590127044;5130.871728206806;5136.101182293102;5145.845624631267;3638.181409182939;5031.949680503203;5433.864153396157;5768.04827203513;5783.884322313551;5699.686517241571;5701.629394089392;5704.087346024637;5709.800156994506;5743.253377060976;5431.6740995540395;5625.634333768292;5627.099664053731;5627.6060675752715;5642.802501912454;4872.878178045542;4911.631627627907;4942.209246520575;4948.38145231846;4977.751112444364;19415.708764368545;19932.800671993384;20045.1981920723;20060.899695501575;20674.48313792152;1917.51103468616;1928.0648885290623;1962.479942815155;1978.9010549472468;2028.330650885219;12730.745385092247;13296.800547991788;13361.532346367927;13589.796153057712;13611.52359667407;1747.8514326282282;1825.4979880532826;1825.7170138628535;1841.8250266224686;1844.5204246895769;66059.33940660532;66150.33849661538;66588;67065;67331.63341832938;8780.648774049094;8792.78018049541;9046.547672616343;9485.525723713787;9783;12294;12503.124781265406;12537.74924501505;12541.686457838445;12604.81092783609;6891.586504809728;6903.482238832108;6955.6869940852785;7115.750948716874;7152.17749958751;6729.663516824139;6745.156855393076;6852.074969879102;6868.210155832044;6881.862362752717;5770.42295770428;5896.705164741746;5923;5949.3753155918;5972.522198224132;1548.3342162869849;1663.5628803802488;1746.175246867027;1794.8743587948718;1803.8196180381856;913.2830727878584;917.0737555069428;921.9904204895629;986.0189111833771;1076.6554702495127;15547.378104875905;16046.839531604768;16653.41713040038;17017.234224459928;17130.743038854427;931.366670663955;943.4386540008684;961.427950369529;1000.6747806962766;1009.5759780892043;9546.733633426367;9718.465484398284;9738.367006144577;9742.853857192147;9842.704718858446;373677;373945;376191;384189;385018;67208.32791672119;67858;68773.65613171902;70187.29812701808;70779.6461017702;857.1342943626981;858.7638399440204;877.3376101043799;877.4165180155253;878.1876763993281;13824.86175138276;14935.775963360775;14964.700705985602;15016.924915375354;15026.398944042116;31386.843065784524;32586.837065814518;35206.295874081865;35865;36175;46134;46720.06559868852;46995.06009879715;47025;47931.76034119807;7796.415268854972;7889.921100789148;8020.438569300326;8031.397645176752;8257.339412847077;8345.582720864053;8365.24712775853;8789.648414063622;11065.170112241452;11906.583269585522;7271.127464704269;7610.200928902385;7625.6949722010495;7675.61621918913;7995.680172793023;4074.714769966074;6405.263394709668;7883.763487095396;8039.271556615356;8052.248018796525;7269.45479089081;7738.922610774045;7913.485623434458;7927.12801591836;7962.761117166494;10703.250772445854;10994.560217591206;11186.272892261977;11346.602868899548;11716.121290903387;10657.40773028173;10850.131989440668;10852.659249357874;11084.889151108708;11255.831162532404 07:44:51 INFO - PROCESS | 24603 | |3;mootools.html;1409.7955796409522;1443.6390902274431;1575.4800915697822;1714.0572685023235;1722.3455087066914;6789.083473731045;7525.2850979156965;7660.693572257117;7817.3355264802485;7827.960860195698;7705.306522412981;7719.575423351714;7765.8835117473145;7774.572398518079;7786.1435242123325;2191.4411824984645;2208.4147700859285;2222.69993550871;2225.3880182949656;2225.6772767948637;2212.037763572843;2217.4234698978303;2281.954360912781;2291.9770802292014;2293.0598454633605;2211.845170838042;2237.9328620141423;2238.5187184755273;2267.682524446579;2295.8622482651012;2211.800937915595;2220.922267720622;2225.18780645065;2229.141780414544;2234.3297010896667;2241.6525438556887;2244.9102035918545;2255.1768604459417;2255.548890221946;2265.3317271404976;7858.332041776456;7870.449068565203;7952.8409431811615;7974.3221826144845;7987;4386.210482113218;4481.484629267643;4508.571685689854;4540.318952157169;4541.613962813165;2728.358835673615;2738.87675054621;2743.533599288126;2754.2425832895915;2786.3312804926873;927.5594092805931;930.646354385336;938.4134915677702;944.4852555357347;956.4452617481844;10502.579896804042;10514.684559463152;10547;10552.314099583502;10564.471776411148;4182.2681030819485;4225.154969006211;4359.2807186813825;4374.059577190919;4473.105378924228;8974;9058.139476749699;9061.728148155566;9065.501397423073;9110.134537218953;4687.554682305175;4689.226277664216;4703.670743048022;4713.363695901078;4720.740359280204;3646.9817650912105;4113.239050775616;4223.472065991751;4267.103908179255;4296.2696341621995;3671.632836716307;3744.0826997385816;3781.7352785305316;3822.598627144165;3824.4454554089502;1208.7461633057158;1209.8608660004213;1213.7147770273978;1237.0289322881495;1240.9379531023412;800.8438354520813;873.8470767615642;890.950997695133;894.9686760963335;900.2527901841456;5444.945550544523;5476.863078422992;5489.972550137224;5563.720344320829;5577.888442231133;389.9863504777319;408.985685501012;411.783813497916;417.2864401872771;427.37816477025854;3819.3316169670197;3834.6932245420858;3919.235749028912;3920.627540383659;3959.703022273341;9194.494302813277;9489.525523723787;9512.191463725523;9601.37591056579;9603.087706667855;9018.368714190075;9328.766780830398;9480.288978326653;9497.287703422133;9505.809883802285;7090.220075791659;7186.892196617055;7220.3140701633265;7260.891086633705;7262.564246145248;5277.762500687555;5482.205080263419;5482.753276102665;5567.081431563746;5700.942990570041;8394.496330220207;8707.695230666895;8778.956105219433;8902;8979.820403592023;8405.243528082501;8542.44474109181;8672.219500245008;8725.956370218108;8737.781555461164;6140.600860944024;6546.443552298108;6625.801225963229;6689.632070236184;6949.409300209539;7430.44271679637;7459.813504662427;7542.622868856425;7565.659545320584;7570.470067095251;6686.465082793462;6783.89824152648;6790.7623233186605;6880.346367095118;7017.789466316019;6616.470682345304;6666.233383160805;6776.288489708707;6833.794986150423;6879.759208427681;6236.75052997875;6446.967765161145;6465.870682586228;6474.417302442803;6477.805665830033;4752.928706069342;4869.123557759495;4877.244027175793;4909.140900342354;4949.282354058713;4639.280911458729;4701.20079586478;4708;4716.64625153108;4758.286257061469 07:44:51 INFO - PROCESS | 24603 | |4;prototype.html;292.6780541404455;295.0572919522128;299.3952216522626;300.6872852233677;312.1509494175842;5233.456130441519;5291.814786482474;5301.761420736067;5312.6281160318795;5335.399380185948;5202.219667049944;5211.739413029352;5231.424543300234;5241.816536421226;5250.474952504747;3840.6927445804267;3973.940390894139;4110.897227569305;4118.455579157816;4122.381642753596;4099.405586190001;4106.466159399274;4107.54816970133;4122.804386727846;4128.69034822388;4099.959000410003;4106.835726570934;4109.198706252282;4112.917741645166;4117.855875044374;4020.3165461871554;4037.515498140242;4111.48606424197;4122.752634841904;4129.029678025661;3591.7844929304324;3593.9038593229056;3597.748157628967;3622.5290712207507;3643.4899114124046;5004.499550045003;5015.088231179686;5017.498250174954;5046.7224302663335;5051.191809310492;4585.403897493338;4697.037107392976;4701.647376446746;4728.952710472886;4735.289706544046;5434.994526012701;5519.116941289374;5527.419620939824;5527.778888844441;5577.330720313588;3938.6652134568594;3941.2117576484816;3941.6452519273116;3951.1505026419172;3972.1857019310974;5613.747381367848;5817.912731309034;5818.6217895836635;5826.242588463472;5834.358220595731;4044.939325910114;4064.06526498901;4077.857274995361;4078.7552746835286;4087.305158123126;4118.52636946755;4121.258173528734;4128.720096769951;4129.194807012604;4152.276805125899;4660.997885454576;4694.577488026094;4699.083678682692;4703.918098837286;4707.340972263886;5265.842024739264;5548.778048878;5617.32592088952;5632.662040277596;5656.264685590847;1409.9647508812361;1419.6734751007325;1422.4950142699192;1422.8363738170035;1433.981872870253;923.0815338737999;952.6237136331249;955.8757361542955;959.3668179001965;969.1374676537887;4733.053389322149;4746.644001699887;4755.262934245197;4762.976185119052;4787.186178349689;5639.125935480007;5642.463965923231;5661.66030038199;5677.063284558084;5694.316681998187;4623.976880115645;4720.834770783074;4739.620830333565;4743.28850672395;4750.572448479654;2958.704129587024;3004.3626223708134;3006.8947586834356;3012.3523442459978;3020.2298413904314;5282.815101471507;5300.70846103468;5301.019311427398;5306.575473962073;5337.62636615441;5697.259356283656;5697.971510142505;5765.769369225184;5776.566757493205;5805.245318108703;5277.63056586043;5299.4700529946695;5324.121519949243;5340.439253878442;5352.063388906926;5454.91817622728;5624.775008999594;5634.802781902614;5638.887222255614;5641.1794102948525;5512.5314348280845;5513;5528.170774383874;5564.137558678412;5588.050031494575;5300.3904550975585;5307.283516725192;5315.495027972336;5331.120365139864;5334.573234141182;3726.385146450805;3968.3055465294037;4018.8794336169963;4022.6379625833815;4035.616616421435;5703.230063941315;5713.371529131875;5733.713314334183;5762.711864406847;5786.623869448473;5497.835064948058;5537.28015358017;5551.361593416808;5566.860828479158;5569.860753481195;5355.848492574115;5496.148097044965;5502.625412796756;5534.723263836711;5537.446255374431;5238.580913526833;5420.349558053059;5445.128779395278;5447.836564903059;5454.618176727591;5446.291982042309;5582.609217354746;5634.408387119457;5645.633033852787;5684.545236381162;5471.890562188813;5472.5621950243085;5496.175573663822;5501.119820828648;5539.169124631338 07:44:51 INFO - PROCESS | 24603 | |5;yui.html;669.0900375489334;682.539285981962;704.7779949315968;707.511816846376;759.4987308376473;11400.372979486136;11709.297442153476;11736.53053877845;11736.882631173687;11767.293962362264;12047.518099276018;12056.517739290417;12091.334976576285;12095.879041209586;12155.878441215586;623.3050149083762;776.5263189454429;776.6116941529235;790.4861839804145;801.8757092650649;789.2462698123278;791.3827214772487;795.4471642208667;795.5107608820563;797.9361651067929;835.6532039203723;836.7949852286198;837.1544739812803;837.417994493827;839.8824164616958;832.0722394530115;833.6123702478316;833.7707130539089;834.5368320582074;835.1022650650544;612.8284080457479;613.7054213977316;613.8158552434252;614.2352770800337;614.6127939398195;12463.501459941592;12515.249085054926;12518.06114541413;12526.561570345086;12556;13023.544175953795;13033.087683862133;13068.150570212905;13093.214407135602;13407.597772066756;10040.548175332127;10108.696739097839;10144.340617859816;10188.949055254676;10341.793164136676;3233.96766032339;3257.625373082102;3271.7219036381935;3310.337932413527;3316.0714999800093;43780;44246.55753442489;46357.76821115873;46374.53625463736;46567.767161163974;10345.586176552853;10394.948025259977;10474.528646210938;10481.475926203659;10553.102986246102;18050.819491804912;18132.274709011755;18136.455906322568;18156.63686726258;18163.09184540794;6538.476921846241;6603.504737144734;6795.082663840319;6995.615241161785;7171.426285897116;3777.9433308500393;3884.864029758945;3901;3904.04350934023;3918.6865050796437;2856.557233628791;2999.865006074732;3122.281875168724;3138.5135304027913;3142.4657808172665;551.3411473289381;552.6435449135286;554.4732504121101;565.6634302589953;569.0979797021685;488.05408274104263;586.2993722501569;587.6151121015741;607.7386723708847;652.2499126005132;7709.2290770922455;7923.405744569181;8127.674893004332;8153.8776918346275;8417.705380311781;504.60388594952786;518.5177784660302;632.3960617610171;633.996830015847;654.6170490263249;3585.31878943;3818.9236215276096;3850.210706805098;3856.4986551748652;4007.8998025049023;49542.50457495451;51478.22782658263;51559.48440515622;53296;54004;44730.32904506435;44872.3269150963;45559;45783.313250301275;46308.7684561575;41086.38370424446;41431.58568414338;41748.95627609274;41957.370639439825;42827.571724282985;7291.161516425679;7350.705971761284;7425.8143546411775;7464.853148799945;7508.887366689395;25087.623685645096;25124.24627261185;25999.220023399328;26736.598951016138;28267.575986360633;34615.13462163466;34650.30699386049;34973.125671857386;35627.10932226715;35990.82004590065;10430.061294483532;10461.9476902615;10499.47502624881;10632.468376580986;10656.62701805433;11824.645260642195;12134.939325303318;12154.817677735018;12311.322877241837;12730.490780369051;9399.154076133182;11327.093832493216;11498.48256828428;11606.651800446;11692.532298707956;11397.658070257905;11467.598634047768;11615.941920290345;11617.244879082833;12189.51241950312;11101.777964440827;11124.332540047622;11269.098472122374;11293.096552275963;11458.541658333907;9241.806652464387;9317.813643727222;9318.394304370195;9677.9032209677;9785.461799601091;9904.356216845881;10174.643887463903;10233.641822536474;10269.53787079598;10320.793584128425 07:44:51 INFO - PROCESS | 24603 | __end_tp_report 07:44:51 INFO - PROCESS | 24603 | __start_cc_report 07:44:51 INFO - PROCESS | 24603 | _x_x_mozilla_cycle_collect,369 07:44:51 INFO - PROCESS | 24603 | __end_cc_report 07:44:51 INFO - PROCESS | 24603 | __startTimestamp1461249891870__endTimestamp 07:44:51 INFO - PROCESS | 24603 | 07:44:51 INFO - PROCESS | 24603 | ------- Summary: start ------- 07:44:51 INFO - PROCESS | 24603 | Number of tests: 6 07:44:51 INFO - PROCESS | 24603 | 07:44:51 INFO - PROCESS | 24603 | [#0] dojo.html Cycles:165 Average:4570.80 Median:4734.48 stddev:470.99 (9.9%) stddev-sans-first:446.17 07:44:51 INFO - PROCESS | 24603 | Values: 2593.6 2602.5 2639.6 2652.2 2662.9 4567.3 4593.7 4608.9 4625.5 4654.6 4464.6 4599.7 4620.8 4666.7 4667.9 4260.1 4289.7 4330.7 4339.9 4381.8 4281.6 4320.2 4345.8 4378.5 4379.1 4161.6 4241.7 4283.1 4295.0 4316.3 4187.8 4196.2 4199.3 4221.3 4262.8 4235.8 4259.3 4263.4 4279.0 4291.0 4503.4 4525.3 4559.7 4584.2 4598.5 4833.1 4856.4 4862.8 4878.9 4912.9 4884.3 4892.9 4901.2 4914.6 4937.8 4648.3 4660.0 4671.3 4712.5 4729.7 5002.5 5024.3 5027.7 5029.8 5054.7 4738.4 4828.5 4840.3 4855.9 4896.9 4913.1 4923.4 4941.0 4957.2 4987.3 4713.4 4774.3 4831.0 4860.5 4950.1 4828.1 4828.7 4839.0 4890.2 4907.6 4021.7 4118.4 4143.3 4162.4 4190.0 3633.4 3645.4 3653.0 3688.6 3695.0 4241.7 4246.0 4267.3 4268.4 4272.1 4982.9 4993.7 4994.6 5048.4 5066.3 4184.8 4219.0 4235.6 4274.3 4277.1 4406.4 4411.8 4430.8 4452.8 4521.0 4715.7 4728.0 4734.5 4761.0 4762.9 4959.4 4997.3 5019.1 5025.0 5064.3 4536.6 4682.0 4738.4 4739.5 4760.5 4891.5 4907.7 4912.4 4919.1 4931.3 4957.7 4963.7 4976.5 4993.2 4997.2 4726.9 4799.1 4833.8 4874.3 4877.4 4621.9 4782.7 4817.5 4851.4 4867.1 4761.7 4763.5 4766.0 4804.4 4836.7 4777.3 4843.1 4863.2 4872.7 4901.9 4742.2 4745.2 4746.3 4750.7 4802.5 07:44:51 INFO - PROCESS | 24603 | 07:44:51 INFO - PROCESS | 24603 | [#1] ext.html Cycles:180 Average:45635.00 Median:3519.59 stddev:83858.66 (2382.6%) stddev-sans-first:84025.65 07:44:51 INFO - PROCESS | 24603 | Values: 573.2 586.5 605.7 607.7 623.2 34628.5 36039.5 36109.5 36126.6 36204.1 35439.6 35484.8 35996.6 36141.5 36153.5 7675.2 7916.1 7923.8 7927.0 7927.8 7805.9 7848.0 7910.8 7926.3 7939.7 7892.6 7967.3 7984.3 8013.8 8026.4 7855.6 7938.9 7942.9 7949.6 7986.5 7821.4 7891.6 7942.6 7950.6 7960.0 28605.6 35709.1 35903.1 36069.3 36084.3 3051.5 3054.2 3069.4 3279.3 3513.8 26788.5 26943.9 27176.3 27236.0 27748.6 3378.3 3387.3 3432.2 3525.4 3532.0 262894.0 269599.0 269618.0 270665.6 272066.0 33294.0 52760.5 53260.7 53416.5 53430.2 33837.8 34237.1 34262.3 34323.0 34335.5 12580.3 12800.8 12836.1 12860.3 12868.5 9982.0 10027.7 10066.0 10106.1 10123.7 8193.2 8260.0 8353.5 8399.6 8452.1 3318.9 3325.5 3356.7 3387.8 3405.7 932.2 951.9 956.6 1020.7 1033.5 28186.0 28710.7 29217.9 29246.7 29345.4 1047.8 1050.9 1055.8 1069.1 1101.0 14784.0 15212.7 15285.2 15352.8 15419.0 360743.0 367299.0 368681.0 369149.0 369452.0 48951.3 49506.0 49738.8 49791.5 49959.5 1223.6 1228.5 1236.8 1241.6 1255.2 26599.9 27498.5 27816.9 28053.3 28475.6 43450.8 43660.3 44290.0 44333.1 44379.6 309944.0 310684.0 311232.0 311727.0 312365.0 25317.2 25865.6 26054.7 26148.7 26211.9 41120.0 42018.4 42077.6 42390.6 42427.0 35742.5 35912.5 35985.5 36172.0 36403.1 34461.1 35663.6 35894.6 36108.3 36258.5 29532.7 33349.0 34052.7 36345.0 36453.6 28327.6 29236.4 29513.0 31679.4 31967.8 24754.5 24945.0 24987.9 25246.4 25290.6 07:44:51 INFO - PROCESS | 24603 | 07:44:51 INFO - PROCESS | 24603 | [#2] jquery.html Cycles:180 Average:23395.70 Median:4954.94 stddev:62328.85 (1257.9%) stddev-sans-first:62479.71 07:44:51 INFO - PROCESS | 24603 | Values: 366.4 367.2 372.4 376.0 381.9 15644.5 16423.8 17621.3 17650.8 17655.1 16174.9 16424.5 17175.2 17350.1 17437.9 4961.5 5082.0 5130.9 5136.1 5145.8 3638.2 5031.9 5433.9 5768.0 5783.9 5699.7 5701.6 5704.1 5709.8 5743.3 5431.7 5625.6 5627.1 5627.6 5642.8 4872.9 4911.6 4942.2 4948.4 4977.8 19415.7 19932.8 20045.2 20060.9 20674.5 1917.5 1928.1 1962.5 1978.9 2028.3 12730.7 13296.8 13361.5 13589.8 13611.5 1747.9 1825.5 1825.7 1841.8 1844.5 66059.3 66150.3 66588.0 67065.0 67331.6 8780.6 8792.8 9046.5 9485.5 9783.0 12294.0 12503.1 12537.7 12541.7 12604.8 6891.6 6903.5 6955.7 7115.8 7152.2 6729.7 6745.2 6852.1 6868.2 6881.9 5770.4 5896.7 5923.0 5949.4 5972.5 1548.3 1663.6 1746.2 1794.9 1803.8 913.3 917.1 922.0 986.0 1076.7 15547.4 16046.8 16653.4 17017.2 17130.7 931.4 943.4 961.4 1000.7 1009.6 9546.7 9718.5 9738.4 9742.9 9842.7 373677.0 373945.0 376191.0 384189.0 385018.0 67208.3 67858.0 68773.7 70187.3 70779.6 857.1 858.8 877.3 877.4 878.2 13824.9 14935.8 14964.7 15016.9 15026.4 31386.8 32586.8 35206.3 35865.0 36175.0 46134.0 46720.1 46995.1 47025.0 47931.8 7796.4 7889.9 8020.4 8031.4 8257.3 8345.6 8365.2 8789.6 11065.2 11906.6 7271.1 7610.2 7625.7 7675.6 7995.7 4074.7 6405.3 7883.8 8039.3 8052.2 7269.5 7738.9 7913.5 7927.1 7962.8 10703.3 10994.6 11186.3 11346.6 11716.1 10657.4 10850.1 10852.7 11084.9 11255.8 07:44:51 INFO - PROCESS | 24603 | 07:44:51 INFO - PROCESS | 24603 | [#3] mootools.html Cycles:180 Average:5143.57 Median:5361.35 stddev:2829.01 (52.8%) stddev-sans-first:2823.03 07:44:51 INFO - PROCESS | 24603 | Values: 1409.8 1443.6 1575.5 1714.1 1722.3 6789.1 7525.3 7660.7 7817.3 7828.0 7705.3 7719.6 7765.9 7774.6 7786.1 2191.4 2208.4 2222.7 2225.4 2225.7 2212.0 2217.4 2282.0 2292.0 2293.1 2211.8 2237.9 2238.5 2267.7 2295.9 2211.8 2220.9 2225.2 2229.1 2234.3 2241.7 2244.9 2255.2 2255.5 2265.3 7858.3 7870.4 7952.8 7974.3 7987.0 4386.2 4481.5 4508.6 4540.3 4541.6 2728.4 2738.9 2743.5 2754.2 2786.3 927.6 930.6 938.4 944.5 956.4 10502.6 10514.7 10547.0 10552.3 10564.5 4182.3 4225.2 4359.3 4374.1 4473.1 8974.0 9058.1 9061.7 9065.5 9110.1 4687.6 4689.2 4703.7 4713.4 4720.7 3647.0 4113.2 4223.5 4267.1 4296.3 3671.6 3744.1 3781.7 3822.6 3824.4 1208.7 1209.9 1213.7 1237.0 1240.9 800.8 873.8 891.0 895.0 900.3 5444.9 5476.9 5490.0 5563.7 5577.9 390.0 409.0 411.8 417.3 427.4 3819.3 3834.7 3919.2 3920.6 3959.7 9194.5 9489.5 9512.2 9601.4 9603.1 9018.4 9328.8 9480.3 9497.3 9505.8 7090.2 7186.9 7220.3 7260.9 7262.6 5277.8 5482.2 5482.8 5567.1 5700.9 8394.5 8707.7 8779.0 8902.0 8979.8 8405.2 8542.4 8672.2 8726.0 8737.8 6140.6 6546.4 6625.8 6689.6 6949.4 7430.4 7459.8 7542.6 7565.7 7570.5 6686.5 6783.9 6790.8 6880.3 7017.8 6616.5 6666.2 6776.3 6833.8 6879.8 6236.8 6447.0 6465.9 6474.4 6477.8 4752.9 4869.1 4877.2 4909.1 4949.3 4639.3 4701.2 4708.0 4716.6 4758.3 07:44:51 INFO - PROCESS | 24603 | 07:44:51 INFO - PROCESS | 24603 | [#4] prototype.html Cycles:180 Average:4576.02 Median:5246.15 stddev:1331.26 (25.4%) stddev-sans-first:1295.59 07:44:51 INFO - PROCESS | 24603 | Values: 292.7 295.1 299.4 300.7 312.2 5233.5 5291.8 5301.8 5312.6 5335.4 5202.2 5211.7 5231.4 5241.8 5250.5 3840.7 3973.9 4110.9 4118.5 4122.4 4099.4 4106.5 4107.5 4122.8 4128.7 4100.0 4106.8 4109.2 4112.9 4117.9 4020.3 4037.5 4111.5 4122.8 4129.0 3591.8 3593.9 3597.7 3622.5 3643.5 5004.5 5015.1 5017.5 5046.7 5051.2 4585.4 4697.0 4701.6 4729.0 4735.3 5435.0 5519.1 5527.4 5527.8 5577.3 3938.7 3941.2 3941.6 3951.2 3972.2 5613.7 5817.9 5818.6 5826.2 5834.4 4044.9 4064.1 4077.9 4078.8 4087.3 4118.5 4121.3 4128.7 4129.2 4152.3 4661.0 4694.6 4699.1 4703.9 4707.3 5265.8 5548.8 5617.3 5632.7 5656.3 1410.0 1419.7 1422.5 1422.8 1434.0 923.1 952.6 955.9 959.4 969.1 4733.1 4746.6 4755.3 4763.0 4787.2 5639.1 5642.5 5661.7 5677.1 5694.3 4624.0 4720.8 4739.6 4743.3 4750.6 2958.7 3004.4 3006.9 3012.4 3020.2 5282.8 5300.7 5301.0 5306.6 5337.6 5697.3 5698.0 5765.8 5776.6 5805.2 5277.6 5299.5 5324.1 5340.4 5352.1 5454.9 5624.8 5634.8 5638.9 5641.2 5512.5 5513.0 5528.2 5564.1 5588.1 5300.4 5307.3 5315.5 5331.1 5334.6 3726.4 3968.3 4018.9 4022.6 4035.6 5703.2 5713.4 5733.7 5762.7 5786.6 5497.8 5537.3 5551.4 5566.9 5569.9 5355.8 5496.1 5502.6 5534.7 5537.4 5238.6 5420.3 5445.1 5447.8 5454.6 5446.3 5582.6 5634.4 5645.6 5684.5 5471.9 5472.6 5496.2 5501.1 5539.2 07:44:51 INFO - PROCESS | 24603 | 07:44:51 INFO - PROCESS | 24603 | [#5] yui.html Cycles:180 Average:12591.21 Median:3911.37 stddev:14004.21 (358.0%) stddev-sans-first:14014.88 07:44:51 INFO - PROCESS | 24603 | Values: 669.1 682.5 704.8 707.5 759.5 11400.4 11709.3 11736.5 11736.9 11767.3 12047.5 12056.5 12091.3 12095.9 12155.9 623.3 776.5 776.6 790.5 801.9 789.2 791.4 795.4 795.5 797.9 835.7 836.8 837.2 837.4 839.9 832.1 833.6 833.8 834.5 835.1 612.8 613.7 613.8 614.2 614.6 12463.5 12515.2 12518.1 12526.6 12556.0 13023.5 13033.1 13068.2 13093.2 13407.6 10040.5 10108.7 10144.3 10188.9 10341.8 3234.0 3257.6 3271.7 3310.3 3316.1 43780.0 44246.6 46357.8 46374.5 46567.8 10345.6 10394.9 10474.5 10481.5 10553.1 18050.8 18132.3 18136.5 18156.6 18163.1 6538.5 6603.5 6795.1 6995.6 7171.4 3777.9 3884.9 3901.0 3904.0 3918.7 2856.6 2999.9 3122.3 3138.5 3142.5 551.3 552.6 554.5 565.7 569.1 488.1 586.3 587.6 607.7 652.2 7709.2 7923.4 8127.7 8153.9 8417.7 504.6 518.5 632.4 634.0 654.6 3585.3 3818.9 3850.2 3856.5 4007.9 49542.5 51478.2 51559.5 53296.0 54004.0 44730.3 44872.3 45559.0 45783.3 46308.8 41086.4 41431.6 41749.0 41957.4 42827.6 7291.2 7350.7 7425.8 7464.9 7508.9 25087.6 25124.2 25999.2 26736.6 28267.6 34615.1 34650.3 34973.1 35627.1 35990.8 10430.1 10461.9 10499.5 10632.5 10656.6 11824.6 12134.9 12154.8 12311.3 12730.5 9399.2 11327.1 11498.5 11606.7 11692.5 11397.7 11467.6 11615.9 11617.2 12189.5 11101.8 11124.3 11269.1 11293.1 11458.5 9241.8 9317.8 9318.4 9677.9 9785.5 9904.4 10174.6 10233.6 10269.5 10320.8 07:44:51 INFO - PROCESS | 24603 | -------- Summary: end -------- 07:44:51 INFO - PROCESS | 24603 | 07:44:52 INFO - TEST-INFO | 24603: exit 0 07:44:52 INFO - TEST-OK | dromaeo_css | took 1113998ms 07:44:52 INFO - TEST-START | kraken 07:44:52 INFO - operating with platform_type : linux_ 07:44:52 INFO - Initialising browser for kraken test... 07:44:52 INFO - TEST-INFO | started process 24841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFE7LBV/profile http://localhost:47031/getInfo.html) 07:44:56 INFO - PROCESS | 24841 | 07:44:56 INFO - PROCESS | 24841 | (process:24911): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:44:56 INFO - PROCESS | 24841 | __metrics Screen width/height:1600/1200 07:44:56 INFO - PROCESS | 24841 | colorDepth:24 07:44:56 INFO - PROCESS | 24841 | Browser inner width/height: 1024/697 07:44:56 INFO - PROCESS | 24841 | __metrics 07:44:57 ERROR - PROCESS | 24841 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:44:58 INFO - TEST-INFO | 24841: exit 0 07:44:58 INFO - Browser initialized. 07:44:58 INFO - Running cycle 1/1 for kraken test... 07:44:58 INFO - TEST-INFO | started process 24962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFE7LBV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:00 INFO - PROCESS | 24962 | 07:45:00 INFO - PROCESS | 24962 | (process:25023): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:45:10 INFO - PROCESS | 24962 | RSS: Main: 164810752 07:45:10 INFO - PROCESS | 24962 | 07:45:12 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47031/tests/kraken/driver.html?testName=audio-beat-detection) 07:45:13 INFO - PROCESS | 24962 | RSS: Main: 168652800 07:45:13 INFO - PROCESS | 24962 | 07:45:16 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47031/tests/kraken/driver.html?testName=audio-dft) 07:45:17 INFO - PROCESS | 24962 | RSS: Main: 171884544 07:45:17 INFO - PROCESS | 24962 | 07:45:20 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47031/tests/kraken/driver.html?testName=audio-fft) 07:45:20 INFO - PROCESS | 24962 | RSS: Main: 165421056 07:45:20 INFO - PROCESS | 24962 | 07:45:22 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47031/tests/kraken/driver.html?testName=audio-oscillator) 07:45:23 INFO - PROCESS | 24962 | RSS: Main: 165777408 07:45:23 INFO - PROCESS | 24962 | 07:45:25 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47031/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:45:26 INFO - PROCESS | 24962 | RSS: Main: 166649856 07:45:26 INFO - PROCESS | 24962 | 07:45:29 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47031/tests/kraken/driver.html?testName=imaging-darkroom) 07:45:30 INFO - PROCESS | 24962 | RSS: Main: 166191104 07:45:30 INFO - PROCESS | 24962 | 07:45:33 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47031/tests/kraken/driver.html?testName=imaging-desaturate) 07:45:34 INFO - PROCESS | 24962 | RSS: Main: 163696640 07:45:34 INFO - PROCESS | 24962 | 07:45:37 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47031/tests/kraken/driver.html?testName=json-parse-financial) 07:45:37 INFO - PROCESS | 24962 | RSS: Main: 164511744 07:45:37 INFO - PROCESS | 24962 | 07:45:39 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47031/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:40 INFO - PROCESS | 24962 | RSS: Main: 164880384 07:45:40 INFO - PROCESS | 24962 | 07:45:42 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:42 INFO - PROCESS | 24962 | RSS: Main: 164589568 07:45:42 INFO - PROCESS | 24962 | 07:45:45 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:45 INFO - PROCESS | 24962 | RSS: Main: 165244928 07:45:45 INFO - PROCESS | 24962 | 07:45:48 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:49 INFO - PROCESS | 24962 | RSS: Main: 165318656 07:45:49 INFO - PROCESS | 24962 | 07:45:52 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:52 INFO - PROCESS | 24962 | RSS: Main: 165376000 07:45:52 INFO - PROCESS | 24962 | 07:45:54 INFO - PROCESS | 24962 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47031/tests/kraken/driver.html?testName=ai-astar) 07:45:54 INFO - PROCESS | 24962 | RSS: Main: 166838272 07:45:54 INFO - PROCESS | 24962 | 07:45:54 INFO - PROCESS | 24962 | __start_tp_report 07:45:54 INFO - PROCESS | 24962 | _x_x_mozilla_page_load 07:45:54 INFO - PROCESS | 24962 | _x_x_mozilla_page_load_details 07:45:54 INFO - PROCESS | 24962 | |i|pagename|runs| 07:45:54 INFO - PROCESS | 24962 | |0;ai-astar;114;109;113;115;113;127;113;114;115;115 07:45:54 INFO - PROCESS | 24962 | |1;audio-beat-detection;166;133;167;187;135;159;161;134;196;135 07:45:54 INFO - PROCESS | 24962 | |2;audio-dft;164;163;164;170;162;163;163;162;166;162 07:45:54 INFO - PROCESS | 24962 | |3;audio-fft;75;75;79;154;80;75;73;74;161;81 07:45:54 INFO - PROCESS | 24962 | |4;audio-oscillator;95;94;158;94;96;95;142;95;94;138 07:45:54 INFO - PROCESS | 24962 | |5;imaging-gaussian-blur;117;118;117;118;119;118;118;118;118;117 07:45:54 INFO - PROCESS | 24962 | |6;imaging-darkroom;152;149;147;148;148;147;147;147;148;147 07:45:54 INFO - PROCESS | 24962 | |7;imaging-desaturate;96;97;96;96;96;96;96;95;95;96 07:45:55 INFO - PROCESS | 24962 | |8;json-parse-financial;67;65;65;65;67;65;66;79;64;74 07:45:55 INFO - PROCESS | 24962 | |9;json-stringify-tinderbox;65;66;67;65;66;66;66;72;65;65 07:45:55 INFO - PROCESS | 24962 | |10;stanford-crypto-aes;80;82;81;82;90;89;82;80;84;79 07:45:55 INFO - PROCESS | 24962 | |11;stanford-crypto-ccm;137;150;135;146;134;134;143;135;179;137 07:45:55 INFO - PROCESS | 24962 | |12;stanford-crypto-pbkdf2;185;186;189;182;182;188;176;183;177;179 07:45:55 INFO - PROCESS | 24962 | |13;stanford-crypto-sha256-iterative;76;74;73;75;77;76;72;76;73;73 07:45:55 INFO - PROCESS | 24962 | __end_tp_report 07:45:55 INFO - PROCESS | 24962 | __start_cc_report 07:45:55 INFO - PROCESS | 24962 | _x_x_mozilla_cycle_collect,943 07:45:55 INFO - PROCESS | 24962 | __end_cc_report 07:45:55 INFO - PROCESS | 24962 | __startTimestamp1461249954994__endTimestamp 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | ------- Summary: start ------- 07:45:55 INFO - PROCESS | 24962 | Number of tests: 14 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.50 stddev:4.64 (4.1%) stddev-sans-first:4.91 07:45:55 INFO - PROCESS | 24962 | Values: 114.0 109.0 113.0 115.0 113.0 127.0 113.0 114.0 115.0 115.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#1] audio-beat-detection Cycles:10 Average:157.30 Median:163.50 stddev:22.84 (14.0%) stddev-sans-first:24.01 07:45:55 INFO - PROCESS | 24962 | Values: 166.0 133.0 167.0 187.0 135.0 159.0 161.0 134.0 196.0 135.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.47 (1.5%) stddev-sans-first:2.62 07:45:55 INFO - PROCESS | 24962 | Values: 164.0 163.0 164.0 170.0 162.0 163.0 163.0 162.0 166.0 162.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.00 stddev:34.30 (45.7%) stddev-sans-first:35.77 07:45:55 INFO - PROCESS | 24962 | Values: 75.0 75.0 79.0 154.0 80.0 75.0 73.0 74.0 161.0 81.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:94.50 stddev:25.28 (26.7%) stddev-sans-first:26.21 07:45:55 INFO - PROCESS | 24962 | Values: 95.0 94.0 158.0 94.0 96.0 95.0 142.0 95.0 94.0 138.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 07:45:55 INFO - PROCESS | 24962 | Values: 117.0 118.0 117.0 118.0 119.0 118.0 118.0 118.0 118.0 117.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.56 (1.1%) stddev-sans-first:0.73 07:45:55 INFO - PROCESS | 24962 | Values: 152.0 149.0 147.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:45:55 INFO - PROCESS | 24962 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:66.50 stddev:4.88 (7.3%) stddev-sans-first:5.17 07:45:55 INFO - PROCESS | 24962 | Values: 67.0 65.0 65.0 65.0 67.0 65.0 66.0 79.0 64.0 74.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:2.11 (3.2%) stddev-sans-first:2.19 07:45:55 INFO - PROCESS | 24962 | Values: 65.0 66.0 67.0 65.0 66.0 66.0 66.0 72.0 65.0 65.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:3.75 (4.6%) stddev-sans-first:3.83 07:45:55 INFO - PROCESS | 24962 | Values: 80.0 82.0 81.0 82.0 90.0 89.0 82.0 80.0 84.0 79.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:140.00 stddev:13.81 (9.9%) stddev-sans-first:14.47 07:45:55 INFO - PROCESS | 24962 | Values: 137.0 150.0 135.0 146.0 134.0 134.0 143.0 135.0 179.0 137.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:184.00 stddev:4.42 (2.4%) stddev-sans-first:4.61 07:45:55 INFO - PROCESS | 24962 | Values: 185.0 186.0 189.0 182.0 182.0 188.0 176.0 183.0 177.0 179.0 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - PROCESS | 24962 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:75.50 stddev:1.72 (2.3%) stddev-sans-first:1.73 07:45:55 INFO - PROCESS | 24962 | Values: 76.0 74.0 73.0 75.0 77.0 76.0 72.0 76.0 73.0 73.0 07:45:55 INFO - PROCESS | 24962 | -------- Summary: end -------- 07:45:55 INFO - PROCESS | 24962 | 07:45:55 INFO - TEST-INFO | 24962: exit 0 07:45:55 INFO - TEST-OK | kraken | took 63358ms 07:45:55 INFO - SUITE-END | took 1177s 07:45:56 INFO - Completed test suite (00:19:37) 07:45:56 INFO - javascript benchmark 07:45:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.610958356246, 2602.531544322021, 2639.564471862143, 2652.1513115802927, 2662.8801703923323, 4567.269236922093, 4593.655475839313, 4608.884777880547, 4625.468071171812, 4654.581087702106, 4464.5981861632445, 4599.678022538424, 4620.7689615519175, 4666.696664716791, 4667.929981050287, 4260.147970405924, 4289.678274129437, 4330.7401555906745, 4339.869803905888, 4381.780910954455, 4281.571842815724, 4320.157569273977, 4345.804438800245, 4378.496472905609, 4379.08039311745, 4161.625453709181, 4241.681873859473, 4283.057727299989, 4295.0, 4316.330968699856, 4187.769672668002, 4196.244675958326, 4199.328107502785, 4221.261279276115, 4262.829486820523, 4235.767032813194, 4259.254630439661, 4263.4031235627035, 4278.9730464688255, 4291.034517233628, 4503.369528266046, 4525.32120181972, 4559.726416415026, 4584.243599806028, 4598.494165641777, 4833.081714474274, 4856.368672072644, 4862.781174847105, 4878.902421951577, 4912.8945987152965, 4884.29177769225, 4892.8532144035735, 4901.191303434929, 4914.631402644816, 4937.8271760488215, 4648.302754586805, 4659.953400465952, 4671.299305104261, 4712.458067322234, 4729.668923175379, 5002.474740152305, 5024.346834911511, 5027.698338099725, 5029.7736601853, 5054.721990290495, 4738.431388233434, 4828.46886842447, 4840.322354870321, 4855.902881942341, 4896.902061958741, 4913.091078150554, 4923.384576927884, 4941.03649788295, 4957.20684690455, 4987.301777751118, 4713.410823647044, 4774.30772537987, 4830.95169048305, 4860.465348811628, 4950.084234416644, 4828.106800241966, 4828.66199366048, 4839.0, 4890.168671325883, 4907.607391408679, 4021.698372622065, 4118.402831589403, 4143.295639741251, 4162.354835000579, 4190.036291652876, 3633.4186530155575, 3645.434957581579, 3652.9817350913077, 3688.5573731152435, 3694.9815250923575, 4241.724287921275, 4246.0, 4267.295896177096, 4268.359746038119, 4272.145570885836, 4982.9252561211615, 4993.650444468925, 4994.550490455877, 5048.444671086178, 5066.290719299301, 4184.7796318151195, 4218.957810421918, 4235.555266697014, 4274.316109422478, 4277.080427708058, 4406.405135306757, 4411.779411029435, 4430.8449204277695, 4452.84226101216, 4520.9827788747925, 4715.693479923794, 4727.976360118246, 4734.479207287196, 4760.95239047612, 4762.880927976828, 4959.355283813081, 4997.3253610762085, 5019.071471777733, 5025.0, 5064.341635587498, 4536.56902594253, 4681.953180468152, 4738.407699037621, 4739.502352252964, 4760.476347601831, 4891.486393928729, 4907.705537667752, 4912.38595175603, 4919.139150648551, 4931.309616653743, 4957.727324997016, 4963.726995015309, 4976.452590215001, 4993.151164302005, 4997.1754660482065, 4726.905461890812, 4799.112164249625, 4833.806647734052, 4874.341963834979, 4877.3903262092235, 4621.907561848677, 4782.665213435026, 4817.5182481752945, 4851.442084160367, 4867.075255701406, 4761.738104404291, 4763.523647635208, 4766.046790641954, 4804.423469183581, 4836.709797412166, 4777.259524773665, 4843.055604157155, 4863.221884498605, 4872.6832755870755, 4901.9019619608125, 4742.241241401359, 4745.193317136164, 4746.311784791255, 4750.714957102585, 4802.471728109836], "value": 4541.441556463349, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.15459696947, 586.4838941731276, 605.6699098991049, 607.6657838188995, 623.2489849731069, 34628.48057279143, 36039.459408108865, 36109.45835812465, 36126.63873361266, 36204.09489762754, 35439.645603543955, 35484.82257588708, 35996.64003359966, 36141.45787813178, 36153.45769813448, 7675.194104619019, 7916.0500739911295, 7923.801904952394, 7926.960365198166, 7927.8414431711335, 7805.8829117563, 7847.960760196191, 7910.762677119696, 7926.326262267714, 7939.682412703485, 7892.644830982619, 7967.322777563914, 7984.281414672679, 8013.799655008613, 8026.398020148483, 7855.646495907669, 7938.880916786253, 7942.920570794276, 7949.64226609804, 7986.480878742921, 7821.413393995473, 7891.565963871984, 7942.570337339276, 7950.6422211000645, 7960.044794624682, 28605.57091643627, 35709.10727231814, 35903.102422439384, 36069.27861442783, 36084.278314433825, 3051.529232263003, 3054.2364408897774, 3069.3707789903237, 3279.262166012652, 3513.789172649649, 26788.464230715275, 26943.865280673668, 27176.32059198516, 27236.0, 27748.583771243448, 3378.3074469733647, 3387.3394688035596, 3432.1934345428804, 3525.383057964846, 3531.99338188615, 262894.0, 269599.0, 269618.0, 270665.64667176735, 272066.0, 33294.0, 52760.47239527632, 53260.73369633205, 53416.46583534115, 53430.19854702183, 33837.830810845786, 34237.14407139841, 34262.31475370529, 34323.0, 34335.484967725504, 12580.30808305552, 12800.80798788019, 12836.101472896995, 12860.292683902288, 12868.549600763929, 9982.0, 10027.699169024942, 10066.0, 10106.14097801695, 10123.7469063274, 8193.221643943816, 8259.95870020646, 8353.498790072616, 8399.580020999048, 8452.070272270046, 3318.8672453101603, 3325.5011748237957, 3356.7314614830757, 3387.8475468603974, 3405.659434056624, 932.1610550504464, 951.9333646644668, 956.5886668732372, 1020.698893826323, 1033.452270296744, 28186.0, 28710.712892871223, 29217.85391073031, 29246.7075329244, 29345.413091738046, 1047.8061558611682, 1050.9474526273655, 1055.7624534479835, 1069.0912724184382, 1100.9779804403868, 14784.0, 15212.695746085237, 15285.235738213267, 15352.769708454382, 15419.0, 360743.0, 367299.0, 368681.0, 369149.0, 369452.0, 48951.265731014064, 49506.0, 49738.75130624396, 49791.50208497869, 49959.500404996215, 1223.6390264871884, 1228.4594778297521, 1236.771197328497, 1241.6275117464725, 1255.2468518888593, 26599.867000665647, 27498.45003099887, 27816.86091569529, 28053.298667533476, 28475.572866406605, 43450.782746086064, 43660.34509482424, 44290.0, 44333.11333773371, 44379.55620443754, 309944.0, 310684.0, 311232.0, 311727.0, 312365.0, 25317.240482785546, 25865.612015820156, 26054.73945260599, 26148.738512615393, 26211.868940655175, 41120.0, 42018.36972445354, 42077.57922420859, 42390.5760942399, 42427.0, 35742.46386304156, 35912.4613130798, 35985.460218096225, 36172.0, 36403.089922752144, 34461.13847153741, 35663.64336356707, 35894.64105358913, 36108.27783444264, 36258.4561231587, 29532.704672952994, 33349.0, 34052.65947340495, 36345.0, 36453.63546364608, 28327.575086374134, 29236.415271694023, 29513.0, 31679.36641267208, 31967.840160799045, 24754.50490990206, 24945.0, 24987.87506062458, 25246.368840779127, 25290.620640690773], "value": 16422.175925796055, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.3735013127552, 367.1921772101376, 372.37998732111043, 375.98872033838995, 381.87970789201415, 15644.53066408008, 16423.83576164238, 17621.295148194058, 17650.823491765077, 17655.117244137775, 16174.919125404356, 16424.507264782045, 17175.227114779835, 17350.132493375313, 17437.912810435962, 4961.503849615027, 5081.974590127044, 5130.871728206806, 5136.101182293102, 5145.845624631267, 3638.181409182939, 5031.949680503203, 5433.864153396157, 5768.04827203513, 5783.884322313551, 5699.686517241571, 5701.629394089392, 5704.087346024637, 5709.800156994506, 5743.253377060976, 5431.6740995540395, 5625.634333768292, 5627.099664053731, 5627.6060675752715, 5642.802501912454, 4872.878178045542, 4911.631627627907, 4942.209246520575, 4948.38145231846, 4977.751112444364, 19415.708764368545, 19932.800671993384, 20045.1981920723, 20060.899695501575, 20674.48313792152, 1917.51103468616, 1928.0648885290623, 1962.479942815155, 1978.9010549472468, 2028.330650885219, 12730.745385092247, 13296.800547991788, 13361.532346367927, 13589.796153057712, 13611.52359667407, 1747.8514326282282, 1825.4979880532826, 1825.7170138628535, 1841.8250266224686, 1844.5204246895769, 66059.33940660532, 66150.33849661538, 66588.0, 67065.0, 67331.63341832938, 8780.648774049094, 8792.78018049541, 9046.547672616343, 9485.525723713787, 9783.0, 12294.0, 12503.124781265406, 12537.74924501505, 12541.686457838445, 12604.81092783609, 6891.586504809728, 6903.482238832108, 6955.6869940852785, 7115.750948716874, 7152.17749958751, 6729.663516824139, 6745.156855393076, 6852.074969879102, 6868.210155832044, 6881.862362752717, 5770.42295770428, 5896.705164741746, 5923.0, 5949.3753155918, 5972.522198224132, 1548.3342162869849, 1663.5628803802488, 1746.175246867027, 1794.8743587948718, 1803.8196180381856, 913.2830727878584, 917.0737555069428, 921.9904204895629, 986.0189111833771, 1076.6554702495127, 15547.378104875905, 16046.839531604768, 16653.41713040038, 17017.234224459928, 17130.743038854427, 931.366670663955, 943.4386540008684, 961.427950369529, 1000.6747806962766, 1009.5759780892043, 9546.733633426367, 9718.465484398284, 9738.367006144577, 9742.853857192147, 9842.704718858446, 373677.0, 373945.0, 376191.0, 384189.0, 385018.0, 67208.32791672119, 67858.0, 68773.65613171902, 70187.29812701808, 70779.6461017702, 857.1342943626981, 858.7638399440204, 877.3376101043799, 877.4165180155253, 878.1876763993281, 13824.86175138276, 14935.775963360775, 14964.700705985602, 15016.924915375354, 15026.398944042116, 31386.843065784524, 32586.837065814518, 35206.295874081865, 35865.0, 36175.0, 46134.0, 46720.06559868852, 46995.06009879715, 47025.0, 47931.76034119807, 7796.415268854972, 7889.921100789148, 8020.438569300326, 8031.397645176752, 8257.339412847077, 8345.582720864053, 8365.24712775853, 8789.648414063622, 11065.170112241452, 11906.583269585522, 7271.127464704269, 7610.200928902385, 7625.6949722010495, 7675.61621918913, 7995.680172793023, 4074.714769966074, 6405.263394709668, 7883.763487095396, 8039.271556615356, 8052.248018796525, 7269.45479089081, 7738.922610774045, 7913.485623434458, 7927.12801591836, 7962.761117166494, 10703.250772445854, 10994.560217591206, 11186.272892261977, 11346.602868899548, 11716.121290903387, 10657.40773028173, 10850.131989440668, 10852.659249357874, 11084.889151108708, 11255.831162532404], "value": 8090.021857348096, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.7955796409522, 1443.6390902274431, 1575.4800915697822, 1714.0572685023235, 1722.3455087066914, 6789.083473731045, 7525.2850979156965, 7660.693572257117, 7817.3355264802485, 7827.960860195698, 7705.306522412981, 7719.575423351714, 7765.8835117473145, 7774.572398518079, 7786.1435242123325, 2191.4411824984645, 2208.4147700859285, 2222.69993550871, 2225.3880182949656, 2225.6772767948637, 2212.037763572843, 2217.4234698978303, 2281.954360912781, 2291.9770802292014, 2293.0598454633605, 2211.845170838042, 2237.9328620141423, 2238.5187184755273, 2267.682524446579, 2295.8622482651012, 2211.800937915595, 2220.922267720622, 2225.18780645065, 2229.141780414544, 2234.3297010896667, 2241.6525438556887, 2244.9102035918545, 2255.1768604459417, 2255.548890221946, 2265.3317271404976, 7858.332041776456, 7870.449068565203, 7952.8409431811615, 7974.3221826144845, 7987.0, 4386.210482113218, 4481.484629267643, 4508.571685689854, 4540.318952157169, 4541.613962813165, 2728.358835673615, 2738.87675054621, 2743.533599288126, 2754.2425832895915, 2786.3312804926873, 927.5594092805931, 930.646354385336, 938.4134915677702, 944.4852555357347, 956.4452617481844, 10502.579896804042, 10514.684559463152, 10547.0, 10552.314099583502, 10564.471776411148, 4182.2681030819485, 4225.154969006211, 4359.2807186813825, 4374.059577190919, 4473.105378924228, 8974.0, 9058.139476749699, 9061.728148155566, 9065.501397423073, 9110.134537218953, 4687.554682305175, 4689.226277664216, 4703.670743048022, 4713.363695901078, 4720.740359280204, 3646.9817650912105, 4113.239050775616, 4223.472065991751, 4267.103908179255, 4296.2696341621995, 3671.632836716307, 3744.0826997385816, 3781.7352785305316, 3822.598627144165, 3824.4454554089502, 1208.7461633057158, 1209.8608660004213, 1213.7147770273978, 1237.0289322881495, 1240.9379531023412, 800.8438354520813, 873.8470767615642, 890.950997695133, 894.9686760963335, 900.2527901841456, 5444.945550544523, 5476.863078422992, 5489.972550137224, 5563.720344320829, 5577.888442231133, 389.9863504777319, 408.985685501012, 411.783813497916, 417.2864401872771, 427.37816477025854, 3819.3316169670197, 3834.6932245420858, 3919.235749028912, 3920.627540383659, 3959.703022273341, 9194.494302813277, 9489.525523723787, 9512.191463725523, 9601.37591056579, 9603.087706667855, 9018.368714190075, 9328.766780830398, 9480.288978326653, 9497.287703422133, 9505.809883802285, 7090.220075791659, 7186.892196617055, 7220.3140701633265, 7260.891086633705, 7262.564246145248, 5277.762500687555, 5482.205080263419, 5482.753276102665, 5567.081431563746, 5700.942990570041, 8394.496330220207, 8707.695230666895, 8778.956105219433, 8902.0, 8979.820403592023, 8405.243528082501, 8542.44474109181, 8672.219500245008, 8725.956370218108, 8737.781555461164, 6140.600860944024, 6546.443552298108, 6625.801225963229, 6689.632070236184, 6949.409300209539, 7430.44271679637, 7459.813504662427, 7542.622868856425, 7565.659545320584, 7570.470067095251, 6686.465082793462, 6783.89824152648, 6790.7623233186605, 6880.346367095118, 7017.789466316019, 6616.470682345304, 6666.233383160805, 6776.288489708707, 6833.794986150423, 6879.759208427681, 6236.75052997875, 6446.967765161145, 6465.870682586228, 6474.417302442803, 6477.805665830033, 4752.928706069342, 4869.123557759495, 4877.244027175793, 4909.140900342354, 4949.282354058713, 4639.280911458729, 4701.20079586478, 4708.0, 4716.64625153108, 4758.286257061469], "value": 4105.370730980814, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.6780541404455, 295.0572919522128, 299.3952216522626, 300.6872852233677, 312.1509494175842, 5233.456130441519, 5291.814786482474, 5301.761420736067, 5312.6281160318795, 5335.399380185948, 5202.219667049944, 5211.739413029352, 5231.424543300234, 5241.816536421226, 5250.474952504747, 3840.6927445804267, 3973.940390894139, 4110.897227569305, 4118.455579157816, 4122.381642753596, 4099.405586190001, 4106.466159399274, 4107.54816970133, 4122.804386727846, 4128.69034822388, 4099.959000410003, 4106.835726570934, 4109.198706252282, 4112.917741645166, 4117.855875044374, 4020.3165461871554, 4037.515498140242, 4111.48606424197, 4122.752634841904, 4129.029678025661, 3591.7844929304324, 3593.9038593229056, 3597.748157628967, 3622.5290712207507, 3643.4899114124046, 5004.499550045003, 5015.088231179686, 5017.498250174954, 5046.7224302663335, 5051.191809310492, 4585.403897493338, 4697.037107392976, 4701.647376446746, 4728.952710472886, 4735.289706544046, 5434.994526012701, 5519.116941289374, 5527.419620939824, 5527.778888844441, 5577.330720313588, 3938.6652134568594, 3941.2117576484816, 3941.6452519273116, 3951.1505026419172, 3972.1857019310974, 5613.747381367848, 5817.912731309034, 5818.6217895836635, 5826.242588463472, 5834.358220595731, 4044.939325910114, 4064.06526498901, 4077.857274995361, 4078.7552746835286, 4087.305158123126, 4118.52636946755, 4121.258173528734, 4128.720096769951, 4129.194807012604, 4152.276805125899, 4660.997885454576, 4694.577488026094, 4699.083678682692, 4703.918098837286, 4707.340972263886, 5265.842024739264, 5548.778048878, 5617.32592088952, 5632.662040277596, 5656.264685590847, 1409.9647508812361, 1419.6734751007325, 1422.4950142699192, 1422.8363738170035, 1433.981872870253, 923.0815338737999, 952.6237136331249, 955.8757361542955, 959.3668179001965, 969.1374676537887, 4733.053389322149, 4746.644001699887, 4755.262934245197, 4762.976185119052, 4787.186178349689, 5639.125935480007, 5642.463965923231, 5661.66030038199, 5677.063284558084, 5694.316681998187, 4623.976880115645, 4720.834770783074, 4739.620830333565, 4743.28850672395, 4750.572448479654, 2958.704129587024, 3004.3626223708134, 3006.8947586834356, 3012.3523442459978, 3020.2298413904314, 5282.815101471507, 5300.70846103468, 5301.019311427398, 5306.575473962073, 5337.62636615441, 5697.259356283656, 5697.971510142505, 5765.769369225184, 5776.566757493205, 5805.245318108703, 5277.63056586043, 5299.4700529946695, 5324.121519949243, 5340.439253878442, 5352.063388906926, 5454.91817622728, 5624.775008999594, 5634.802781902614, 5638.887222255614, 5641.1794102948525, 5512.5314348280845, 5513.0, 5528.170774383874, 5564.137558678412, 5588.050031494575, 5300.3904550975585, 5307.283516725192, 5315.495027972336, 5331.120365139864, 5334.573234141182, 3726.385146450805, 3968.3055465294037, 4018.8794336169963, 4022.6379625833815, 4035.616616421435, 5703.230063941315, 5713.371529131875, 5733.713314334183, 5762.711864406847, 5786.623869448473, 5497.835064948058, 5537.28015358017, 5551.361593416808, 5566.860828479158, 5569.860753481195, 5355.848492574115, 5496.148097044965, 5502.625412796756, 5534.723263836711, 5537.446255374431, 5238.580913526833, 5420.349558053059, 5445.128779395278, 5447.836564903059, 5454.618176727591, 5446.291982042309, 5582.609217354746, 5634.408387119457, 5645.633033852787, 5684.545236381162, 5471.890562188813, 5472.5621950243085, 5496.175573663822, 5501.119820828648, 5539.169124631338], "value": 4146.468116706704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.0900375489334, 682.539285981962, 704.7779949315968, 707.511816846376, 759.4987308376473, 11400.372979486136, 11709.297442153476, 11736.53053877845, 11736.882631173687, 11767.293962362264, 12047.518099276018, 12056.517739290417, 12091.334976576285, 12095.879041209586, 12155.878441215586, 623.3050149083762, 776.5263189454429, 776.6116941529235, 790.4861839804145, 801.8757092650649, 789.2462698123278, 791.3827214772487, 795.4471642208667, 795.5107608820563, 797.9361651067929, 835.6532039203723, 836.7949852286198, 837.1544739812803, 837.417994493827, 839.8824164616958, 832.0722394530115, 833.6123702478316, 833.7707130539089, 834.5368320582074, 835.1022650650544, 612.8284080457479, 613.7054213977316, 613.8158552434252, 614.2352770800337, 614.6127939398195, 12463.501459941592, 12515.249085054926, 12518.06114541413, 12526.561570345086, 12556.0, 13023.544175953795, 13033.087683862133, 13068.150570212905, 13093.214407135602, 13407.597772066756, 10040.548175332127, 10108.696739097839, 10144.340617859816, 10188.949055254676, 10341.793164136676, 3233.96766032339, 3257.625373082102, 3271.7219036381935, 3310.337932413527, 3316.0714999800093, 43780.0, 44246.55753442489, 46357.76821115873, 46374.53625463736, 46567.767161163974, 10345.586176552853, 10394.948025259977, 10474.528646210938, 10481.475926203659, 10553.102986246102, 18050.819491804912, 18132.274709011755, 18136.455906322568, 18156.63686726258, 18163.09184540794, 6538.476921846241, 6603.504737144734, 6795.082663840319, 6995.615241161785, 7171.426285897116, 3777.9433308500393, 3884.864029758945, 3901.0, 3904.04350934023, 3918.6865050796437, 2856.557233628791, 2999.865006074732, 3122.281875168724, 3138.5135304027913, 3142.4657808172665, 551.3411473289381, 552.6435449135286, 554.4732504121101, 565.6634302589953, 569.0979797021685, 488.05408274104263, 586.2993722501569, 587.6151121015741, 607.7386723708847, 652.2499126005132, 7709.2290770922455, 7923.405744569181, 8127.674893004332, 8153.8776918346275, 8417.705380311781, 504.60388594952786, 518.5177784660302, 632.3960617610171, 633.996830015847, 654.6170490263249, 3585.31878943, 3818.9236215276096, 3850.210706805098, 3856.4986551748652, 4007.8998025049023, 49542.50457495451, 51478.22782658263, 51559.48440515622, 53296.0, 54004.0, 44730.32904506435, 44872.3269150963, 45559.0, 45783.313250301275, 46308.7684561575, 41086.38370424446, 41431.58568414338, 41748.95627609274, 41957.370639439825, 42827.571724282985, 7291.161516425679, 7350.705971761284, 7425.8143546411775, 7464.853148799945, 7508.887366689395, 25087.623685645096, 25124.24627261185, 25999.220023399328, 26736.598951016138, 28267.575986360633, 34615.13462163466, 34650.30699386049, 34973.125671857386, 35627.10932226715, 35990.82004590065, 10430.061294483532, 10461.9476902615, 10499.47502624881, 10632.468376580986, 10656.62701805433, 11824.645260642195, 12134.939325303318, 12154.817677735018, 12311.322877241837, 12730.490780369051, 9399.154076133182, 11327.093832493216, 11498.48256828428, 11606.651800446, 11692.532298707956, 11397.658070257905, 11467.598634047768, 11615.941920290345, 11617.244879082833, 12189.51241950312, 11101.777964440827, 11124.332540047622, 11269.098472122374, 11293.096552275963, 11458.541658333907, 9241.806652464387, 9317.813643727222, 9318.394304370195, 9677.9032209677, 9785.461799601091, 9904.356216845881, 10174.643887463903, 10233.641822536474, 10269.53787079598, 10320.793584128425], "value": 5938.074371765252, "unit": "score"}], "name": "dromaeo_css", "value": 6274.066133326056, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 113.0, 115.0, 113.0, 127.0, 113.0, 114.0, 115.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 133.0, 167.0, 187.0, 135.0, 159.0, 161.0, 134.0, 196.0, 135.0], "value": 157.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 170.0, 162.0, 163.0, 163.0, 162.0, 166.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 79.0, 154.0, 80.0, 75.0, 73.0, 74.0, 161.0, 81.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 158.0, 94.0, 96.0, 95.0, 142.0, 95.0, 94.0, 138.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 65.0, 67.0, 65.0, 66.0, 79.0, 64.0, 74.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 72.0, 65.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 81.0, 82.0, 90.0, 89.0, 82.0, 80.0, 84.0, 79.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 150.0, 135.0, 146.0, 134.0, 134.0, 143.0, 135.0, 179.0, 137.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 189.0, 182.0, 182.0, 188.0, 176.0, 183.0, 177.0, 179.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 73.0, 75.0, 77.0, 76.0, 72.0, 76.0, 73.0, 73.0], "value": 74.5, "unit": "score"}], "name": "kraken", "value": 1617.6000000000001, "alertThreshold": 2.0}]} 07:45:56 INFO - Return code: 0 07:45:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:45:56 ERROR - # TBPL SUCCESS # 07:45:56 INFO - Running post-action listener: _resource_record_post_action 07:45:56 INFO - Running post-run listener: _resource_record_post_run 07:45:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 344064; Write bytes: 525082624; Read time: 156; Write time: 434196 07:45:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241504256; Read time: 0; Write time: 262764 07:45:57 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 344064; Write bytes: 283578368; Read time: 156; Write time: 171432 07:45:57 INFO - Running post-run listener: _upload_blobber_files 07:45:57 INFO - Blob upload gear active. 07:45:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:45:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:45:57 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:45:57 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:45:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:58 INFO - (blobuploader) - INFO - Done attempting. 07:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:59 INFO - (blobuploader) - INFO - Done attempting. 07:45:59 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:59 INFO - Return code: 0 07:45:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3a98e3d1a3fa5e5c58210619bf5b97024a5847677a284ab9f612f235520e4d0549df7a4b0b4ece79bdb4f26de832e1d1b5b49d4005323d824158fc8dbfb6911", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1d526ed13537d3d32ec25145d2bb2d5c694706aa31c95be50808b6d0cc45e0e3d49d77072075f78261f68ea8418276daa706413005f6e8f81bb02c21ab218a4"} 07:45:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:59 INFO - Contents: 07:45:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3a98e3d1a3fa5e5c58210619bf5b97024a5847677a284ab9f612f235520e4d0549df7a4b0b4ece79bdb4f26de832e1d1b5b49d4005323d824158fc8dbfb6911", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1d526ed13537d3d32ec25145d2bb2d5c694706aa31c95be50808b6d0cc45e0e3d49d77072075f78261f68ea8418276daa706413005f6e8f81bb02c21ab218a4"} 07:45:59 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:59 INFO - Copying logs to upload dir... 07:45:59 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.899257 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-21 07:45:59.125274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 07:45:59.128417) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3a98e3d1a3fa5e5c58210619bf5b97024a5847677a284ab9f612f235520e4d0549df7a4b0b4ece79bdb4f26de832e1d1b5b49d4005323d824158fc8dbfb6911", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1d526ed13537d3d32ec25145d2bb2d5c694706aa31c95be50808b6d0cc45e0e3d49d77072075f78261f68ea8418276daa706413005f6e8f81bb02c21ab218a4"} build_url:https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3a98e3d1a3fa5e5c58210619bf5b97024a5847677a284ab9f612f235520e4d0549df7a4b0b4ece79bdb4f26de832e1d1b5b49d4005323d824158fc8dbfb6911", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1d526ed13537d3d32ec25145d2bb2d5c694706aa31c95be50808b6d0cc45e0e3d49d77072075f78261f68ea8418276daa706413005f6e8f81bb02c21ab218a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 07:45:59.153177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:45:59.153502) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461248698.720949-586920978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:45:59.235886) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 07:45:59.236206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 07:45:59.236494) ========= ========= Total master_lag: 0.18 =========