builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1461710501.25 results: success (0) buildid: 20160426141800 builduid: 590d7c51f5c246609990c3f5874b3abc revision: 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.250204) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.250621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.250910) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.277967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.278266) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 15:41:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2016-04-26 15:41:41 (18.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087300 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.380985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.381274) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021047 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.432175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.432504) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 --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 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 --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=5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 15:41:41,920 truncating revision to first 12 chars 2016-04-26 15:41:41,920 Setting DEBUG logging. 2016-04-26 15:41:41,920 attempt 1/10 2016-04-26 15:41:41,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6a441b2b2997?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 15:41:42,183 unpacking tar archive at: mozilla-central-6a441b2b2997/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541675 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.990706) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.991001) ========= script_repo_revision: 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.991370) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:41.991642) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:41:42.008018) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-26 15:41:42.008268) ========= /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=5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:41:42 INFO - MultiFileLogger online at 20160426 15:41:42 in /builds/slave/test 15:41:42 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 15:41:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:41:42 INFO - {'append_to_log': False, 15:41:42 INFO - 'base_work_dir': '/builds/slave/test', 15:41:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:41:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:41:42 INFO - 'branch': 'Firefox-Non-PGO', 15:41:42 INFO - 'buildbot_json_path': 'buildprops.json', 15:41:42 INFO - 'config_files': ('talos/linux_config.py',), 15:41:42 INFO - 'default_actions': ('clobber', 15:41:42 INFO - 'read-buildbot-config', 15:41:42 INFO - 'download-and-extract', 15:41:42 INFO - 'populate-webroot', 15:41:42 INFO - 'create-virtualenv', 15:41:42 INFO - 'install', 15:41:42 INFO - 'run-tests'), 15:41:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:41:42 INFO - 'download_minidump_stackwalk': True, 15:41:42 INFO - 'download_symbols': 'ondemand', 15:41:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:41:42 INFO - 'tooltool.py': '/tools/tooltool.py', 15:41:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:41:42 INFO - '/tools/misc-python/virtualenv.py')}, 15:41:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:41:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:41:42 INFO - 'installer_path': 'installer.exe', 15:41:42 INFO - 'log_level': 'info', 15:41:42 INFO - 'log_name': 'talos', 15:41:42 INFO - 'log_to_console': True, 15:41:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:41:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:41:42 INFO - 'opt_config_files': (), 15:41:42 INFO - 'pip_index': False, 15:41:42 INFO - 'sps_profile': False, 15:41:42 INFO - 'sps_profile_interval': 0, 15:41:42 INFO - 'suite': 'dromaeojs-e10s', 15:41:42 INFO - 'system_bits': '32', 15:41:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:41:42 INFO - 'title': 'talos-linux64-ix-011', 15:41:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:41:42 INFO - 'use_talos_json': True, 15:41:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:41:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:41:42 INFO - 'work_dir': 'build'} 15:41:42 INFO - ##### 15:41:42 INFO - ##### Running clobber step. 15:41:42 INFO - ##### 15:41:42 INFO - Running pre-action listener: _resource_record_pre_action 15:41:42 INFO - Running main action method: clobber 15:41:42 INFO - rmtree: /builds/slave/test/build 15:41:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:41:43 INFO - Running post-action listener: _resource_record_post_action 15:41:43 INFO - ##### 15:41:43 INFO - ##### Running read-buildbot-config step. 15:41:43 INFO - ##### 15:41:43 INFO - Running pre-action listener: _resource_record_pre_action 15:41:43 INFO - Running main action method: read_buildbot_config 15:41:43 INFO - Using buildbot properties: 15:41:43 INFO - { 15:41:43 INFO - "project": "", 15:41:43 INFO - "product": "firefox", 15:41:43 INFO - "script_repo_revision": "production", 15:41:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:41:43 INFO - "repository": "", 15:41:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:41:43 INFO - "buildid": "20160426141800", 15:41:43 INFO - "pgo_build": "False", 15:41:43 INFO - "basedir": "/builds/slave/test", 15:41:43 INFO - "buildnumber": 337, 15:41:43 INFO - "slavename": "talos-linux64-ix-011", 15:41:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:41:43 INFO - "platform": "ubuntu64_hw", 15:41:43 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:41:43 INFO - "branch": "mozilla-central", 15:41:43 INFO - "repo_path": "mozilla-central", 15:41:43 INFO - "revision": "6a441b2b2997cdbd47b5d80283f6f60d5a9e7489", 15:41:43 INFO - "stage_platform": "linux64", 15:41:43 INFO - "builduid": "590d7c51f5c246609990c3f5874b3abc", 15:41:43 INFO - "slavebuilddir": "test" 15:41:43 INFO - } 15:41:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:41:43 INFO - Running post-action listener: _resource_record_post_action 15:41:43 INFO - ##### 15:41:43 INFO - ##### Running download-and-extract step. 15:41:43 INFO - ##### 15:41:43 INFO - Running pre-action listener: _resource_record_pre_action 15:41:43 INFO - Running main action method: download_and_extract 15:41:43 INFO - mkdir: /builds/slave/test/build/tests 15:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:43 INFO - https://queue.taskcluster.net/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:41:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:41:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:41:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:41:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:41:52 INFO - Downloaded 1361 bytes. 15:41:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:41:52 INFO - Using the following test package requirements: 15:41:52 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:41:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:41:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:41:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:52 INFO - u'jsshell-linux-x86_64.zip'], 15:41:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:41:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:41:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:41:52 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:41:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:41:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:41:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:52 INFO - https://queue.taskcluster.net/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:41:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:41:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:41:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:41:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:41:58 INFO - Downloaded 22290767 bytes. 15:41:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:41:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:41:59 INFO - Return code: 0 15:41:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:41:59 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')]} 15:41:59 INFO - https://queue.taskcluster.net/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:42:01 INFO - Downloaded 22290767 bytes. 15:42:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:42:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:42:02 INFO - Return code: 0 15:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:02 INFO - https://queue.taskcluster.net/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:42:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:42:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:42:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:42:03 INFO - Downloaded 10840145 bytes. 15:42:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:42:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:42:04 INFO - Return code: 0 15:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:04 INFO - https://queue.taskcluster.net/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:42:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:42:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:42:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:42:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:42:06 INFO - Downloaded 54814192 bytes. 15:42:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:42:06 INFO - mkdir: /builds/slave/test/properties 15:42:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:42:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:42:06 INFO - Contents: 15:42:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:42:07 INFO - Running post-action listener: _resource_record_post_action 15:42:07 INFO - Running post-action listener: set_extra_try_arguments 15:42:07 INFO - ##### 15:42:07 INFO - ##### Running populate-webroot step. 15:42:07 INFO - ##### 15:42:07 INFO - Running pre-action listener: _resource_record_pre_action 15:42:07 INFO - Running main action method: populate_webroot 15:42:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:42:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:42:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:42:07 INFO - '--tppagecycles', 15:42:07 INFO - '7'], 15:42:07 INFO - 'tests': ['tsvgm']}}, 15:42:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:42:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:42:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:42:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:42:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:42:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:42:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'talos_options': ['--disable-e10s'], 15:42:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'talos_options': ['--disable-e10s'], 15:42:07 INFO - 'tests': ['damp', 'tps']}, 15:42:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'tests': ['damp', 'tps']}, 15:42:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:42:07 INFO - 'tests': ['dromaeo_dom']}, 15:42:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:42:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:42:07 INFO - 'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore', 15:42:07 INFO - 'tabpaint']}, 15:42:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore', 15:42:07 INFO - 'tabpaint']}, 15:42:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore', 15:42:07 INFO - 'tabpaint']}, 15:42:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore', 15:42:07 INFO - 'tabpaint']}, 15:42:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:42:07 INFO - 'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore', 15:42:07 INFO - 'tabpaint']}, 15:42:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:42:07 INFO - 'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore', 15:42:07 INFO - 'tabpaint']}, 15:42:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:42:07 INFO - 'tests': ['tsvgx', 15:42:07 INFO - 'tsvgr_opacity', 15:42:07 INFO - 'tart', 15:42:07 INFO - 'tscrollx', 15:42:07 INFO - 'cart']}, 15:42:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:42:07 INFO - 'tsvgr_opacity', 15:42:07 INFO - 'tart', 15:42:07 INFO - 'tscrollx', 15:42:07 INFO - 'cart']}, 15:42:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'talos_options': ['--disable-e10s'], 15:42:07 INFO - 'tests': ['tp5o']}, 15:42:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'tests': ['tp5o']}, 15:42:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'talos_options': ['--disable-e10s', 15:42:07 INFO - '--xperf_path', 15:42:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:07 INFO - 'tests': ['tp5n']}, 15:42:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'talos_options': ['--xperf_path', 15:42:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:07 INFO - 'tests': ['tp5n']}}, 15:42:07 INFO - 'talos.zip': {'path': '', 15:42:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:42:07 INFO - Running post-action listener: _resource_record_post_action 15:42:07 INFO - ##### 15:42:07 INFO - ##### Running create-virtualenv step. 15:42:07 INFO - ##### 15:42:07 INFO - Running pre-action listener: _resource_record_pre_action 15:42:07 INFO - Running main action method: create_virtualenv 15:42:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:42:07 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 15:42:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:42:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:42:07 INFO - Using real prefix '/usr' 15:42:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:42:07 INFO - Installing distribute.............................................................................................................................................................................................done. 15:42:09 INFO - Installing pip.................done. 15:42:09 INFO - Return code: 0 15:42:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9765eaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', '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 15:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:42:09 INFO - Using env: {'DISPLAY': ':0', 15:42:09 INFO - 'HOME': '/home/cltbld', 15:42:09 INFO - 'LANG': 'en_US.UTF-8', 15:42:09 INFO - 'LANGUAGE': 'en_US:en', 15:42:09 INFO - 'LOGNAME': 'cltbld', 15:42:09 INFO - 'MAIL': '/var/mail/cltbld', 15:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:09 INFO - 'MOZ_NO_REMOTE': '1', 15:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:09 INFO - 'NO_EM_RESTART': '1', 15:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:09 INFO - 'PWD': '/builds/slave/test', 15:42:09 INFO - 'SHELL': '/bin/bash', 15:42:09 INFO - 'SHLVL': '1', 15:42:09 INFO - 'TERM': 'linux', 15:42:09 INFO - 'TMOUT': '86400', 15:42:09 INFO - 'USER': 'cltbld', 15:42:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', 15:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:09 INFO - '_': '/tools/buildbot/bin/python'} 15:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:10 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 15:42:10 INFO - Cleaning up... 15:42:10 INFO - Return code: 0 15:42:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:10 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 0x7f9765eaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', '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 15:42:10 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 15:42:10 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 15:42:10 INFO - Using env: {'DISPLAY': ':0', 15:42:10 INFO - 'HOME': '/home/cltbld', 15:42:10 INFO - 'LANG': 'en_US.UTF-8', 15:42:10 INFO - 'LANGUAGE': 'en_US:en', 15:42:10 INFO - 'LOGNAME': 'cltbld', 15:42:10 INFO - 'MAIL': '/var/mail/cltbld', 15:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:10 INFO - 'MOZ_NO_REMOTE': '1', 15:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:10 INFO - 'NO_EM_RESTART': '1', 15:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:10 INFO - 'PWD': '/builds/slave/test', 15:42:10 INFO - 'SHELL': '/bin/bash', 15:42:10 INFO - 'SHLVL': '1', 15:42:10 INFO - 'TERM': 'linux', 15:42:10 INFO - 'TMOUT': '86400', 15:42:10 INFO - 'USER': 'cltbld', 15:42:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', 15:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:10 INFO - '_': '/tools/buildbot/bin/python'} 15:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:10 INFO - Downloading/unpacking psutil>=0.7.1 15:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:42:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:13 INFO - Installing collected packages: psutil 15:42:13 INFO - Running setup.py install for psutil 15:42:13 INFO - building 'psutil._psutil_linux' extension 15:42:13 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 15:42:13 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 15:42:13 INFO - building 'psutil._psutil_posix' extension 15:42:13 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 15:42:13 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 15:42:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:13 INFO - Successfully installed psutil 15:42:13 INFO - Cleaning up... 15:42:13 INFO - Return code: 0 15:42:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9765eaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', '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 15:42:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:42:13 INFO - Using env: {'DISPLAY': ':0', 15:42:13 INFO - 'HOME': '/home/cltbld', 15:42:13 INFO - 'LANG': 'en_US.UTF-8', 15:42:13 INFO - 'LANGUAGE': 'en_US:en', 15:42:13 INFO - 'LOGNAME': 'cltbld', 15:42:13 INFO - 'MAIL': '/var/mail/cltbld', 15:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:13 INFO - 'MOZ_NO_REMOTE': '1', 15:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:13 INFO - 'NO_EM_RESTART': '1', 15:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:13 INFO - 'PWD': '/builds/slave/test', 15:42:13 INFO - 'SHELL': '/bin/bash', 15:42:13 INFO - 'SHLVL': '1', 15:42:13 INFO - 'TERM': 'linux', 15:42:13 INFO - 'TMOUT': '86400', 15:42:13 INFO - 'USER': 'cltbld', 15:42:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', 15:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:13 INFO - '_': '/tools/buildbot/bin/python'} 15:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:42:16 INFO - Installing collected packages: mozsystemmonitor 15:42:16 INFO - Running setup.py install for mozsystemmonitor 15:42:16 INFO - Successfully installed mozsystemmonitor 15:42:16 INFO - Cleaning up... 15:42:16 INFO - Return code: 0 15:42:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:42:16 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')]} 15:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:16 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')]} 15:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:16 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 0x7f9765eaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', '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 15:42:16 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 15:42:16 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 15:42:16 INFO - Using env: {'DISPLAY': ':0', 15:42:16 INFO - 'HOME': '/home/cltbld', 15:42:16 INFO - 'LANG': 'en_US.UTF-8', 15:42:16 INFO - 'LANGUAGE': 'en_US:en', 15:42:16 INFO - 'LOGNAME': 'cltbld', 15:42:16 INFO - 'MAIL': '/var/mail/cltbld', 15:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:16 INFO - 'MOZ_NO_REMOTE': '1', 15:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:16 INFO - 'NO_EM_RESTART': '1', 15:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:16 INFO - 'PWD': '/builds/slave/test', 15:42:16 INFO - 'SHELL': '/bin/bash', 15:42:16 INFO - 'SHLVL': '1', 15:42:16 INFO - 'TERM': 'linux', 15:42:16 INFO - 'TMOUT': '86400', 15:42:16 INFO - 'USER': 'cltbld', 15:42:16 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', 15:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:16 INFO - '_': '/tools/buildbot/bin/python'} 15:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:16 INFO - Downloading/unpacking blobuploader==1.2.4 15:42:16 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 15:42:16 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 15:42:16 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 15:42:16 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 15:42:16 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 15:42:16 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 15:42:18 INFO - Downloading blobuploader-1.2.4.tar.gz 15:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:42:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:42:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:18 INFO - Downloading docopt-0.6.1.tar.gz 15:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:42:19 INFO - Installing collected packages: blobuploader, requests, docopt 15:42:19 INFO - Running setup.py install for blobuploader 15:42:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:42:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:42:19 INFO - Running setup.py install for requests 15:42:19 INFO - Running setup.py install for docopt 15:42:19 INFO - Successfully installed blobuploader requests docopt 15:42:19 INFO - Cleaning up... 15:42:19 INFO - Return code: 0 15:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:19 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 0x7f9765eaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', '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 15:42:19 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 15:42:19 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 15:42:19 INFO - Using env: {'DISPLAY': ':0', 15:42:19 INFO - 'HOME': '/home/cltbld', 15:42:19 INFO - 'LANG': 'en_US.UTF-8', 15:42:19 INFO - 'LANGUAGE': 'en_US:en', 15:42:19 INFO - 'LOGNAME': 'cltbld', 15:42:19 INFO - 'MAIL': '/var/mail/cltbld', 15:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:19 INFO - 'MOZ_NO_REMOTE': '1', 15:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:19 INFO - 'NO_EM_RESTART': '1', 15:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:19 INFO - 'PWD': '/builds/slave/test', 15:42:19 INFO - 'SHELL': '/bin/bash', 15:42:19 INFO - 'SHLVL': '1', 15:42:19 INFO - 'TERM': 'linux', 15:42:19 INFO - 'TMOUT': '86400', 15:42:19 INFO - 'USER': 'cltbld', 15:42:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', 15:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:19 INFO - '_': '/tools/buildbot/bin/python'} 15:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:19 INFO - Running setup.py (path:/tmp/pip-Z1V59k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:19 INFO - Running setup.py (path:/tmp/pip-pJK3VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:20 INFO - Running setup.py (path:/tmp/pip-AlEclI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:20 INFO - Running setup.py (path:/tmp/pip-Qo88wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:20 INFO - Running setup.py (path:/tmp/pip-Q4noXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:20 INFO - Running setup.py (path:/tmp/pip-z28KPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:20 INFO - Running setup.py (path:/tmp/pip-jFuJ6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:20 INFO - Running setup.py (path:/tmp/pip-CJbdJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:20 INFO - Running setup.py (path:/tmp/pip-V8vh5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:20 INFO - Running setup.py (path:/tmp/pip-rT_bje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:20 INFO - Running setup.py (path:/tmp/pip-qWQMve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:20 INFO - Running setup.py (path:/tmp/pip-ezoIer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:20 INFO - Running setup.py (path:/tmp/pip-mzkjKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:20 INFO - Running setup.py (path:/tmp/pip-tDKwTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:20 INFO - Running setup.py (path:/tmp/pip-2N7kC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:20 INFO - Running setup.py (path:/tmp/pip-9A5i55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:21 INFO - Running setup.py (path:/tmp/pip-EooL9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:42:21 INFO - Running setup.py install for manifestparser 15:42:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for mozcrash 15:42:21 INFO - Running setup.py install for mozdebug 15:42:21 INFO - Running setup.py install for mozdevice 15:42:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for mozfile 15:42:21 INFO - Running setup.py install for mozhttpd 15:42:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for mozinfo 15:42:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for mozInstall 15:42:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for mozleak 15:42:22 INFO - Running setup.py install for mozlog 15:42:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Running setup.py install for moznetwork 15:42:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Running setup.py install for mozprocess 15:42:22 INFO - Running setup.py install for mozprofile 15:42:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Running setup.py install for mozrunner 15:42:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Running setup.py install for mozscreenshot 15:42:22 INFO - Running setup.py install for moztest 15:42:22 INFO - Running setup.py install for mozversion 15:42:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:42:22 INFO - Cleaning up... 15:42:22 INFO - Return code: 0 15:42:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:22 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 0x7f9765eaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', '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 15:42:22 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 15:42:22 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 15:42:22 INFO - Using env: {'DISPLAY': ':0', 15:42:22 INFO - 'HOME': '/home/cltbld', 15:42:22 INFO - 'LANG': 'en_US.UTF-8', 15:42:22 INFO - 'LANGUAGE': 'en_US:en', 15:42:22 INFO - 'LOGNAME': 'cltbld', 15:42:22 INFO - 'MAIL': '/var/mail/cltbld', 15:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:22 INFO - 'MOZ_NO_REMOTE': '1', 15:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:22 INFO - 'NO_EM_RESTART': '1', 15:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:22 INFO - 'PWD': '/builds/slave/test', 15:42:22 INFO - 'SHELL': '/bin/bash', 15:42:22 INFO - 'SHLVL': '1', 15:42:22 INFO - 'TERM': 'linux', 15:42:22 INFO - 'TMOUT': '86400', 15:42:22 INFO - 'USER': 'cltbld', 15:42:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', 15:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:22 INFO - '_': '/tools/buildbot/bin/python'} 15:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:23 INFO - Running setup.py (path:/tmp/pip-QO9Ezi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:23 INFO - Running setup.py (path:/tmp/pip-X4Z61Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:23 INFO - Running setup.py (path:/tmp/pip-l629eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:23 INFO - Running setup.py (path:/tmp/pip-d3YW15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:23 INFO - Running setup.py (path:/tmp/pip-hAfme_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:23 INFO - Running setup.py (path:/tmp/pip-K5yAyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:23 INFO - Running setup.py (path:/tmp/pip-C_vXL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:23 INFO - Running setup.py (path:/tmp/pip-JPvuRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:23 INFO - Running setup.py (path:/tmp/pip-USYRpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:23 INFO - Running setup.py (path:/tmp/pip-QPJMmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:23 INFO - Running setup.py (path:/tmp/pip-4fNAbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:23 INFO - Running setup.py (path:/tmp/pip-4303Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:23 INFO - Running setup.py (path:/tmp/pip-emvh5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:24 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)) 15:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:24 INFO - Running setup.py (path:/tmp/pip-aFEUeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:24 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)) 15:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:24 INFO - Running setup.py (path:/tmp/pip-5yzcBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:24 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)) 15:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:24 INFO - Running setup.py (path:/tmp/pip-oJaFnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:24 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)) 15:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:24 INFO - Running setup.py (path:/tmp/pip-8RVmVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:24 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)) 15:42:24 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)) 15:42:24 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)) 15:42:24 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)) 15:42:24 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)) 15:42:24 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)) 15:42:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:26 INFO - Downloading blessings-1.6.tar.gz 15:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:42:26 INFO - Installing collected packages: blessings 15:42:26 INFO - Running setup.py install for blessings 15:42:26 INFO - Successfully installed blessings 15:42:26 INFO - Cleaning up... 15:42:26 INFO - Return code: 0 15:42:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:42:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:42:26 INFO - Reading from file tmpfile_stdout 15:42:26 INFO - Current package versions: 15:42:26 INFO - argparse == 1.2.1 15:42:26 INFO - blessings == 1.6 15:42:26 INFO - blobuploader == 1.2.4 15:42:26 INFO - docopt == 0.6.1 15:42:26 INFO - manifestparser == 1.1 15:42:26 INFO - mozInstall == 1.12 15:42:26 INFO - mozcrash == 0.17 15:42:26 INFO - mozdebug == 0.1 15:42:26 INFO - mozdevice == 0.48 15:42:26 INFO - mozfile == 1.2 15:42:26 INFO - mozhttpd == 0.7 15:42:26 INFO - mozinfo == 0.9 15:42:26 INFO - mozleak == 0.1 15:42:26 INFO - mozlog == 3.1 15:42:26 INFO - moznetwork == 0.27 15:42:26 INFO - mozprocess == 0.22 15:42:26 INFO - mozprofile == 0.28 15:42:26 INFO - mozrunner == 6.11 15:42:26 INFO - mozscreenshot == 0.1 15:42:26 INFO - mozsystemmonitor == 0.0 15:42:26 INFO - moztest == 0.7 15:42:26 INFO - mozversion == 1.4 15:42:26 INFO - psutil == 3.1.1 15:42:26 INFO - requests == 1.2.3 15:42:26 INFO - wsgiref == 0.1.2 15:42:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:26 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')]} 15:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:26 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')]} 15:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:26 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 0x7f9765eaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', '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 15:42:26 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 15:42:26 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 15:42:26 INFO - Using env: {'DISPLAY': ':0', 15:42:26 INFO - 'HOME': '/home/cltbld', 15:42:26 INFO - 'LANG': 'en_US.UTF-8', 15:42:26 INFO - 'LANGUAGE': 'en_US:en', 15:42:26 INFO - 'LOGNAME': 'cltbld', 15:42:26 INFO - 'MAIL': '/var/mail/cltbld', 15:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:26 INFO - 'MOZ_NO_REMOTE': '1', 15:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:26 INFO - 'NO_EM_RESTART': '1', 15:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:26 INFO - 'PWD': '/builds/slave/test', 15:42:26 INFO - 'SHELL': '/bin/bash', 15:42:26 INFO - 'SHLVL': '1', 15:42:26 INFO - 'TERM': 'linux', 15:42:26 INFO - 'TMOUT': '86400', 15:42:26 INFO - 'USER': 'cltbld', 15:42:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', 15:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:26 INFO - '_': '/tools/buildbot/bin/python'} 15:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:26 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)) 15:42:26 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)) 15:42:26 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)) 15:42:26 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)) 15:42:26 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)) 15:42:26 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)) 15:42:26 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)) 15:42:26 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)) 15:42:26 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)) 15:42:26 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)) 15:42:26 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)) 15:42:26 INFO - Cleaning up... 15:42:26 INFO - Return code: 0 15:42:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:42:26 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')]} 15:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:26 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')]} 15:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:26 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 0x7f9765eaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', '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 15:42:26 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 15:42:26 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 15:42:26 INFO - Using env: {'DISPLAY': ':0', 15:42:26 INFO - 'HOME': '/home/cltbld', 15:42:26 INFO - 'LANG': 'en_US.UTF-8', 15:42:26 INFO - 'LANGUAGE': 'en_US:en', 15:42:26 INFO - 'LOGNAME': 'cltbld', 15:42:26 INFO - 'MAIL': '/var/mail/cltbld', 15:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:26 INFO - 'MOZ_NO_REMOTE': '1', 15:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:26 INFO - 'NO_EM_RESTART': '1', 15:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:26 INFO - 'PWD': '/builds/slave/test', 15:42:26 INFO - 'SHELL': '/bin/bash', 15:42:26 INFO - 'SHLVL': '1', 15:42:26 INFO - 'TERM': 'linux', 15:42:26 INFO - 'TMOUT': '86400', 15:42:26 INFO - 'USER': 'cltbld', 15:42:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', 15:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:26 INFO - '_': '/tools/buildbot/bin/python'} 15:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:27 INFO - Downloading/unpacking jsonschema 15:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:42:29 INFO - Downloading/unpacking functools32 (from jsonschema) 15:42:29 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 15:42:29 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 15:42:29 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 15:42:29 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 15:42:29 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 15:42:29 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 15:42:29 INFO - Downloading functools32-3.2.3-2.tar.gz 15:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:42:29 INFO - warning: no files found matching '*.txt' 15:42:29 INFO - no previously-included directories found matching 'build' 15:42:29 INFO - no previously-included directories found matching 'dist' 15:42:29 INFO - no previously-included directories found matching '.git*' 15:42:29 INFO - Installing collected packages: jsonschema, functools32 15:42:29 INFO - Running setup.py install for functools32 15:42:29 INFO - warning: no files found matching '*.txt' 15:42:29 INFO - no previously-included directories found matching 'build' 15:42:29 INFO - no previously-included directories found matching 'dist' 15:42:29 INFO - no previously-included directories found matching '.git*' 15:42:29 INFO - Successfully installed jsonschema functools32 15:42:29 INFO - Cleaning up... 15:42:29 INFO - Return code: 0 15:42:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:42:29 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')]} 15:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:29 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')]} 15:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:29 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 0x7f9765eaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', '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 15:42:29 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 15:42:29 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 15:42:29 INFO - Using env: {'DISPLAY': ':0', 15:42:29 INFO - 'HOME': '/home/cltbld', 15:42:29 INFO - 'LANG': 'en_US.UTF-8', 15:42:29 INFO - 'LANGUAGE': 'en_US:en', 15:42:29 INFO - 'LOGNAME': 'cltbld', 15:42:29 INFO - 'MAIL': '/var/mail/cltbld', 15:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:29 INFO - 'MOZ_NO_REMOTE': '1', 15:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:29 INFO - 'NO_EM_RESTART': '1', 15:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:29 INFO - 'PWD': '/builds/slave/test', 15:42:29 INFO - 'SHELL': '/bin/bash', 15:42:29 INFO - 'SHLVL': '1', 15:42:29 INFO - 'TERM': 'linux', 15:42:29 INFO - 'TMOUT': '86400', 15:42:29 INFO - 'USER': 'cltbld', 15:42:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', 15:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:29 INFO - '_': '/tools/buildbot/bin/python'} 15:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:29 INFO - Downloading/unpacking flake8 15:42:29 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 15:42:29 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 15:42:29 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 15:42:29 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 15:42:29 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 15:42:29 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 15:42:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:42:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:42:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:42:32 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 15:42:32 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 15:42:32 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 15:42:32 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 15:42:32 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 15:42:32 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 15:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:42:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:42:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:42:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:42:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:42:32 INFO - no previously-included directories found matching 'docs/_build' 15:42:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:42:32 INFO - Running setup.py install for pep8 15:42:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:42:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:42:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:42:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:42:32 INFO - no previously-included directories found matching 'docs/_build' 15:42:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:42:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:42:32 INFO - Cleaning up... 15:42:32 INFO - Return code: 0 15:42:32 INFO - Running post-action listener: _resource_record_post_action 15:42:32 INFO - Running post-action listener: _start_resource_monitoring 15:42:32 INFO - Starting resource monitoring. 15:42:32 INFO - ##### 15:42:32 INFO - ##### Running install step. 15:42:32 INFO - ##### 15:42:32 INFO - Running pre-action listener: _resource_record_pre_action 15:42:32 INFO - Running main action method: install 15:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:42:32 INFO - Reading from file tmpfile_stdout 15:42:32 INFO - Detecting whether we're running mozinstall >=1.0... 15:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:42:32 INFO - Reading from file tmpfile_stdout 15:42:32 INFO - Output received: 15:42:32 INFO - Usage: mozinstall [options] installer 15:42:32 INFO - Options: 15:42:32 INFO - -h, --help show this help message and exit 15:42:32 INFO - -d DEST, --destination=DEST 15:42:32 INFO - Directory to install application into. [default: 15:42:32 INFO - "/builds/slave/test"] 15:42:32 INFO - --app=APP Application being installed. [default: firefox] 15:42:32 INFO - mkdir: /builds/slave/test/build/application 15:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:42:48 INFO - Reading from file tmpfile_stdout 15:42:48 INFO - Output received: 15:42:48 INFO - /builds/slave/test/build/application/firefox/firefox 15:42:48 INFO - Running post-action listener: _resource_record_post_action 15:42:48 INFO - ##### 15:42:48 INFO - ##### Running run-tests step. 15:42:48 INFO - ##### 15:42:48 INFO - Running pre-action listener: _resource_record_pre_action 15:42:48 INFO - Running main action method: run_tests 15:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:42:48 INFO - Python 2.7.3 15:42:48 INFO - Return code: 0 15:42:48 INFO - grabbing minidump binary from tooltool 15:42: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')]} 15:42:48 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 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:42:48 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 15:42:48 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 15:42:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:42:48 INFO - Return code: 0 15:42:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:42:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:42:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:42:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:42:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:42:49 INFO - Return code: 0 15:42:49 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/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:42:49 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/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 15:42:49 INFO - Using env: {'DISPLAY': ':0', 15:42:49 INFO - 'HOME': '/home/cltbld', 15:42:49 INFO - 'LANG': 'en_US.UTF-8', 15:42:49 INFO - 'LANGUAGE': 'en_US:en', 15:42:49 INFO - 'LOGNAME': 'cltbld', 15:42:49 INFO - 'MAIL': '/var/mail/cltbld', 15:42:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:42:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:49 INFO - 'MOZ_NO_REMOTE': '1', 15:42:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:49 INFO - 'NO_EM_RESTART': '1', 15:42:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:49 INFO - 'PWD': '/builds/slave/test', 15:42:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:42:49 INFO - 'SHELL': '/bin/bash', 15:42:49 INFO - 'SHLVL': '1', 15:42:49 INFO - 'TERM': 'linux', 15:42:49 INFO - 'TMOUT': '86400', 15:42:49 INFO - 'USER': 'cltbld', 15:42:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993', 15:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:49 INFO - '_': '/tools/buildbot/bin/python'} 15:42:49 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/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:42:49 INFO - mozversion application_buildid: 20160426141800 15:42:49 INFO - mozversion application_changeset: 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 15:42:49 INFO - mozversion application_display_name: Nightly 15:42:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:42:49 INFO - mozversion application_name: Firefox 15:42:49 INFO - mozversion application_remotingname: firefox 15:42:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:42:49 INFO - mozversion application_vendor: Mozilla 15:42:49 INFO - mozversion application_version: 49.0a1 15:42:49 INFO - mozversion platform_buildid: 20160426141800 15:42:49 INFO - mozversion platform_changeset: 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 15:42:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:42:49 INFO - mozversion platform_version: 49.0a1 15:42:49 INFO - using testdate: 1461710569 15:42:49 INFO - actual date: 1461710569 15:42:49 INFO - starting webserver on 'localhost:46121' 15:42:49 INFO - SUITE-START | Running 2 tests 15:42:49 INFO - TEST-START | dromaeo_css 15:42:49 INFO - operating with platform_type : linux_ 15:42:49 INFO - Initialising browser for dromaeo_css test... 15:42:49 INFO - TEST-INFO | started process 23766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppuuwiN/profile http://localhost:46121/getInfo.html) 15:42:54 INFO - PROCESS | 23766 | 15:42:54 INFO - PROCESS | 23766 | (process:23834): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:42:55 INFO - PROCESS | 23766 | __metrics Screen width/height:1600/1200 15:42:55 INFO - PROCESS | 23766 | colorDepth:24 15:42:55 INFO - PROCESS | 23766 | Browser inner width/height: 1024/697 15:42:55 INFO - PROCESS | 23766 | __metrics 15:42:56 ERROR - PROCESS | 23766 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:42:57 INFO - TEST-INFO | 23766: exit 0 15:42:57 INFO - Browser initialized. 15:42:57 INFO - Running cycle 1/1 for dromaeo_css test... 15:42:57 INFO - TEST-INFO | started process 23885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppuuwiN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:59 INFO - PROCESS | 23885 | 15:42:59 INFO - PROCESS | 23885 | (process:23943): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:43:09 INFO - PROCESS | 23885 | RSS: Main: 166297600 15:43:09 INFO - PROCESS | 23885 | 15:43:59 INFO - PROCESS | 23885 | 1461710639225 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] 15:46:10 INFO - PROCESS | 23885 | Cycle 1(1): loaded http://localhost:46121/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46121/tests/dromaeo/cssquery-ext.html) 15:46:11 INFO - PROCESS | 23885 | RSS: Main: 169902080 15:46:11 INFO - PROCESS | 23885 | 15:49:13 INFO - PROCESS | 23885 | Cycle 1(1): loaded http://localhost:46121/tests/dromaeo/cssquery-ext.html (next: http://localhost:46121/tests/dromaeo/cssquery-jquery.html) 15:49:14 INFO - PROCESS | 23885 | RSS: Main: 166903808 15:49:14 INFO - PROCESS | 23885 | 15:52:16 INFO - PROCESS | 23885 | Cycle 1(1): loaded http://localhost:46121/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46121/tests/dromaeo/cssquery-mootools.html) 15:52:16 INFO - PROCESS | 23885 | RSS: Main: 168177664 15:52:16 INFO - PROCESS | 23885 | 15:55:18 INFO - PROCESS | 23885 | Cycle 1(1): loaded http://localhost:46121/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46121/tests/dromaeo/cssquery-prototype.html) 15:55:19 INFO - PROCESS | 23885 | RSS: Main: 166207488 15:55:19 INFO - PROCESS | 23885 | 15:58:21 INFO - PROCESS | 23885 | Cycle 1(1): loaded http://localhost:46121/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46121/tests/dromaeo/cssquery-yui.html) 15:58:22 INFO - PROCESS | 23885 | RSS: Main: 167542784 15:58:22 INFO - PROCESS | 23885 | 16:01:24 INFO - PROCESS | 23885 | Cycle 1(1): loaded http://localhost:46121/tests/dromaeo/cssquery-yui.html (next: http://localhost:46121/tests/dromaeo/cssquery-dojo.html) 16:01:24 INFO - PROCESS | 23885 | RSS: Main: 170045440 16:01:24 INFO - PROCESS | 23885 | 16:01:24 INFO - PROCESS | 23885 | __start_tp_report 16:01:24 INFO - PROCESS | 23885 | _x_x_mozilla_page_load 16:01:24 INFO - PROCESS | 23885 | _x_x_mozilla_page_load_details 16:01:24 INFO - PROCESS | 23885 | |i|pagename|runs| 16:01:24 INFO - PROCESS | 23885 | |0;dojo.html;2580.419405633732;2630.224083895251;2637.973620263797;2643.841369517829;2648.271725275548;4580.03819197968;4580.35874977503;4629.398178236829;4630.814767409308;4678.204705200115;4562.794674239659;4588.059447813199;4607.677462577621;4676.485586585472;4684.13343531446;4199.832006719727;4309.224339618867;4326.502452217988;4335.978320108395;4339.32740425233;625.5868375633625;4122.97938510307;4243.236217480852;4284.036091879318;4289.871303860889;4244.087521182961;4276.401303817453;4276.572342765729;4307.913841723163;4333.328334108218;4259.446271984653;4274.465691788527;4287.335463003239;4297.484301883763;4332.501762297345;4131.35963925592;4194.182134483777;4255.0426154115385;4268.210381079511;4294.184105020036;4485.506594274627;4541.500434952152;4546.772661366918;4547.772611369452;4562.224421848294;4817.807287708488;4912.606991440676;4934.08719386911;4935.259711043336;4935.629827762932;4958.2314741214805;5003.074431230234;5014.022265658198;5044.722540260284;5061.038402703474;4593.816247350102;4625.259958406672;4627.074585082997;4643.489216186217;4671.112488627184;4937.7777999990085;5032.949670503322;5039;5048.899022019539;5104.974475127675;4827.517248275144;4855.053264613437;4874.4150701916;4881.096997055556;4901.779419926112;4952.207646776498;4952.479989601112;4954.3311652926395;4965.652404331734;5007.649464537448;4732.645051621073;4877.951220487821;4889.804407823718;4949.826756063592;4952.504749525091;4840.757962101951;4876.756162191876;4881.267809828483;4912.877178070506;4945.208766597327;4208.263553878059;4210.179015092028;4215.325547912319;4218.873433796991;4266.0188156724125;3639.7270204734223;3685.8709945152327;3686.594474607791;3716.3496388132507;3733.8133093345223;4215.620594146541;4306.332518459643;4312.05134870328;4355.760433176142;4379.64962802975;4968.1554135797005;4968.279599458058;4983.053219888209;4989.17678583037;5004.674696144739;4267.1892340455215;4322.092360604308;4363.629091527256;4378.408914796525;4395.802188901507;4505.684602077823;4523.072770082125;4523.773811309421;4527.524609915978;4578.679492435497;4706.952930470651;4707.340972263886;4718.056388722201;4720.527947205252;4722.126406614719;4809.062232864558;4981.601471882168;5011.674241174312;5063.443021267584;5076.923846142237;4662.836800711959;4672.065586882569;4683.648726345469;4696.976515117402;4730.787114579921;4755.619550436026;4891.608671306216;4891.926621100615;4893.804247830047;4946.431160416598;4852.344933433941;4894.2658601210105;4894.388201474816;4925.507449255046;4946.060248552763;4815.855524334275;4851.369321988119;4851.757412129309;4859.562639362474;4904.779284932258;4692.741899195577;4788.138135135709;4840.394950631171;4848.636352273523;4901.362822833009;4680.929786053144;4713.528647135259;4727.787249573708;4741.620670346433;4762.3332733416655;4839.661223714447;4842.128416884994;4844.128056949783;4854.660173787801;4902.803887844446;4619.976900115478;4728.3380326753595;4745.217039188496;4786.593139583035;4790.113828941657 16:01:25 INFO - PROCESS | 23885 | |1;ext.html;576.2105914896592;594.488739683872;603.6528995827399;625.5871125057463;627.3130921640803;35037.649623503756;36296;36370.09074773132;36394.818025909866;36416.45375319369;36271;37018.8149059255;37028;37066.25867482649;37104.62895371045;7609.467337286378;7732.072151341847;7780.455368124233;7796.571188584626;7802.960985195066;7605.695772169107;7677.270659287359;7727.265909738566;7728.188540203282;7732.922670773305;7671.8082047948965;7738.303552680258;7762.068551773795;7773.339266162383;7774.222577742237;7608.0489938757655;7681.308682218571;7690.192529784376;7712.614369281541;7760.223977602251;7579.583122928237;7644.46488745788;7691.9230807691765;7751.302382785577;7775.922240777576;23436.64845027326;27962.860185699144;28622;28910;28948.27629309263;2777.4306267215375;2973.2864112612815;3220.838958052088;3354.295597924439;3493.458513930345;25315;25863.224103276745;25996.22011339663;26381.604275935875;26794.464110717872;3344.3144155448076;3371.3594417060926;3396.201892555272;3410.3179364127027;3491.458823882302;152268;154188;155366;156200;156568.43431565652;31338;32148.517772233434;50183;51232;51260.74369628128;32802.50796238059;32847.507287390705;32909.341813163606;33033.83483082569;33080.50379244313;12456.252624842538;12676.302803345905;12715.237085774883;12715.364231788373;12728.109032367645;10539;10548.681414823148;10579.57681692739;10636.202284828669;10667.466626668636;7764.456488045896;7811.804704882424;7858.292753652198;7924.801879952932;7934.2859142677435;3115.392498462778;3172.365526894584;3194.3611277744544;3198.4882418812876;3203.631582368011;869.9260562852102;880.1990188928045;1013.9239557033104;1050.7005503431485;1054.514923135351;26908.192754217405;27304.180874573794;27652.308692282855;27748.30629234285;27807.860960695067;926.4765407544716;932.8320902237663;950.273041123541;987.1707765477033;1075.0539525217757;13522.18866867991;13807.654808629864;14432.567022989328;14987.925060374846;15444.0733555987;274092;281676;282214;282971;283182;46606.300905486445;46862.76568617203;47434.762826186336;47471.525284747404;47499.28751068737;1179.8732210738724;1216.4525963316366;1221.4869754703045;1224.0268986156027;1263.4630282130242;25993.350166245997;27484.725152749015;28092.71907280901;28101.578476322462;28487.857560712062;41085.794571026956;41137.58862411338;41964.79017605015;42070.36894446525;42169.57830421779;257067;258956;259282;259564;259714;24047.63928541108;24395.39011524726;24440.633390498802;24499.877500612383;32872.671273286964;35706.64293357033;35889.46165807463;36180;36692.44961325636;36898.8155059223;33470;34445.13887152841;34453.310933781686;34532.82733586316;34790.47814282838;34005.65994340025;34173.82913085419;34291.314173716884;34558.82720586381;34717.47923781196;31540.842295788374;32268.677313226566;32436;33656.49515257322;33821.15447113842;25411.237662870142;26462.470750585264;26738.866305668347;26941.86529067342;29189;21989.890050549646;23150.3054908353;23680.881595591913;23897.52204955926;23986.520269594163 16:01:25 INFO - PROCESS | 23885 | |2;jquery.html;359.64395248703784;360.1518424111218;360.3531660669099;360.46650956584256;366.12130885873916;15047;15322.54032379029;16927.238274277643;16975.405860794875;17003.23485443155;14480.13119212848;14684.85315146851;15223.695526089472;15272.923635381836;15435;4983.327250821129;5013.097642424371;5253.0544501989625;5279.3928698199625;5282.2076688496845;3345.2473193531505;5118.71847048414;5219.060569097561;5402.432744561824;5405.405405405402;5285.365756109272;5321.547668448186;5358.892822143554;5359.38367087786;5369.704666243375;5238.659487133344;5308.840734777963;5440.347158340985;5474.315710536183;5487.067198576252;5210.166373380241;5243.134882744343;5250.6324557281005;5266.736663166865;5273.367195936512;11744.354060526668;16610.418635347825;17557.824421755748;17713.38003169896;17818.643627127385;1783.6432713457361;1845.8061903500209;1859.944201673952;1886.613244284932;1893.2900162439084;8409.411341206118;8447.408681392306;8799.604017819149;8840;12072.094592905567;1755.5084576318652;1828.7622609060736;1850.1304386938118;1875.5217419557925;1875.90620468976;58615.70692146512;60793.392066079214;61344;61524;62379.68810155966;9688.46713430754;9790.216782657513;9903.752406189902;9934.15559677421;10332.276740628235;13495.460181592824;13505.594832155051;13523.864761352457;13586.252756098509;13616.18302901829;7020.368166865007;7153.89269160963;7162.319579639926;7235.167955685059;7252.5648461092505;6656.83357916056;6676.666166691646;6683.6324002180345;6819.659017049128;6820.113385259884;4140.296149654566;4158.168366326747;4325.199838029975;4330.545292744217;4446.6220371268155;1607.903525788433;1657.80935192452;1808.4176345697515;1821.763170787789;1854.2212270846278;863.53369180643;870.9738707838775;893.4058850864233;985.4629227071264;987.1559816356911;15217.847821521864;15369.769453458208;15478.303476343592;15590.610234744223;15637.296321665552;840.2689659995842;868.847951608466;871.4292138649195;891.9687810926716;963.9662611808553;8661.30709543235;8826.338024648177;8841.292696584258;8865.689700860568;9072.8639070414;123434;343738;343842;344038;359896;63271.050934236024;64487.355126449074;65587;66194.66902665456;66598.33401666018;939.6241503398695;955.8088382323563;962.5957098018708;982.8771403574553;986.4377304936118;14258.500952466615;14440.350184241524;14504.73045119325;14676.70646587041;14919.104853708812;31070.689293106778;31320.843395783788;31682.207944801565;31760.523592145673;32156.83921580377;39940;42233.788831055645;43001.13997719966;43061.78469107635;43503.78248108739;7510.586917719578;7578.431617628589;7595.506292090997;7714.190010049088;7849.921500785147;8072.636731346986;10939.45302734876;10956.890431095906;11030.558777648805;11083.334999900031;9756.707298781048;9969.40183588987;10036.397816131055;10079.899201007896;10186.541605627617;9896.208303335572;10050.296479246383;10246.333988290737;10290.588376465157;10314.174866010851;5272.156454967187;7153.964230178815;9905.455199964072;9979.301448898797;10360.844587331045;6849.657517124224;7375.188729239672;7495.138059123053;7541.321281084729;7608.0489938757655;7462.8507429850015;8234.752957411287;9237.491937943209;9415.105564971316;9444.811103778024 16:01:25 INFO - PROCESS | 23885 | |3;mootools.html;1420.7655736803429;1449.3622805965374;1569.9843001569982;1726.197318247015;1750.7023805952995;6449.83875403114;7299.343059124678;7327.706891724325;7588.582627955467;7592.544447333157;7357.3746231570385;7390.297921697444;7397.852042959137;7474.028376311086;7476.28975247352;2156.24531414005;2195.1768086967386;2198.3844523533435;2199;2203.966940495886;2156.1698745982753;2173.4892300309416;2208.7570367259586;2208.8232941364654;2212.623853944825;2111.7043613894066;2113.302610138658;2124.6388114020656;2125.4048866317457;2133.434639820449;2106.6734656128247;2122.9044692988778;2133.3599920024008;2135.7864213578673;2146.785321467856;2109.915603375863;2150.1721837092678;2175.3256490487843;2202.537467131904;2208.017432242653;7610.771676849703;7624.466287359887;7628.19903910087;7687.308142267167;7716.305532502101;4472.686911916135;4647.1170477609485;4661.813527458898;4664.673472856902;4666.95333046672;2815.8873645054173;2859.5567687008547;2987.686292939232;3024.9848750756105;3028.6819883912094;920.093707697917;959.2086528613852;981.0728861226144;989.0554520432969;991.2020823237291;10408.375497470177;10415.114715249212;10432.008959148869;10447.47762611874;10479.318844275098;4042.292598795199;4048.919021619551;4119.629233369011;4133.173365326947;4239.215745087169;8508.234258916727;8528.658853645784;8542.914570854336;8544.871826922601;8548.059713431518;4482.39487669167;4486.573775491323;4498.437695288089;4520.570545798144;4525.796339164745;3547.113221694576;3997.8800635980965;4084.8774536763945;4091.631753142172;4216.198922204771;3450.723942084627;3510.578730552299;3514.4360759461792;3533.876314328986;3575.3564358415215;1155.9595414160465;1169.368540987874;1184.5084290019718;1189.6252680405644;1192.379962419537;824.9505029698238;840.5965136734279;843.304273973974;851.9190676885686;861.0485413617862;4895.975520122448;5088.847334579968;5125.1287281162295;5127.564282001045;5231.3199284092825;398.5476484190465;404.11498817589387;415.78171459983145;419.47356068134906;420.7349369896945;3539.132912436418;3551.5915669697797;3595.676389124939;3654.634536546324;3662.9633703663153;9195.586198620944;9559.330846840654;9670.129688328085;9673.419594824332;9682.56428460721;9384.90615093854;9442.38624489406;9517.952410237904;9522.571484283224;9538.61845526185;6728.125343705385;7109.360157585842;7236.384907282834;7259.237780033126;7309.305615966475;5148;5174.922376164285;5186.688798672092;5363.704996225245;5389.676619402849;8571.22858942698;8623.655053797778;8723;8881.111888811067;8881.555922203994;8874.51190184546;8894.73315800527;9032.412893161923;9054.049324820799;9064.864027039468;5840.561957853263;6516.73933042692;6746;6747.831304217434;6930.099087118642;7081.044059051962;7153.177384600837;7174.354308112295;7175.174854891754;7193.892091618525;6335.778247761306;6554.377334153248;6600.53796234259;6660.134182556237;6687.565308254948;6254.342599211303;6314.778982735582;6359.17330747;6382;6411.6153030818305;6139.048447490646;6183.072539119168;6207.16203312547;6216.751329946752;6234.220722409699;4334.761588112684;4457.375967364506;4476.507584165674;4482.215612267905;4493.910121797611;4429.2027435062;4487.7980490878645;4492.961392190866;4498.392716983165;4518.096380723934 16:01:25 INFO - PROCESS | 23885 | |4;prototype.html;311.36326212894636;314.7922371234985;315.070541901391;318.0823324708216;318.84376655438825;4883.731394773286;4967.776450059747;4971.624970026372;4983.700977941317;4991.201407774757;4859.975700121503;4870.732109733972;4894.119058569456;4911.336969509115;4914.950850491494;3705.4812326274277;3750.343689854278;3868.6324799144036;3875.6511913927743;3882.7282090253693;3888.2612303662354;3889.658067966547;3898.4542164097047;3900.4149377593303;3900.453936448885;3857.864974725885;3876.282887665777;3881.922361552767;3893.9875632335657;3905.3751399776042;3798.1264309209037;3802.068493219151;3862.5558060822946;3863.884083477486;3884.261990221877;3438.793672379665;3446.827658617084;3452.602950660656;3459.100633835196;3464.7401444891734;4703.365045718819;4711.929321060187;4717.386739723848;4726.834560790356;4733.479317275097;4430.224710675619;4442.711223770445;4444.466664000308;4445.177642136216;4450.221211288012;4934.6052315815;5117.41149767774;5130.666506677091;5137.486251374833;5152.381714194284;3726.9254614907823;3749.793761343125;3766.642168993941;3774.471573979645;3784.489093972306;5291.095205725974;5308.991291654612;5310.415854256029;5352.330958630171;5369.731513424314;3497.632748561415;3709.350863598859;3730.198007428416;3742.7567208131386;3811.809409529568;3758.2295629396453;3773.9432958771586;3776.339140650375;3787.4318852172396;3800.2969450651167;4282.314829627245;4293.291606884892;4327.2643650579475;4340.153670034313;4358.956410435919;4968.6025117990475;5076.162433198555;5124.180131178993;5146.614003949719;5190.247414125006;1376.311844077961;1390.3882291791579;1392.484780631173;1395.0304538345752;1401.068289587413;852.863541833316;904.5432056811268;918.545320066558;948.4830767231875;951.2627713522076;4383.254846676073;4532.70537415067;4536.138133754576;4558.521355257651;4565.6119229865835;5242.370915490165;5247.9737601311745;5265.262863199156;5272.578193744491;5287.894242115136;4414.249577571821;4497.437820272466;4525.660575456854;4526.977365113154;4538.841140560131;2985.6118704568266;3013.246688327918;3018.2303512604144;3029.7576193904433;3032.651245106797;5290.65610735301;5316.388615309289;5320.201969704575;5355.768173320081;5364.544013758796;5628.268325117709;5762.740676669476;5775.249217601685;5824.796132135355;5831.329397119301;5325.733713314319;5337.119375303109;5343.812966546152;5353.197020446964;5367.570594352443;5561.610687251854;5599.496045355938;5612.326520817528;5635.605507614428;5666.801661941812;5304.840854774363;5481.109017388994;5487.4238204987905;5490;5501.092319767194;5290.873118967058;5299.258103865385;5316.9468305318;5318.867028324323;5356.678599284055;3903.082775547687;3916.5300163980505;3921.5882282378893;3922.823472943667;3928.0572662561353;5426.782928682808;5594.552435805207;5603.131514615078;5615.213870058114;5624.634398764068;5446.794048410242;5450.264214331015;5452.209429632601;5477.068898287221;5487.42382049895;5296.470352964673;5424.593155513431;5425.647332923348;5444.3194600674915;5444.564434845282;5289.761960711854;5370.865728356823;5371.865703357447;5382.623216374816;5408.810691625774;4868.878278043077;4947.9960615950595;5180.974095129651;5196.350456192976;5450.781968721207;5019;5040.899182016413;5048.167052436307;5056.508330042573;5061.443241243386 16:01:25 INFO - PROCESS | 23885 | |5;yui.html;659.9835004124897;669.8158006548199;713.0409599089224;770.9845803083939;781.4529829119617;11695.473703683345;11789.410529473513;11861.169718119734;12325;12513.249205047703;10466.372017678945;10947.288426252288;11531.654050378482;11663.358515281656;11671.241369310988;781.9843603127948;791.2759824760337;795.6419611174995;796;796.3509739562268;794.5788731972063;800.3157300508069;804.1435870797611;804.9637766300501;805.7582725182422;839.3746658739248;843.6288033265374;845.3490812074699;846.1876598465481;853.2363534636496;837.1795640272506;839.1063517353998;840.6553313141613;841.1798496465927;843.6541018182546;609.8048624440181;611.9296280927706;614.0390289197436;614.5912967876357;617.1544983372808;11333.546658133664;11390.487428065757;11408.486618102123;11412.82880756781;11448;10151.64469243573;10211.540480678388;10316.948415257875;10397.688069357931;10661.84007239892;8913.1086891311;8984.46093234408;9198;9223.677171298972;9272.350935434522;3256.8697252110123;3267.901962941092;3279.4097062528735;3304.273059926812;3390.0338403555115;37501.81249093764;40633.79683101595;41879.74360769182;42068.78965605152;44695;9025.729228123168;9225.12361325673;9252.814943701089;9331.06689331075;9631.518424078768;15107.4712385066;15171.848281517265;15316.081035137704;15421.228938553028;15426.922865385826;6521.836954076186;6614.7023383947835;6706.53054286205;6768.661566921733;7023.8244043898285;3643.4534819776713;3704.5554533456157;3748.475213470116;3778.848846046127;3843.0008197868196;2814.746672799458;2874.5688146777734;2888.364559796841;2892.971070289312;2897.9420411592073;513.9717315547681;521.707843607581;528.6959998001165;528.6986417741928;536.6109570561312;557.6431084106175;566.4675205306999;577.4265127527538;588.802751078385;593.6289818863211;7623.733169339046;7820.296173344313;8003.599820008976;8061.234182752629;8239.382046346429;519.8180636777173;561.3179986316645;599.7091410665823;600.3516202501288;610.81370182094;3632.654897784706;3678.7608805427562;3719.237556300952;3740.9064773380337;3747.887563373103;54087.516960650915;57146;57180.42819571834;57195.42804571984;57805.710971444874;46825;48753.75623121862;49116.50883491191;49733;49994.500054998985;36030.459543106874;45423.31865022027;46567;46689;47562;7721.845563088595;7779;7869.4884832488;7891.131975482807;8135.9186408135165;30260.394792104475;30404.087877363716;30504.389912201186;30536.083917482512;31158.68841311558;37156;38115.80942095272;40394;40585.79707101446;40862.59137408707;9986.750331241778;10084.54619542137;10110.848337275094;10154.086132248132;10430.37417754937;10904;11242.94378528102;11562.94218528902;11638.88361116378;11802.173847830569;10361;10414.479276036016;10548.367097974146;10618.893811061791;10704.785904281714;10355.223358248311;10372.533236004247;10456.424896630455;10590.947045264724;10609.628662996758;10358.948205258925;10445.9477702611;10463.68608941733;10683.145348372267;10711.571537138427;8696.956515217384;8784.209421152127;8851.645934162561;8970.327225457986;9168.770780730269;8605.698800541952;8616;8634.956825215833;8748.976289874676;8800.207981281716 16:01:25 INFO - PROCESS | 23885 | __end_tp_report 16:01:25 INFO - PROCESS | 23885 | __start_cc_report 16:01:25 INFO - PROCESS | 23885 | _x_x_mozilla_cycle_collect,382 16:01:25 INFO - PROCESS | 23885 | __end_cc_report 16:01:25 INFO - PROCESS | 23885 | __startTimestamp1461711684994__endTimestamp 16:01:25 INFO - PROCESS | 23885 | 16:01:25 INFO - PROCESS | 23885 | ------- Summary: start ------- 16:01:25 INFO - PROCESS | 23885 | Number of tests: 6 16:01:25 INFO - PROCESS | 23885 | 16:01:25 INFO - PROCESS | 23885 | [#0] dojo.html Cycles:165 Average:4559.78 Median:4707.34 stddev:558.49 (11.9%) stddev-sans-first:538.18 16:01:25 INFO - PROCESS | 23885 | Values: 2580.4 2630.2 2638.0 2643.8 2648.3 4580.0 4580.4 4629.4 4630.8 4678.2 4562.8 4588.1 4607.7 4676.5 4684.1 4199.8 4309.2 4326.5 4336.0 4339.3 625.6 4123.0 4243.2 4284.0 4289.9 4244.1 4276.4 4276.6 4307.9 4333.3 4259.4 4274.5 4287.3 4297.5 4332.5 4131.4 4194.2 4255.0 4268.2 4294.2 4485.5 4541.5 4546.8 4547.8 4562.2 4817.8 4912.6 4934.1 4935.3 4935.6 4958.2 5003.1 5014.0 5044.7 5061.0 4593.8 4625.3 4627.1 4643.5 4671.1 4937.8 5032.9 5039.0 5048.9 5105.0 4827.5 4855.1 4874.4 4881.1 4901.8 4952.2 4952.5 4954.3 4965.7 5007.6 4732.6 4878.0 4889.8 4949.8 4952.5 4840.8 4876.8 4881.3 4912.9 4945.2 4208.3 4210.2 4215.3 4218.9 4266.0 3639.7 3685.9 3686.6 3716.3 3733.8 4215.6 4306.3 4312.1 4355.8 4379.6 4968.2 4968.3 4983.1 4989.2 5004.7 4267.2 4322.1 4363.6 4378.4 4395.8 4505.7 4523.1 4523.8 4527.5 4578.7 4707.0 4707.3 4718.1 4720.5 4722.1 4809.1 4981.6 5011.7 5063.4 5076.9 4662.8 4672.1 4683.6 4697.0 4730.8 4755.6 4891.6 4891.9 4893.8 4946.4 4852.3 4894.3 4894.4 4925.5 4946.1 4815.9 4851.4 4851.8 4859.6 4904.8 4692.7 4788.1 4840.4 4848.6 4901.4 4680.9 4713.5 4727.8 4741.6 4762.3 4839.7 4842.1 4844.1 4854.7 4902.8 4620.0 4728.3 4745.2 4786.6 4790.1 16:01:25 INFO - PROCESS | 23885 | 16:01:25 INFO - PROCESS | 23885 | [#1] ext.html Cycles:180 Average:37586.92 Median:33057.17 stddev:62373.75 (188.7%) stddev-sans-first:62486.82 16:01:25 INFO - PROCESS | 23885 | Values: 576.2 594.5 603.7 625.6 627.3 35037.6 36296.0 36370.1 36394.8 36416.5 36271.0 37018.8 37028.0 37066.3 37104.6 7609.5 7732.1 7780.5 7796.6 7803.0 7605.7 7677.3 7727.3 7728.2 7732.9 7671.8 7738.3 7762.1 7773.3 7774.2 7608.0 7681.3 7690.2 7712.6 7760.2 7579.6 7644.5 7691.9 7751.3 7775.9 23436.6 27962.9 28622.0 28910.0 28948.3 2777.4 2973.3 3220.8 3354.3 3493.5 25315.0 25863.2 25996.2 26381.6 26794.5 3344.3 3371.4 3396.2 3410.3 3491.5 152268.0 154188.0 155366.0 156200.0 156568.4 31338.0 32148.5 50183.0 51232.0 51260.7 32802.5 32847.5 32909.3 33033.8 33080.5 12456.3 12676.3 12715.2 12715.4 12728.1 10539.0 10548.7 10579.6 10636.2 10667.5 7764.5 7811.8 7858.3 7924.8 7934.3 3115.4 3172.4 3194.4 3198.5 3203.6 869.9 880.2 1013.9 1050.7 1054.5 26908.2 27304.2 27652.3 27748.3 27807.9 926.5 932.8 950.3 987.2 1075.1 13522.2 13807.7 14432.6 14987.9 15444.1 274092.0 281676.0 282214.0 282971.0 283182.0 46606.3 46862.8 47434.8 47471.5 47499.3 1179.9 1216.5 1221.5 1224.0 1263.5 25993.4 27484.7 28092.7 28101.6 28487.9 41085.8 41137.6 41964.8 42070.4 42169.6 257067.0 258956.0 259282.0 259564.0 259714.0 24047.6 24395.4 24440.6 24499.9 32872.7 35706.6 35889.5 36180.0 36692.4 36898.8 33470.0 34445.1 34453.3 34532.8 34790.5 34005.7 34173.8 34291.3 34558.8 34717.5 31540.8 32268.7 32436.0 33656.5 33821.2 25411.2 26462.5 26738.9 26941.9 29189.0 21989.9 23150.3 23680.9 23897.5 23986.5 16:01:25 INFO - PROCESS | 23885 | 16:01:25 INFO - PROCESS | 23885 | [#2] jquery.html Cycles:180 Average:20500.22 Median:5240.90 stddev:52331.63 (998.5%) stddev-sans-first:52456.58 16:01:25 INFO - PROCESS | 23885 | Values: 359.6 360.2 360.4 360.5 366.1 15047.0 15322.5 16927.2 16975.4 17003.2 14480.1 14684.9 15223.7 15272.9 15435.0 4983.3 5013.1 5253.1 5279.4 5282.2 3345.2 5118.7 5219.1 5402.4 5405.4 5285.4 5321.5 5358.9 5359.4 5369.7 5238.7 5308.8 5440.3 5474.3 5487.1 5210.2 5243.1 5250.6 5266.7 5273.4 11744.4 16610.4 17557.8 17713.4 17818.6 1783.6 1845.8 1859.9 1886.6 1893.3 8409.4 8447.4 8799.6 8840.0 12072.1 1755.5 1828.8 1850.1 1875.5 1875.9 58615.7 60793.4 61344.0 61524.0 62379.7 9688.5 9790.2 9903.8 9934.2 10332.3 13495.5 13505.6 13523.9 13586.3 13616.2 7020.4 7153.9 7162.3 7235.2 7252.6 6656.8 6676.7 6683.6 6819.7 6820.1 4140.3 4158.2 4325.2 4330.5 4446.6 1607.9 1657.8 1808.4 1821.8 1854.2 863.5 871.0 893.4 985.5 987.2 15217.8 15369.8 15478.3 15590.6 15637.3 840.3 868.8 871.4 892.0 964.0 8661.3 8826.3 8841.3 8865.7 9072.9 123434.0 343738.0 343842.0 344038.0 359896.0 63271.1 64487.4 65587.0 66194.7 66598.3 939.6 955.8 962.6 982.9 986.4 14258.5 14440.4 14504.7 14676.7 14919.1 31070.7 31320.8 31682.2 31760.5 32156.8 39940.0 42233.8 43001.1 43061.8 43503.8 7510.6 7578.4 7595.5 7714.2 7849.9 8072.6 10939.5 10956.9 11030.6 11083.3 9756.7 9969.4 10036.4 10079.9 10186.5 9896.2 10050.3 10246.3 10290.6 10314.2 5272.2 7154.0 9905.5 9979.3 10360.8 6849.7 7375.2 7495.1 7541.3 7608.0 7462.9 8234.8 9237.5 9415.1 9444.8 16:01:25 INFO - PROCESS | 23885 | 16:01:25 INFO - PROCESS | 23885 | [#3] mootools.html Cycles:180 Average:5010.03 Median:4992.41 stddev:2801.38 (56.1%) stddev-sans-first:2796.26 16:01:25 INFO - PROCESS | 23885 | Values: 1420.8 1449.4 1570.0 1726.2 1750.7 6449.8 7299.3 7327.7 7588.6 7592.5 7357.4 7390.3 7397.9 7474.0 7476.3 2156.2 2195.2 2198.4 2199.0 2204.0 2156.2 2173.5 2208.8 2208.8 2212.6 2111.7 2113.3 2124.6 2125.4 2133.4 2106.7 2122.9 2133.4 2135.8 2146.8 2109.9 2150.2 2175.3 2202.5 2208.0 7610.8 7624.5 7628.2 7687.3 7716.3 4472.7 4647.1 4661.8 4664.7 4667.0 2815.9 2859.6 2987.7 3025.0 3028.7 920.1 959.2 981.1 989.1 991.2 10408.4 10415.1 10432.0 10447.5 10479.3 4042.3 4048.9 4119.6 4133.2 4239.2 8508.2 8528.7 8542.9 8544.9 8548.1 4482.4 4486.6 4498.4 4520.6 4525.8 3547.1 3997.9 4084.9 4091.6 4216.2 3450.7 3510.6 3514.4 3533.9 3575.4 1156.0 1169.4 1184.5 1189.6 1192.4 825.0 840.6 843.3 851.9 861.0 4896.0 5088.8 5125.1 5127.6 5231.3 398.5 404.1 415.8 419.5 420.7 3539.1 3551.6 3595.7 3654.6 3663.0 9195.6 9559.3 9670.1 9673.4 9682.6 9384.9 9442.4 9518.0 9522.6 9538.6 6728.1 7109.4 7236.4 7259.2 7309.3 5148.0 5174.9 5186.7 5363.7 5389.7 8571.2 8623.7 8723.0 8881.1 8881.6 8874.5 8894.7 9032.4 9054.0 9064.9 5840.6 6516.7 6746.0 6747.8 6930.1 7081.0 7153.2 7174.4 7175.2 7193.9 6335.8 6554.4 6600.5 6660.1 6687.6 6254.3 6314.8 6359.2 6382.0 6411.6 6139.0 6183.1 6207.2 6216.8 6234.2 4334.8 4457.4 4476.5 4482.2 4493.9 4429.2 4487.8 4493.0 4498.4 4518.1 16:01:25 INFO - PROCESS | 23885 | 16:01:25 INFO - PROCESS | 23885 | [#4] prototype.html Cycles:180 Average:4378.40 Median:4913.14 stddev:1285.78 (26.2%) stddev-sans-first:1252.63 16:01:25 INFO - PROCESS | 23885 | Values: 311.4 314.8 315.1 318.1 318.8 4883.7 4967.8 4971.6 4983.7 4991.2 4860.0 4870.7 4894.1 4911.3 4915.0 3705.5 3750.3 3868.6 3875.7 3882.7 3888.3 3889.7 3898.5 3900.4 3900.5 3857.9 3876.3 3881.9 3894.0 3905.4 3798.1 3802.1 3862.6 3863.9 3884.3 3438.8 3446.8 3452.6 3459.1 3464.7 4703.4 4711.9 4717.4 4726.8 4733.5 4430.2 4442.7 4444.5 4445.2 4450.2 4934.6 5117.4 5130.7 5137.5 5152.4 3726.9 3749.8 3766.6 3774.5 3784.5 5291.1 5309.0 5310.4 5352.3 5369.7 3497.6 3709.4 3730.2 3742.8 3811.8 3758.2 3773.9 3776.3 3787.4 3800.3 4282.3 4293.3 4327.3 4340.2 4359.0 4968.6 5076.2 5124.2 5146.6 5190.2 1376.3 1390.4 1392.5 1395.0 1401.1 852.9 904.5 918.5 948.5 951.3 4383.3 4532.7 4536.1 4558.5 4565.6 5242.4 5248.0 5265.3 5272.6 5287.9 4414.2 4497.4 4525.7 4527.0 4538.8 2985.6 3013.2 3018.2 3029.8 3032.7 5290.7 5316.4 5320.2 5355.8 5364.5 5628.3 5762.7 5775.2 5824.8 5831.3 5325.7 5337.1 5343.8 5353.2 5367.6 5561.6 5599.5 5612.3 5635.6 5666.8 5304.8 5481.1 5487.4 5490.0 5501.1 5290.9 5299.3 5316.9 5318.9 5356.7 3903.1 3916.5 3921.6 3922.8 3928.1 5426.8 5594.6 5603.1 5615.2 5624.6 5446.8 5450.3 5452.2 5477.1 5487.4 5296.5 5424.6 5425.6 5444.3 5444.6 5289.8 5370.9 5371.9 5382.6 5408.8 4868.9 4948.0 5181.0 5196.4 5450.8 5019.0 5040.9 5048.2 5056.5 5061.4 16:01:25 INFO - PROCESS | 23885 | 16:01:25 INFO - PROCESS | 23885 | [#5] yui.html Cycles:180 Average:12591.17 Median:48935.13 stddev:14905.65 (30.5%) stddev-sans-first:14920.53 16:01:25 INFO - PROCESS | 23885 | Values: 660.0 669.8 713.0 771.0 781.5 11695.5 11789.4 11861.2 12325.0 12513.2 10466.4 10947.3 11531.7 11663.4 11671.2 782.0 791.3 795.6 796.0 796.4 794.6 800.3 804.1 805.0 805.8 839.4 843.6 845.3 846.2 853.2 837.2 839.1 840.7 841.2 843.7 609.8 611.9 614.0 614.6 617.2 11333.5 11390.5 11408.5 11412.8 11448.0 10151.6 10211.5 10316.9 10397.7 10661.8 8913.1 8984.5 9198.0 9223.7 9272.4 3256.9 3267.9 3279.4 3304.3 3390.0 37501.8 40633.8 41879.7 42068.8 44695.0 9025.7 9225.1 9252.8 9331.1 9631.5 15107.5 15171.8 15316.1 15421.2 15426.9 6521.8 6614.7 6706.5 6768.7 7023.8 3643.5 3704.6 3748.5 3778.8 3843.0 2814.7 2874.6 2888.4 2893.0 2897.9 514.0 521.7 528.7 528.7 536.6 557.6 566.5 577.4 588.8 593.6 7623.7 7820.3 8003.6 8061.2 8239.4 519.8 561.3 599.7 600.4 610.8 3632.7 3678.8 3719.2 3740.9 3747.9 54087.5 57146.0 57180.4 57195.4 57805.7 46825.0 48753.8 49116.5 49733.0 49994.5 36030.5 45423.3 46567.0 46689.0 47562.0 7721.8 7779.0 7869.5 7891.1 8135.9 30260.4 30404.1 30504.4 30536.1 31158.7 37156.0 38115.8 40394.0 40585.8 40862.6 9986.8 10084.5 10110.8 10154.1 10430.4 10904.0 11242.9 11562.9 11638.9 11802.2 10361.0 10414.5 10548.4 10618.9 10704.8 10355.2 10372.5 10456.4 10590.9 10609.6 10358.9 10445.9 10463.7 10683.1 10711.6 8697.0 8784.2 8851.6 8970.3 9168.8 8605.7 8616.0 8635.0 8749.0 8800.2 16:01:25 INFO - PROCESS | 23885 | -------- Summary: end -------- 16:01:25 INFO - PROCESS | 23885 | 16:01:25 INFO - TEST-INFO | 23885: exit 0 16:01:25 INFO - TEST-OK | dromaeo_css | took 1116007ms 16:01:25 INFO - TEST-START | kraken 16:01:25 INFO - operating with platform_type : linux_ 16:01:25 INFO - Initialising browser for kraken test... 16:01:25 INFO - TEST-INFO | started process 24113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzxZE8S/profile http://localhost:46121/getInfo.html) 16:01:30 INFO - PROCESS | 24113 | 16:01:30 INFO - PROCESS | 24113 | (process:24182): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:01:31 INFO - PROCESS | 24113 | __metrics Screen width/height:1600/1200 16:01:31 INFO - PROCESS | 24113 | colorDepth:24 16:01:31 INFO - PROCESS | 24113 | Browser inner width/height: 1024/697 16:01:31 INFO - PROCESS | 24113 | __metrics 16:01:32 ERROR - PROCESS | 24113 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:01:33 INFO - TEST-INFO | 24113: exit 0 16:01:33 INFO - Browser initialized. 16:01:33 INFO - Running cycle 1/1 for kraken test... 16:01:33 INFO - TEST-INFO | started process 24233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzxZE8S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:35 INFO - PROCESS | 24233 | 16:01:35 INFO - PROCESS | 24233 | (process:24291): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:01:45 INFO - PROCESS | 24233 | RSS: Main: 165675008 16:01:45 INFO - PROCESS | 24233 | 16:01:48 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46121/tests/kraken/driver.html?testName=audio-beat-detection) 16:01:49 INFO - PROCESS | 24233 | RSS: Main: 169492480 16:01:49 INFO - PROCESS | 24233 | 16:01:52 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46121/tests/kraken/driver.html?testName=audio-dft) 16:01:52 INFO - PROCESS | 24233 | RSS: Main: 173174784 16:01:52 INFO - PROCESS | 24233 | 16:01:55 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46121/tests/kraken/driver.html?testName=audio-fft) 16:01:56 INFO - PROCESS | 24233 | RSS: Main: 165445632 16:01:56 INFO - PROCESS | 24233 | 16:01:58 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46121/tests/kraken/driver.html?testName=audio-oscillator) 16:01:59 INFO - PROCESS | 24233 | RSS: Main: 165736448 16:01:59 INFO - PROCESS | 24233 | 16:02:01 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46121/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:02:02 INFO - PROCESS | 24233 | RSS: Main: 166105088 16:02:02 INFO - PROCESS | 24233 | 16:02:05 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46121/tests/kraken/driver.html?testName=imaging-darkroom) 16:02:05 INFO - PROCESS | 24233 | RSS: Main: 166354944 16:02:05 INFO - PROCESS | 24233 | 16:02:09 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46121/tests/kraken/driver.html?testName=imaging-desaturate) 16:02:09 INFO - PROCESS | 24233 | RSS: Main: 165920768 16:02:09 INFO - PROCESS | 24233 | 16:02:12 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46121/tests/kraken/driver.html?testName=json-parse-financial) 16:02:13 INFO - PROCESS | 24233 | RSS: Main: 166522880 16:02:13 INFO - PROCESS | 24233 | 16:02:15 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46121/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:02:15 INFO - PROCESS | 24233 | RSS: Main: 166645760 16:02:15 INFO - PROCESS | 24233 | 16:02:17 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46121/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:02:18 INFO - PROCESS | 24233 | RSS: Main: 166658048 16:02:18 INFO - PROCESS | 24233 | 16:02:20 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46121/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:02:21 INFO - PROCESS | 24233 | RSS: Main: 167796736 16:02:21 INFO - PROCESS | 24233 | 16:02:24 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:02:24 INFO - PROCESS | 24233 | RSS: Main: 167182336 16:02:24 INFO - PROCESS | 24233 | 16:02:28 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:02:28 INFO - PROCESS | 24233 | RSS: Main: 164618240 16:02:28 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | Cycle 1(1): loaded http://localhost:46121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46121/tests/kraken/driver.html?testName=ai-astar) 16:02:30 INFO - PROCESS | 24233 | RSS: Main: 166805504 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | __start_tp_report 16:02:30 INFO - PROCESS | 24233 | _x_x_mozilla_page_load 16:02:30 INFO - PROCESS | 24233 | _x_x_mozilla_page_load_details 16:02:30 INFO - PROCESS | 24233 | |i|pagename|runs| 16:02:30 INFO - PROCESS | 24233 | |0;ai-astar;115;110;115;114;114;127;116;113;114;114 16:02:30 INFO - PROCESS | 24233 | |1;audio-beat-detection;155;137;155;196;142;167;154;133;204;134 16:02:30 INFO - PROCESS | 24233 | |2;audio-dft;164;162;164;174;163;163;163;165;165;162 16:02:30 INFO - PROCESS | 24233 | |3;audio-fft;76;78;78;165;74;73;77;77;160;76 16:02:30 INFO - PROCESS | 24233 | |4;audio-oscillator;93;94;143;94;95;94;151;95;94;144 16:02:30 INFO - PROCESS | 24233 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;118;118;118 16:02:30 INFO - PROCESS | 24233 | |6;imaging-darkroom;147;148;147;150;147;147;148;147;147;147 16:02:30 INFO - PROCESS | 24233 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;96 16:02:30 INFO - PROCESS | 24233 | |8;json-parse-financial;66;67;67;65;67;66;66;87;64;65 16:02:30 INFO - PROCESS | 24233 | |9;json-stringify-tinderbox;65;65;64;66;66;65;65;66;65;65 16:02:30 INFO - PROCESS | 24233 | |10;stanford-crypto-aes;83;80;80;85;81;79;80;81;89;80 16:02:30 INFO - PROCESS | 24233 | |11;stanford-crypto-ccm;135;141;135;156;137;135;135;140;246;135 16:02:30 INFO - PROCESS | 24233 | |12;stanford-crypto-pbkdf2;222;221;218;223;217;215;219;216;219;219 16:02:30 INFO - PROCESS | 24233 | |13;stanford-crypto-sha256-iterative;75;78;74;77;75;75;74;74;74;76 16:02:30 INFO - PROCESS | 24233 | __end_tp_report 16:02:30 INFO - PROCESS | 24233 | __start_cc_report 16:02:30 INFO - PROCESS | 24233 | _x_x_mozilla_cycle_collect,943 16:02:30 INFO - PROCESS | 24233 | __end_cc_report 16:02:30 INFO - PROCESS | 24233 | __startTimestamp1461711750907__endTimestamp 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | ------- Summary: start ------- 16:02:30 INFO - PROCESS | 24233 | Number of tests: 14 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#0] ai-astar Cycles:10 Average:115.20 Median:114.50 stddev:4.44 (3.9%) stddev-sans-first:4.71 16:02:30 INFO - PROCESS | 24233 | Values: 115.0 110.0 115.0 114.0 114.0 127.0 116.0 113.0 114.0 114.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#1] audio-beat-detection Cycles:10 Average:157.70 Median:155.00 stddev:24.88 (16.1%) stddev-sans-first:26.37 16:02:30 INFO - PROCESS | 24233 | Values: 155.0 137.0 155.0 196.0 142.0 167.0 154.0 133.0 204.0 134.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:3.50 (2.1%) stddev-sans-first:3.71 16:02:30 INFO - PROCESS | 24233 | Values: 164.0 162.0 164.0 174.0 163.0 163.0 163.0 165.0 165.0 162.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.50 stddev:36.47 (47.7%) stddev-sans-first:38.14 16:02:30 INFO - PROCESS | 24233 | Values: 76.0 78.0 78.0 165.0 74.0 73.0 77.0 77.0 160.0 76.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:94.00 stddev:25.14 (26.7%) stddev-sans-first:25.93 16:02:30 INFO - PROCESS | 24233 | Values: 93.0 94.0 143.0 94.0 95.0 94.0 151.0 95.0 94.0 144.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:02:30 INFO - PROCESS | 24233 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 16:02:30 INFO - PROCESS | 24233 | Values: 147.0 148.0 147.0 150.0 147.0 147.0 148.0 147.0 147.0 147.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:02:30 INFO - PROCESS | 24233 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:66.50 stddev:6.75 (10.1%) stddev-sans-first:7.12 16:02:30 INFO - PROCESS | 24233 | Values: 66.0 67.0 67.0 65.0 67.0 66.0 66.0 87.0 64.0 65.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 16:02:30 INFO - PROCESS | 24233 | Values: 65.0 65.0 64.0 66.0 66.0 65.0 65.0 66.0 65.0 65.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:3.08 (3.8%) stddev-sans-first:3.24 16:02:30 INFO - PROCESS | 24233 | Values: 83.0 80.0 80.0 85.0 81.0 79.0 80.0 81.0 89.0 80.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:138.50 stddev:34.52 (24.9%) stddev-sans-first:36.21 16:02:30 INFO - PROCESS | 24233 | Values: 135.0 141.0 135.0 156.0 137.0 135.0 135.0 140.0 246.0 135.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:218.90 Median:219.00 stddev:2.56 (1.2%) stddev-sans-first:2.46 16:02:30 INFO - PROCESS | 24233 | Values: 222.0 221.0 218.0 223.0 217.0 215.0 219.0 216.0 219.0 219.0 16:02:30 INFO - PROCESS | 24233 | 16:02:30 INFO - PROCESS | 24233 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:75.00 stddev:1.40 (1.9%) stddev-sans-first:1.48 16:02:30 INFO - PROCESS | 24233 | Values: 75.0 78.0 74.0 77.0 75.0 75.0 74.0 74.0 74.0 76.0 16:02:30 INFO - PROCESS | 24233 | -------- Summary: end -------- 16:02:30 INFO - PROCESS | 24233 | 16:02:31 INFO - TEST-INFO | 24233: exit 0 16:02:31 INFO - TEST-OK | kraken | took 66081ms 16:02:31 INFO - SUITE-END | took 1182s 16:02:32 INFO - Completed test suite (00:19:42) 16:02:32 INFO - javascript benchmark 16:02:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.419405633732, 2630.224083895251, 2637.973620263797, 2643.841369517829, 2648.271725275548, 4580.03819197968, 4580.35874977503, 4629.398178236829, 4630.814767409308, 4678.204705200115, 4562.794674239659, 4588.059447813199, 4607.677462577621, 4676.485586585472, 4684.13343531446, 4199.832006719727, 4309.224339618867, 4326.502452217988, 4335.978320108395, 4339.32740425233, 625.5868375633625, 4122.97938510307, 4243.236217480852, 4284.036091879318, 4289.871303860889, 4244.087521182961, 4276.401303817453, 4276.572342765729, 4307.913841723163, 4333.328334108218, 4259.446271984653, 4274.465691788527, 4287.335463003239, 4297.484301883763, 4332.501762297345, 4131.35963925592, 4194.182134483777, 4255.0426154115385, 4268.210381079511, 4294.184105020036, 4485.506594274627, 4541.500434952152, 4546.772661366918, 4547.772611369452, 4562.224421848294, 4817.807287708488, 4912.606991440676, 4934.08719386911, 4935.259711043336, 4935.629827762932, 4958.2314741214805, 5003.074431230234, 5014.022265658198, 5044.722540260284, 5061.038402703474, 4593.816247350102, 4625.259958406672, 4627.074585082997, 4643.489216186217, 4671.112488627184, 4937.7777999990085, 5032.949670503322, 5039.0, 5048.899022019539, 5104.974475127675, 4827.517248275144, 4855.053264613437, 4874.4150701916, 4881.096997055556, 4901.779419926112, 4952.207646776498, 4952.479989601112, 4954.3311652926395, 4965.652404331734, 5007.649464537448, 4732.645051621073, 4877.951220487821, 4889.804407823718, 4949.826756063592, 4952.504749525091, 4840.757962101951, 4876.756162191876, 4881.267809828483, 4912.877178070506, 4945.208766597327, 4208.263553878059, 4210.179015092028, 4215.325547912319, 4218.873433796991, 4266.0188156724125, 3639.7270204734223, 3685.8709945152327, 3686.594474607791, 3716.3496388132507, 3733.8133093345223, 4215.620594146541, 4306.332518459643, 4312.05134870328, 4355.760433176142, 4379.64962802975, 4968.1554135797005, 4968.279599458058, 4983.053219888209, 4989.17678583037, 5004.674696144739, 4267.1892340455215, 4322.092360604308, 4363.629091527256, 4378.408914796525, 4395.802188901507, 4505.684602077823, 4523.072770082125, 4523.773811309421, 4527.524609915978, 4578.679492435497, 4706.952930470651, 4707.340972263886, 4718.056388722201, 4720.527947205252, 4722.126406614719, 4809.062232864558, 4981.601471882168, 5011.674241174312, 5063.443021267584, 5076.923846142237, 4662.836800711959, 4672.065586882569, 4683.648726345469, 4696.976515117402, 4730.787114579921, 4755.619550436026, 4891.608671306216, 4891.926621100615, 4893.804247830047, 4946.431160416598, 4852.344933433941, 4894.2658601210105, 4894.388201474816, 4925.507449255046, 4946.060248552763, 4815.855524334275, 4851.369321988119, 4851.757412129309, 4859.562639362474, 4904.779284932258, 4692.741899195577, 4788.138135135709, 4840.394950631171, 4848.636352273523, 4901.362822833009, 4680.929786053144, 4713.528647135259, 4727.787249573708, 4741.620670346433, 4762.3332733416655, 4839.661223714447, 4842.128416884994, 4844.128056949783, 4854.660173787801, 4902.803887844446, 4619.976900115478, 4728.3380326753595, 4745.217039188496, 4786.593139583035, 4790.113828941657], "value": 4527.0621266682, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2105914896592, 594.488739683872, 603.6528995827399, 625.5871125057463, 627.3130921640803, 35037.649623503756, 36296.0, 36370.09074773132, 36394.818025909866, 36416.45375319369, 36271.0, 37018.8149059255, 37028.0, 37066.25867482649, 37104.62895371045, 7609.467337286378, 7732.072151341847, 7780.455368124233, 7796.571188584626, 7802.960985195066, 7605.695772169107, 7677.270659287359, 7727.265909738566, 7728.188540203282, 7732.922670773305, 7671.8082047948965, 7738.303552680258, 7762.068551773795, 7773.339266162383, 7774.222577742237, 7608.0489938757655, 7681.308682218571, 7690.192529784376, 7712.614369281541, 7760.223977602251, 7579.583122928237, 7644.46488745788, 7691.9230807691765, 7751.302382785577, 7775.922240777576, 23436.64845027326, 27962.860185699144, 28622.0, 28910.0, 28948.27629309263, 2777.4306267215375, 2973.2864112612815, 3220.838958052088, 3354.295597924439, 3493.458513930345, 25315.0, 25863.224103276745, 25996.22011339663, 26381.604275935875, 26794.464110717872, 3344.3144155448076, 3371.3594417060926, 3396.201892555272, 3410.3179364127027, 3491.458823882302, 152268.0, 154188.0, 155366.0, 156200.0, 156568.43431565652, 31338.0, 32148.517772233434, 50183.0, 51232.0, 51260.74369628128, 32802.50796238059, 32847.507287390705, 32909.341813163606, 33033.83483082569, 33080.50379244313, 12456.252624842538, 12676.302803345905, 12715.237085774883, 12715.364231788373, 12728.109032367645, 10539.0, 10548.681414823148, 10579.57681692739, 10636.202284828669, 10667.466626668636, 7764.456488045896, 7811.804704882424, 7858.292753652198, 7924.801879952932, 7934.2859142677435, 3115.392498462778, 3172.365526894584, 3194.3611277744544, 3198.4882418812876, 3203.631582368011, 869.9260562852102, 880.1990188928045, 1013.9239557033104, 1050.7005503431485, 1054.514923135351, 26908.192754217405, 27304.180874573794, 27652.308692282855, 27748.30629234285, 27807.860960695067, 926.4765407544716, 932.8320902237663, 950.273041123541, 987.1707765477033, 1075.0539525217757, 13522.18866867991, 13807.654808629864, 14432.567022989328, 14987.925060374846, 15444.0733555987, 274092.0, 281676.0, 282214.0, 282971.0, 283182.0, 46606.300905486445, 46862.76568617203, 47434.762826186336, 47471.525284747404, 47499.28751068737, 1179.8732210738724, 1216.4525963316366, 1221.4869754703045, 1224.0268986156027, 1263.4630282130242, 25993.350166245997, 27484.725152749015, 28092.71907280901, 28101.578476322462, 28487.857560712062, 41085.794571026956, 41137.58862411338, 41964.79017605015, 42070.36894446525, 42169.57830421779, 257067.0, 258956.0, 259282.0, 259564.0, 259714.0, 24047.63928541108, 24395.39011524726, 24440.633390498802, 24499.877500612383, 32872.671273286964, 35706.64293357033, 35889.46165807463, 36180.0, 36692.44961325636, 36898.8155059223, 33470.0, 34445.13887152841, 34453.310933781686, 34532.82733586316, 34790.47814282838, 34005.65994340025, 34173.82913085419, 34291.314173716884, 34558.82720586381, 34717.47923781196, 31540.842295788374, 32268.677313226566, 32436.0, 33656.49515257322, 33821.15447113842, 25411.237662870142, 26462.470750585264, 26738.866305668347, 26941.86529067342, 29189.0, 21989.890050549646, 23150.3054908353, 23680.881595591913, 23897.52204955926, 23986.520269594163], "value": 15371.544605613495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.64395248703784, 360.1518424111218, 360.3531660669099, 360.46650956584256, 366.12130885873916, 15047.0, 15322.54032379029, 16927.238274277643, 16975.405860794875, 17003.23485443155, 14480.13119212848, 14684.85315146851, 15223.695526089472, 15272.923635381836, 15435.0, 4983.327250821129, 5013.097642424371, 5253.0544501989625, 5279.3928698199625, 5282.2076688496845, 3345.2473193531505, 5118.71847048414, 5219.060569097561, 5402.432744561824, 5405.405405405402, 5285.365756109272, 5321.547668448186, 5358.892822143554, 5359.38367087786, 5369.704666243375, 5238.659487133344, 5308.840734777963, 5440.347158340985, 5474.315710536183, 5487.067198576252, 5210.166373380241, 5243.134882744343, 5250.6324557281005, 5266.736663166865, 5273.367195936512, 11744.354060526668, 16610.418635347825, 17557.824421755748, 17713.38003169896, 17818.643627127385, 1783.6432713457361, 1845.8061903500209, 1859.944201673952, 1886.613244284932, 1893.2900162439084, 8409.411341206118, 8447.408681392306, 8799.604017819149, 8840.0, 12072.094592905567, 1755.5084576318652, 1828.7622609060736, 1850.1304386938118, 1875.5217419557925, 1875.90620468976, 58615.70692146512, 60793.392066079214, 61344.0, 61524.0, 62379.68810155966, 9688.46713430754, 9790.216782657513, 9903.752406189902, 9934.15559677421, 10332.276740628235, 13495.460181592824, 13505.594832155051, 13523.864761352457, 13586.252756098509, 13616.18302901829, 7020.368166865007, 7153.89269160963, 7162.319579639926, 7235.167955685059, 7252.5648461092505, 6656.83357916056, 6676.666166691646, 6683.6324002180345, 6819.659017049128, 6820.113385259884, 4140.296149654566, 4158.168366326747, 4325.199838029975, 4330.545292744217, 4446.6220371268155, 1607.903525788433, 1657.80935192452, 1808.4176345697515, 1821.763170787789, 1854.2212270846278, 863.53369180643, 870.9738707838775, 893.4058850864233, 985.4629227071264, 987.1559816356911, 15217.847821521864, 15369.769453458208, 15478.303476343592, 15590.610234744223, 15637.296321665552, 840.2689659995842, 868.847951608466, 871.4292138649195, 891.9687810926716, 963.9662611808553, 8661.30709543235, 8826.338024648177, 8841.292696584258, 8865.689700860568, 9072.8639070414, 123434.0, 343738.0, 343842.0, 344038.0, 359896.0, 63271.050934236024, 64487.355126449074, 65587.0, 66194.66902665456, 66598.33401666018, 939.6241503398695, 955.8088382323563, 962.5957098018708, 982.8771403574553, 986.4377304936118, 14258.500952466615, 14440.350184241524, 14504.73045119325, 14676.70646587041, 14919.104853708812, 31070.689293106778, 31320.843395783788, 31682.207944801565, 31760.523592145673, 32156.83921580377, 39940.0, 42233.788831055645, 43001.13997719966, 43061.78469107635, 43503.78248108739, 7510.586917719578, 7578.431617628589, 7595.506292090997, 7714.190010049088, 7849.921500785147, 8072.636731346986, 10939.45302734876, 10956.890431095906, 11030.558777648805, 11083.334999900031, 9756.707298781048, 9969.40183588987, 10036.397816131055, 10079.899201007896, 10186.541605627617, 9896.208303335572, 10050.296479246383, 10246.333988290737, 10290.588376465157, 10314.174866010851, 5272.156454967187, 7153.964230178815, 9905.455199964072, 9979.301448898797, 10360.844587331045, 6849.657517124224, 7375.188729239672, 7495.138059123053, 7541.321281084729, 7608.0489938757655, 7462.8507429850015, 8234.752957411287, 9237.491937943209, 9415.105564971316, 9444.811103778024], "value": 7734.258156719971, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.7655736803429, 1449.3622805965374, 1569.9843001569982, 1726.197318247015, 1750.7023805952995, 6449.83875403114, 7299.343059124678, 7327.706891724325, 7588.582627955467, 7592.544447333157, 7357.3746231570385, 7390.297921697444, 7397.852042959137, 7474.028376311086, 7476.28975247352, 2156.24531414005, 2195.1768086967386, 2198.3844523533435, 2199.0, 2203.966940495886, 2156.1698745982753, 2173.4892300309416, 2208.7570367259586, 2208.8232941364654, 2212.623853944825, 2111.7043613894066, 2113.302610138658, 2124.6388114020656, 2125.4048866317457, 2133.434639820449, 2106.6734656128247, 2122.9044692988778, 2133.3599920024008, 2135.7864213578673, 2146.785321467856, 2109.915603375863, 2150.1721837092678, 2175.3256490487843, 2202.537467131904, 2208.017432242653, 7610.771676849703, 7624.466287359887, 7628.19903910087, 7687.308142267167, 7716.305532502101, 4472.686911916135, 4647.1170477609485, 4661.813527458898, 4664.673472856902, 4666.95333046672, 2815.8873645054173, 2859.5567687008547, 2987.686292939232, 3024.9848750756105, 3028.6819883912094, 920.093707697917, 959.2086528613852, 981.0728861226144, 989.0554520432969, 991.2020823237291, 10408.375497470177, 10415.114715249212, 10432.008959148869, 10447.47762611874, 10479.318844275098, 4042.292598795199, 4048.919021619551, 4119.629233369011, 4133.173365326947, 4239.215745087169, 8508.234258916727, 8528.658853645784, 8542.914570854336, 8544.871826922601, 8548.059713431518, 4482.39487669167, 4486.573775491323, 4498.437695288089, 4520.570545798144, 4525.796339164745, 3547.113221694576, 3997.8800635980965, 4084.8774536763945, 4091.631753142172, 4216.198922204771, 3450.723942084627, 3510.578730552299, 3514.4360759461792, 3533.876314328986, 3575.3564358415215, 1155.9595414160465, 1169.368540987874, 1184.5084290019718, 1189.6252680405644, 1192.379962419537, 824.9505029698238, 840.5965136734279, 843.304273973974, 851.9190676885686, 861.0485413617862, 4895.975520122448, 5088.847334579968, 5125.1287281162295, 5127.564282001045, 5231.3199284092825, 398.5476484190465, 404.11498817589387, 415.78171459983145, 419.47356068134906, 420.7349369896945, 3539.132912436418, 3551.5915669697797, 3595.676389124939, 3654.634536546324, 3662.9633703663153, 9195.586198620944, 9559.330846840654, 9670.129688328085, 9673.419594824332, 9682.56428460721, 9384.90615093854, 9442.38624489406, 9517.952410237904, 9522.571484283224, 9538.61845526185, 6728.125343705385, 7109.360157585842, 7236.384907282834, 7259.237780033126, 7309.305615966475, 5148.0, 5174.922376164285, 5186.688798672092, 5363.704996225245, 5389.676619402849, 8571.22858942698, 8623.655053797778, 8723.0, 8881.111888811067, 8881.555922203994, 8874.51190184546, 8894.73315800527, 9032.412893161923, 9054.049324820799, 9064.864027039468, 5840.561957853263, 6516.73933042692, 6746.0, 6747.831304217434, 6930.099087118642, 7081.044059051962, 7153.177384600837, 7174.354308112295, 7175.174854891754, 7193.892091618525, 6335.778247761306, 6554.377334153248, 6600.53796234259, 6660.134182556237, 6687.565308254948, 6254.342599211303, 6314.778982735582, 6359.17330747, 6382.0, 6411.6153030818305, 6139.048447490646, 6183.072539119168, 6207.16203312547, 6216.751329946752, 6234.220722409699, 4334.761588112684, 4457.375967364506, 4476.507584165674, 4482.215612267905, 4493.910121797611, 4429.2027435062, 4487.7980490878645, 4492.961392190866, 4498.392716983165, 4518.096380723934], "value": 3995.689366716078, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.36326212894636, 314.7922371234985, 315.070541901391, 318.0823324708216, 318.84376655438825, 4883.731394773286, 4967.776450059747, 4971.624970026372, 4983.700977941317, 4991.201407774757, 4859.975700121503, 4870.732109733972, 4894.119058569456, 4911.336969509115, 4914.950850491494, 3705.4812326274277, 3750.343689854278, 3868.6324799144036, 3875.6511913927743, 3882.7282090253693, 3888.2612303662354, 3889.658067966547, 3898.4542164097047, 3900.4149377593303, 3900.453936448885, 3857.864974725885, 3876.282887665777, 3881.922361552767, 3893.9875632335657, 3905.3751399776042, 3798.1264309209037, 3802.068493219151, 3862.5558060822946, 3863.884083477486, 3884.261990221877, 3438.793672379665, 3446.827658617084, 3452.602950660656, 3459.100633835196, 3464.7401444891734, 4703.365045718819, 4711.929321060187, 4717.386739723848, 4726.834560790356, 4733.479317275097, 4430.224710675619, 4442.711223770445, 4444.466664000308, 4445.177642136216, 4450.221211288012, 4934.6052315815, 5117.41149767774, 5130.666506677091, 5137.486251374833, 5152.381714194284, 3726.9254614907823, 3749.793761343125, 3766.642168993941, 3774.471573979645, 3784.489093972306, 5291.095205725974, 5308.991291654612, 5310.415854256029, 5352.330958630171, 5369.731513424314, 3497.632748561415, 3709.350863598859, 3730.198007428416, 3742.7567208131386, 3811.809409529568, 3758.2295629396453, 3773.9432958771586, 3776.339140650375, 3787.4318852172396, 3800.2969450651167, 4282.314829627245, 4293.291606884892, 4327.2643650579475, 4340.153670034313, 4358.956410435919, 4968.6025117990475, 5076.162433198555, 5124.180131178993, 5146.614003949719, 5190.247414125006, 1376.311844077961, 1390.3882291791579, 1392.484780631173, 1395.0304538345752, 1401.068289587413, 852.863541833316, 904.5432056811268, 918.545320066558, 948.4830767231875, 951.2627713522076, 4383.254846676073, 4532.70537415067, 4536.138133754576, 4558.521355257651, 4565.6119229865835, 5242.370915490165, 5247.9737601311745, 5265.262863199156, 5272.578193744491, 5287.894242115136, 4414.249577571821, 4497.437820272466, 4525.660575456854, 4526.977365113154, 4538.841140560131, 2985.6118704568266, 3013.246688327918, 3018.2303512604144, 3029.7576193904433, 3032.651245106797, 5290.65610735301, 5316.388615309289, 5320.201969704575, 5355.768173320081, 5364.544013758796, 5628.268325117709, 5762.740676669476, 5775.249217601685, 5824.796132135355, 5831.329397119301, 5325.733713314319, 5337.119375303109, 5343.812966546152, 5353.197020446964, 5367.570594352443, 5561.610687251854, 5599.496045355938, 5612.326520817528, 5635.605507614428, 5666.801661941812, 5304.840854774363, 5481.109017388994, 5487.4238204987905, 5490.0, 5501.092319767194, 5290.873118967058, 5299.258103865385, 5316.9468305318, 5318.867028324323, 5356.678599284055, 3903.082775547687, 3916.5300163980505, 3921.5882282378893, 3922.823472943667, 3928.0572662561353, 5426.782928682808, 5594.552435805207, 5603.131514615078, 5615.213870058114, 5624.634398764068, 5446.794048410242, 5450.264214331015, 5452.209429632601, 5477.068898287221, 5487.42382049895, 5296.470352964673, 5424.593155513431, 5425.647332923348, 5444.3194600674915, 5444.564434845282, 5289.761960711854, 5370.865728356823, 5371.865703357447, 5382.623216374816, 5408.810691625774, 4868.878278043077, 4947.9960615950595, 5180.974095129651, 5196.350456192976, 5450.781968721207, 5019.0, 5040.899182016413, 5048.167052436307, 5056.508330042573, 5061.443241243386], "value": 3976.1873281830667, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.9835004124897, 669.8158006548199, 713.0409599089224, 770.9845803083939, 781.4529829119617, 11695.473703683345, 11789.410529473513, 11861.169718119734, 12325.0, 12513.249205047703, 10466.372017678945, 10947.288426252288, 11531.654050378482, 11663.358515281656, 11671.241369310988, 781.9843603127948, 791.2759824760337, 795.6419611174995, 796.0, 796.3509739562268, 794.5788731972063, 800.3157300508069, 804.1435870797611, 804.9637766300501, 805.7582725182422, 839.3746658739248, 843.6288033265374, 845.3490812074699, 846.1876598465481, 853.2363534636496, 837.1795640272506, 839.1063517353998, 840.6553313141613, 841.1798496465927, 843.6541018182546, 609.8048624440181, 611.9296280927706, 614.0390289197436, 614.5912967876357, 617.1544983372808, 11333.546658133664, 11390.487428065757, 11408.486618102123, 11412.82880756781, 11448.0, 10151.64469243573, 10211.540480678388, 10316.948415257875, 10397.688069357931, 10661.84007239892, 8913.1086891311, 8984.46093234408, 9198.0, 9223.677171298972, 9272.350935434522, 3256.8697252110123, 3267.901962941092, 3279.4097062528735, 3304.273059926812, 3390.0338403555115, 37501.81249093764, 40633.79683101595, 41879.74360769182, 42068.78965605152, 44695.0, 9025.729228123168, 9225.12361325673, 9252.814943701089, 9331.06689331075, 9631.518424078768, 15107.4712385066, 15171.848281517265, 15316.081035137704, 15421.228938553028, 15426.922865385826, 6521.836954076186, 6614.7023383947835, 6706.53054286205, 6768.661566921733, 7023.8244043898285, 3643.4534819776713, 3704.5554533456157, 3748.475213470116, 3778.848846046127, 3843.0008197868196, 2814.746672799458, 2874.5688146777734, 2888.364559796841, 2892.971070289312, 2897.9420411592073, 513.9717315547681, 521.707843607581, 528.6959998001165, 528.6986417741928, 536.6109570561312, 557.6431084106175, 566.4675205306999, 577.4265127527538, 588.802751078385, 593.6289818863211, 7623.733169339046, 7820.296173344313, 8003.599820008976, 8061.234182752629, 8239.382046346429, 519.8180636777173, 561.3179986316645, 599.7091410665823, 600.3516202501288, 610.81370182094, 3632.654897784706, 3678.7608805427562, 3719.237556300952, 3740.9064773380337, 3747.887563373103, 54087.516960650915, 57146.0, 57180.42819571834, 57195.42804571984, 57805.710971444874, 46825.0, 48753.75623121862, 49116.50883491191, 49733.0, 49994.500054998985, 36030.459543106874, 45423.31865022027, 46567.0, 46689.0, 47562.0, 7721.845563088595, 7779.0, 7869.4884832488, 7891.131975482807, 8135.9186408135165, 30260.394792104475, 30404.087877363716, 30504.389912201186, 30536.083917482512, 31158.68841311558, 37156.0, 38115.80942095272, 40394.0, 40585.79707101446, 40862.59137408707, 9986.750331241778, 10084.54619542137, 10110.848337275094, 10154.086132248132, 10430.37417754937, 10904.0, 11242.94378528102, 11562.94218528902, 11638.88361116378, 11802.173847830569, 10361.0, 10414.479276036016, 10548.367097974146, 10618.893811061791, 10704.785904281714, 10355.223358248311, 10372.533236004247, 10456.424896630455, 10590.947045264724, 10609.628662996758, 10358.948205258925, 10445.9477702611, 10463.68608941733, 10683.145348372267, 10711.571537138427, 8696.956515217384, 8784.209421152127, 8851.645934162561, 8970.327225457986, 9168.770780730269, 8605.698800541952, 8616.0, 8634.956825215833, 8748.976289874676, 8800.207981281716], "value": 5773.962362908881, "unit": "score"}], "name": "dromaeo_css", "value": 6056.960332423568, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 115.0, 114.0, 114.0, 127.0, 116.0, 113.0, 114.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 137.0, 155.0, 196.0, 142.0, 167.0, 154.0, 133.0, 204.0, 134.0], "value": 157.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 174.0, 163.0, 163.0, 163.0, 165.0, 165.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 165.0, 74.0, 73.0, 77.0, 77.0, 160.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 143.0, 94.0, 95.0, 94.0, 151.0, 95.0, 94.0, 144.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 150.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 67.0, 66.0, 66.0, 87.0, 64.0, 65.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 80.0, 85.0, 81.0, 79.0, 80.0, 81.0, 89.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 135.0, 156.0, 137.0, 135.0, 135.0, 140.0, 246.0, 135.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 221.0, 218.0, 223.0, 217.0, 215.0, 219.0, 216.0, 219.0, 219.0], "value": 218.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 77.0, 75.0, 75.0, 74.0, 74.0, 74.0, 76.0], "value": 75.2, "unit": "score"}], "name": "kraken", "value": 1659.3000000000002, "alertThreshold": 2.0}]} 16:02:32 INFO - Return code: 0 16:02:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:02:32 ERROR - # TBPL SUCCESS # 16:02:32 INFO - Running post-action listener: _resource_record_post_action 16:02:32 INFO - Running post-run listener: _resource_record_post_run 16:02:33 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 445792256; Read time: 76; Write time: 655256 16:02:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 155250688; Read time: 0; Write time: 301604 16:02:33 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290541568; Read time: 76; Write time: 353652 16:02:33 INFO - Running post-run listener: _upload_blobber_files 16:02:33 INFO - Blob upload gear active. 16:02:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:02:33 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 16:02:33 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'] 16:02:33 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 16:02:33 INFO - (blobuploader) - INFO - Open directory for files ... 16:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:34 INFO - (blobuploader) - INFO - Done attempting. 16:02:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:02:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:02:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:35 INFO - (blobuploader) - INFO - Done attempting. 16:02:35 INFO - (blobuploader) - INFO - Iteration through files over. 16:02:35 INFO - Return code: 0 16:02:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:02:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:02:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3a1ea23b9460b9f591961b8906804edc19844a635ca00680c14ac3b971f158ff9d9e68c3e02ed6cbe5e5c3a7a54c7c2f06a68cb13b118e2121463d84ccedf4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8f8f44a30d81faba0154c54e69b5dfece7d67196f40730c2dbc25b41f4852e45ae27ec0dadc18f07767801829ed8358852441612e96ff28efd5219643804686"} 16:02:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:02:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:02:35 INFO - Contents: 16:02:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3a1ea23b9460b9f591961b8906804edc19844a635ca00680c14ac3b971f158ff9d9e68c3e02ed6cbe5e5c3a7a54c7c2f06a68cb13b118e2121463d84ccedf4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8f8f44a30d81faba0154c54e69b5dfece7d67196f40730c2dbc25b41f4852e45ae27ec0dadc18f07767801829ed8358852441612e96ff28efd5219643804686"} 16:02:35 INFO - Running post-run listener: copy_logs_to_upload_dir 16:02:35 INFO - Copying logs to upload dir... 16:02:35 INFO - mkdir: /builds/slave/test/build/upload/logs 16:02:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.093300 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-26 16:02:35.121018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:02:35.124169) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993 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/e3a1ea23b9460b9f591961b8906804edc19844a635ca00680c14ac3b971f158ff9d9e68c3e02ed6cbe5e5c3a7a54c7c2f06a68cb13b118e2121463d84ccedf4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8f8f44a30d81faba0154c54e69b5dfece7d67196f40730c2dbc25b41f4852e45ae27ec0dadc18f07767801829ed8358852441612e96ff28efd5219643804686"} build_url:https://queue.taskcluster.net/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/Bn88raIhSZuvvuJqIiUt4g/artifacts/public/build/firefox-49.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/e3a1ea23b9460b9f591961b8906804edc19844a635ca00680c14ac3b971f158ff9d9e68c3e02ed6cbe5e5c3a7a54c7c2f06a68cb13b118e2121463d84ccedf4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8f8f44a30d81faba0154c54e69b5dfece7d67196f40730c2dbc25b41f4852e45ae27ec0dadc18f07767801829ed8358852441612e96ff28efd5219643804686"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:02:35.149588) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:02:35.149953) ========= 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=5cf47e208febbcd81da23b2e0000026f-1461709841.632272-911542993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:02:35.233714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:02:35.234039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:02:35.234385) ========= ========= Total master_lag: 0.17 =========