builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1461120553.25 results: success (0) buildid: 20160419171636 builduid: e0f028363ffc46898a22c85626348447 revision: 7c79a69e49c4c0daad06331acc29c61d19cb3673 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:13.249920) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:13.250829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:13.251136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:13.280085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:13.280379) ========= 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=745a4373a2a16df560f216e000000264-1461112192.303179-881799550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 19:49:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2016-04-19 19:49:13 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104595 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:13.400279) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:13.400567) ========= 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=745a4373a2a16df560f216e000000264-1461112192.303179-881799550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022509 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:13.453793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 19:49:13.454187) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7c79a69e49c4c0daad06331acc29c61d19cb3673 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7c79a69e49c4c0daad06331acc29c61d19cb3673 --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=745a4373a2a16df560f216e000000264-1461112192.303179-881799550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 19:49:13,625 truncating revision to first 12 chars 2016-04-19 19:49:13,625 Setting DEBUG logging. 2016-04-19 19:49:13,625 attempt 1/10 2016-04-19 19:49:13,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7c79a69e49c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 19:49:14,310 unpacking tar archive at: mozilla-aurora-7c79a69e49c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.004096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 19:49:14.472382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:14.472700) ========= script_repo_revision: 7c79a69e49c4c0daad06331acc29c61d19cb3673 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:14.473114) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:14.473414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 19:49:14.483428) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-19 19:49:14.483860) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=745a4373a2a16df560f216e000000264-1461112192.303179-881799550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:49:14 INFO - MultiFileLogger online at 20160419 19:49:14 in /builds/slave/test 19:49:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:49:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:49:14 INFO - {'append_to_log': False, 19:49:14 INFO - 'base_work_dir': '/builds/slave/test', 19:49:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:49:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:49:14 INFO - 'branch': 'Mozilla-Aurora', 19:49:14 INFO - 'buildbot_json_path': 'buildprops.json', 19:49:14 INFO - 'config_files': ('talos/linux_config.py',), 19:49:14 INFO - 'default_actions': ('clobber', 19:49:14 INFO - 'read-buildbot-config', 19:49:14 INFO - 'download-and-extract', 19:49:14 INFO - 'populate-webroot', 19:49:14 INFO - 'create-virtualenv', 19:49:14 INFO - 'install', 19:49:14 INFO - 'run-tests'), 19:49:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:49:14 INFO - 'download_minidump_stackwalk': True, 19:49:14 INFO - 'download_symbols': 'ondemand', 19:49:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:49:14 INFO - 'tooltool.py': '/tools/tooltool.py', 19:49:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:49:14 INFO - '/tools/misc-python/virtualenv.py')}, 19:49:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:49:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:49:14 INFO - 'installer_path': 'installer.exe', 19:49:14 INFO - 'log_level': 'info', 19:49:14 INFO - 'log_name': 'talos', 19:49:14 INFO - 'log_to_console': True, 19:49:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:49:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:49:14 INFO - 'opt_config_files': (), 19:49:14 INFO - 'pip_index': False, 19:49:14 INFO - 'sps_profile': False, 19:49:14 INFO - 'sps_profile_interval': 0, 19:49:14 INFO - 'suite': 'dromaeojs-e10s', 19:49:14 INFO - 'system_bits': '32', 19:49:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:49:14 INFO - 'title': 'talos-linux64-ix-032', 19:49:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:49:14 INFO - 'use_talos_json': True, 19:49:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:49:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:49:14 INFO - 'work_dir': 'build'} 19:49:14 INFO - ##### 19:49:14 INFO - ##### Running clobber step. 19:49:14 INFO - ##### 19:49:14 INFO - Running pre-action listener: _resource_record_pre_action 19:49:14 INFO - Running main action method: clobber 19:49:14 INFO - rmtree: /builds/slave/test/build 19:49:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:49:15 INFO - Running post-action listener: _resource_record_post_action 19:49:15 INFO - ##### 19:49:15 INFO - ##### Running read-buildbot-config step. 19:49:15 INFO - ##### 19:49:15 INFO - Running pre-action listener: _resource_record_pre_action 19:49:15 INFO - Running main action method: read_buildbot_config 19:49:15 INFO - Using buildbot properties: 19:49:15 INFO - { 19:49:15 INFO - "project": "", 19:49:15 INFO - "product": "firefox", 19:49:15 INFO - "script_repo_revision": "production", 19:49:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:49:15 INFO - "repository": "", 19:49:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:49:15 INFO - "buildid": "20160419171636", 19:49:15 INFO - "pgo_build": "True", 19:49:15 INFO - "basedir": "/builds/slave/test", 19:49:15 INFO - "buildnumber": 308, 19:49:15 INFO - "slavename": "talos-linux64-ix-032", 19:49:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:49:15 INFO - "platform": "ubuntu64_hw", 19:49:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:49:15 INFO - "branch": "mozilla-aurora", 19:49:15 INFO - "repo_path": "releases/mozilla-aurora", 19:49:15 INFO - "revision": "7c79a69e49c4c0daad06331acc29c61d19cb3673", 19:49:15 INFO - "stage_platform": "linux64-pgo", 19:49:15 INFO - "builduid": "e0f028363ffc46898a22c85626348447", 19:49:15 INFO - "slavebuilddir": "test" 19:49:15 INFO - } 19:49:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 19:49:15 INFO - Running post-action listener: _resource_record_post_action 19:49:15 INFO - ##### 19:49:15 INFO - ##### Running download-and-extract step. 19:49:15 INFO - ##### 19:49:15 INFO - Running pre-action listener: _resource_record_pre_action 19:49:15 INFO - Running main action method: download_and_extract 19:49:15 INFO - mkdir: /builds/slave/test/build/tests 19:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:15 INFO - https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:49:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 19:49:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 19:49:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 19:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:49:23 INFO - Downloaded 1448 bytes. 19:49:23 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 19:49:23 INFO - Using the following test package requirements: 19:49:23 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 19:49:23 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:49:23 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:49:23 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:23 INFO - u'jsshell-linux-x86_64.zip'], 19:49:23 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:49:23 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 19:49:23 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:49:23 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:49:23 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:49:23 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 19:49:23 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:49:23 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:23 INFO - https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:49:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:49:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:49:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:49:39 INFO - Downloaded 23352405 bytes. 19:49:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:49:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:49:40 INFO - Return code: 0 19:49:40 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:49:40 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')]} 19:49:40 INFO - https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:49:42 INFO - Downloaded 23352405 bytes. 19:49:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:49:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:49:43 INFO - Return code: 0 19:49: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')]} 19:49:43 INFO - https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:49:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 19:49:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 19:49:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 19:49:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:49:44 INFO - Downloaded 10845168 bytes. 19:49:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:49:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:49:44 INFO - Return code: 0 19:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:44 INFO - https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:49:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 19:49:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 19:49:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 19:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:49:46 INFO - Downloaded 60592961 bytes. 19:49:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 19:49:46 INFO - mkdir: /builds/slave/test/properties 19:49:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:49:46 INFO - Writing to file /builds/slave/test/properties/build_url 19:49:46 INFO - Contents: 19:49:46 INFO - build_url:https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 19:49:47 INFO - Running post-action listener: _resource_record_post_action 19:49:47 INFO - Running post-action listener: set_extra_try_arguments 19:49:47 INFO - ##### 19:49:47 INFO - ##### Running populate-webroot step. 19:49:47 INFO - ##### 19:49:47 INFO - Running pre-action listener: _resource_record_pre_action 19:49:47 INFO - Running main action method: populate_webroot 19:49:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:49:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:49:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:49:47 INFO - '--tppagecycles', 19:49:47 INFO - '7'], 19:49:47 INFO - 'tests': ['tsvgm']}}, 19:49:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:49:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:49:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:49:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:49:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:49:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:49:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:47 INFO - 'talos_options': ['--e10s'], 19:49:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:47 INFO - 'tests': ['damp', 'tps']}, 19:49:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:47 INFO - 'talos_options': ['--e10s'], 19:49:47 INFO - 'tests': ['damp', 'tps']}, 19:49:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:49:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:49:47 INFO - 'other': {'tests': ['a11yr', 19:49:47 INFO - 'ts_paint', 19:49:47 INFO - 'tpaint', 19:49:47 INFO - 'sessionrestore', 19:49:47 INFO - 'sessionrestore_no_auto_restore', 19:49:47 INFO - 'tabpaint']}, 19:49:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:49:47 INFO - 'tests': ['a11yr', 19:49:47 INFO - 'ts_paint', 19:49:47 INFO - 'tpaint', 19:49:47 INFO - 'sessionrestore', 19:49:47 INFO - 'sessionrestore_no_auto_restore', 19:49:47 INFO - 'tabpaint']}, 19:49:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:49:47 INFO - 'tests': ['a11yr', 19:49:47 INFO - 'ts_paint', 19:49:47 INFO - 'tpaint', 19:49:47 INFO - 'sessionrestore', 19:49:47 INFO - 'sessionrestore_no_auto_restore', 19:49:47 INFO - 'tabpaint']}, 19:49:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:49:47 INFO - 'tests': ['a11yr', 19:49:47 INFO - 'ts_paint', 19:49:47 INFO - 'tpaint', 19:49:47 INFO - 'sessionrestore', 19:49:47 INFO - 'sessionrestore_no_auto_restore', 19:49:47 INFO - 'tabpaint']}, 19:49:47 INFO - 'other_l64': {'tests': ['a11yr', 19:49:47 INFO - 'ts_paint', 19:49:47 INFO - 'tpaint', 19:49:47 INFO - 'sessionrestore', 19:49:47 INFO - 'sessionrestore_no_auto_restore', 19:49:47 INFO - 'tabpaint']}, 19:49:47 INFO - 'other_nol64': {'tests': ['a11yr', 19:49:47 INFO - 'ts_paint', 19:49:47 INFO - 'tpaint', 19:49:47 INFO - 'sessionrestore', 19:49:47 INFO - 'sessionrestore_no_auto_restore', 19:49:47 INFO - 'tabpaint']}, 19:49:47 INFO - 'svgr': {'tests': ['tsvgx', 19:49:47 INFO - 'tsvgr_opacity', 19:49:47 INFO - 'tart', 19:49:47 INFO - 'tscrollx', 19:49:47 INFO - 'cart']}, 19:49:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:49:47 INFO - 'tests': ['tsvgx', 19:49:47 INFO - 'tsvgr_opacity', 19:49:47 INFO - 'tart', 19:49:47 INFO - 'tscrollx', 19:49:47 INFO - 'cart']}, 19:49:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:47 INFO - 'tests': ['tp5o']}, 19:49:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:47 INFO - 'talos_options': ['--e10s'], 19:49:47 INFO - 'tests': ['tp5o']}, 19:49:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:47 INFO - 'talos_options': ['--xperf_path', 19:49:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:47 INFO - 'tests': ['tp5n']}, 19:49:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:47 INFO - 'talos_options': ['--e10s', 19:49:47 INFO - '--xperf_path', 19:49:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:47 INFO - 'tests': ['tp5n']}}, 19:49:47 INFO - 'talos.zip': {'path': '', 19:49:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:49:47 INFO - Running post-action listener: _resource_record_post_action 19:49:47 INFO - ##### 19:49:47 INFO - ##### Running create-virtualenv step. 19:49:47 INFO - ##### 19:49:47 INFO - Running pre-action listener: _resource_record_pre_action 19:49:47 INFO - Running main action method: create_virtualenv 19:49:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:49:47 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 19:49:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:49:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:49:47 INFO - Using real prefix '/usr' 19:49:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:49:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:49:51 INFO - Installing pip.................done. 19:49:51 INFO - Return code: 0 19:49:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:51 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 0x7f08a02c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc160>, '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 0x1ecd060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd4f0>, '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': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', '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 19:49:51 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 19:49:51 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 19:49:51 INFO - Using env: {'DISPLAY': ':0', 19:49:51 INFO - 'HOME': '/home/cltbld', 19:49:51 INFO - 'LANG': 'en_US.UTF-8', 19:49:51 INFO - 'LANGUAGE': 'en_US:en', 19:49:51 INFO - 'LOGNAME': 'cltbld', 19:49:51 INFO - 'MAIL': '/var/mail/cltbld', 19:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:51 INFO - 'MOZ_NO_REMOTE': '1', 19:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:51 INFO - 'NO_EM_RESTART': '1', 19:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:51 INFO - 'PWD': '/builds/slave/test', 19:49:51 INFO - 'SHELL': '/bin/bash', 19:49:51 INFO - 'SHLVL': '1', 19:49:51 INFO - 'TERM': 'linux', 19:49:51 INFO - 'TMOUT': '86400', 19:49:51 INFO - 'USER': 'cltbld', 19:49:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', 19:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:51 INFO - '_': '/tools/buildbot/bin/python'} 19:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:51 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 19:49:51 INFO - Cleaning up... 19:49:51 INFO - Return code: 0 19:49:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:51 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 0x7f08a02c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc160>, '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 0x1ecd060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd4f0>, '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': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', '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 19:49:51 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 19:49:51 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 19:49:51 INFO - Using env: {'DISPLAY': ':0', 19:49:51 INFO - 'HOME': '/home/cltbld', 19:49:51 INFO - 'LANG': 'en_US.UTF-8', 19:49:51 INFO - 'LANGUAGE': 'en_US:en', 19:49:51 INFO - 'LOGNAME': 'cltbld', 19:49:51 INFO - 'MAIL': '/var/mail/cltbld', 19:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:51 INFO - 'MOZ_NO_REMOTE': '1', 19:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:51 INFO - 'NO_EM_RESTART': '1', 19:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:51 INFO - 'PWD': '/builds/slave/test', 19:49:51 INFO - 'SHELL': '/bin/bash', 19:49:51 INFO - 'SHLVL': '1', 19:49:51 INFO - 'TERM': 'linux', 19:49:51 INFO - 'TMOUT': '86400', 19:49:51 INFO - 'USER': 'cltbld', 19:49:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', 19:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:51 INFO - '_': '/tools/buildbot/bin/python'} 19:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:51 INFO - Downloading/unpacking psutil>=0.7.1 19:49:51 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 19:49:51 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 19:49:51 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 19:49:51 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 19:49:51 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 19:49:51 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 19:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:49:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:53 INFO - Installing collected packages: psutil 19:49:53 INFO - Running setup.py install for psutil 19:49:53 INFO - building 'psutil._psutil_linux' extension 19:49:53 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 19:49:54 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 19:49:54 INFO - building 'psutil._psutil_posix' extension 19:49:54 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 19:49:54 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 19:49:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:54 INFO - Successfully installed psutil 19:49:54 INFO - Cleaning up... 19:49:54 INFO - Return code: 0 19:49:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:49:54 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')]} 19:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:54 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')]} 19:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:54 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 0x7f08a02c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc160>, '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 0x1ecd060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd4f0>, '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': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', '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 19:49:54 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 19:49:54 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 19:49:54 INFO - Using env: {'DISPLAY': ':0', 19:49:54 INFO - 'HOME': '/home/cltbld', 19:49:54 INFO - 'LANG': 'en_US.UTF-8', 19:49:54 INFO - 'LANGUAGE': 'en_US:en', 19:49:54 INFO - 'LOGNAME': 'cltbld', 19:49:54 INFO - 'MAIL': '/var/mail/cltbld', 19:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:54 INFO - 'MOZ_NO_REMOTE': '1', 19:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:54 INFO - 'NO_EM_RESTART': '1', 19:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:54 INFO - 'PWD': '/builds/slave/test', 19:49:54 INFO - 'SHELL': '/bin/bash', 19:49:54 INFO - 'SHLVL': '1', 19:49:54 INFO - 'TERM': 'linux', 19:49:54 INFO - 'TMOUT': '86400', 19:49:54 INFO - 'USER': 'cltbld', 19:49:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', 19:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:54 INFO - '_': '/tools/buildbot/bin/python'} 19:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:49:54 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 19:49:54 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 19:49:54 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 19:49:54 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 19:49:54 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 19:49:54 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 19:49:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:49:56 INFO - Installing collected packages: mozsystemmonitor 19:49:56 INFO - Running setup.py install for mozsystemmonitor 19:49:58 INFO - Successfully installed mozsystemmonitor 19:49:58 INFO - Cleaning up... 19:49:58 INFO - Return code: 0 19:49:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f08a02c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc160>, '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 0x1ecd060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd4f0>, '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': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', '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 19:49:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:49:58 INFO - Using env: {'DISPLAY': ':0', 19:49:58 INFO - 'HOME': '/home/cltbld', 19:49:58 INFO - 'LANG': 'en_US.UTF-8', 19:49:58 INFO - 'LANGUAGE': 'en_US:en', 19:49:58 INFO - 'LOGNAME': 'cltbld', 19:49:58 INFO - 'MAIL': '/var/mail/cltbld', 19:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:58 INFO - 'MOZ_NO_REMOTE': '1', 19:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:58 INFO - 'NO_EM_RESTART': '1', 19:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:58 INFO - 'PWD': '/builds/slave/test', 19:49:58 INFO - 'SHELL': '/bin/bash', 19:49:58 INFO - 'SHLVL': '1', 19:49:58 INFO - 'TERM': 'linux', 19:49:58 INFO - 'TMOUT': '86400', 19:49:58 INFO - 'USER': 'cltbld', 19:49:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', 19:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:58 INFO - '_': '/tools/buildbot/bin/python'} 19:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:58 INFO - Downloading/unpacking blobuploader==1.2.4 19:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:00 INFO - Downloading blobuploader-1.2.4.tar.gz 19:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:50:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:50:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:01 INFO - Downloading docopt-0.6.1.tar.gz 19:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:50:01 INFO - Installing collected packages: blobuploader, requests, docopt 19:50:01 INFO - Running setup.py install for blobuploader 19:50:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:50:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:50:01 INFO - Running setup.py install for requests 19:50:01 INFO - Running setup.py install for docopt 19:50:01 INFO - Successfully installed blobuploader requests docopt 19:50:01 INFO - Cleaning up... 19:50:01 INFO - Return code: 0 19:50:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:01 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 0x7f08a02c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc160>, '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 0x1ecd060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd4f0>, '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': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', '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 19:50:01 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 19:50:01 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 19:50:01 INFO - Using env: {'DISPLAY': ':0', 19:50:01 INFO - 'HOME': '/home/cltbld', 19:50:01 INFO - 'LANG': 'en_US.UTF-8', 19:50:01 INFO - 'LANGUAGE': 'en_US:en', 19:50:01 INFO - 'LOGNAME': 'cltbld', 19:50:01 INFO - 'MAIL': '/var/mail/cltbld', 19:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:01 INFO - 'MOZ_NO_REMOTE': '1', 19:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:01 INFO - 'NO_EM_RESTART': '1', 19:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:01 INFO - 'PWD': '/builds/slave/test', 19:50:01 INFO - 'SHELL': '/bin/bash', 19:50:01 INFO - 'SHLVL': '1', 19:50:01 INFO - 'TERM': 'linux', 19:50:01 INFO - 'TMOUT': '86400', 19:50:01 INFO - 'USER': 'cltbld', 19:50:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', 19:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:01 INFO - '_': '/tools/buildbot/bin/python'} 19:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:50:01 INFO - Running setup.py (path:/tmp/pip-FIYqvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:50:02 INFO - Running setup.py (path:/tmp/pip-Cpmu8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:50:02 INFO - Running setup.py (path:/tmp/pip-ZK03Dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:50:02 INFO - Running setup.py (path:/tmp/pip-r8LK7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:50:02 INFO - Running setup.py (path:/tmp/pip-Mjq0S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:50:02 INFO - Running setup.py (path:/tmp/pip-xo5HpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:50:02 INFO - Running setup.py (path:/tmp/pip-fT0YZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:50:02 INFO - Running setup.py (path:/tmp/pip-GE2bni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:50:02 INFO - Running setup.py (path:/tmp/pip-mXhYhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:50:02 INFO - Running setup.py (path:/tmp/pip-4bYt1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:50:02 INFO - Running setup.py (path:/tmp/pip-1mtnYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:50:02 INFO - Running setup.py (path:/tmp/pip-vj0Vkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:50:02 INFO - Running setup.py (path:/tmp/pip-UkN9Yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:50:02 INFO - Running setup.py (path:/tmp/pip-FtmqHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:02 INFO - Running setup.py (path:/tmp/pip-Geyl8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:50:03 INFO - Running setup.py (path:/tmp/pip-TBz1JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:50:03 INFO - Running setup.py (path:/tmp/pip-gwC1La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:50:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:50:03 INFO - Running setup.py install for manifestparser 19:50:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:50:03 INFO - Running setup.py install for mozcrash 19:50:03 INFO - Running setup.py install for mozdebug 19:50:03 INFO - Running setup.py install for mozdevice 19:50:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:50:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:50:03 INFO - Running setup.py install for mozfile 19:50:03 INFO - Running setup.py install for mozhttpd 19:50:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:50:03 INFO - Running setup.py install for mozinfo 19:50:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:50:03 INFO - Running setup.py install for mozInstall 19:50:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:50:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:50:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:50:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:50:03 INFO - Running setup.py install for mozleak 19:50:04 INFO - Running setup.py install for mozlog 19:50:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:50:04 INFO - Running setup.py install for moznetwork 19:50:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:50:04 INFO - Running setup.py install for mozprocess 19:50:04 INFO - Running setup.py install for mozprofile 19:50:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:50:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:50:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:50:04 INFO - Running setup.py install for mozrunner 19:50:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:50:04 INFO - Running setup.py install for mozscreenshot 19:50:04 INFO - Running setup.py install for moztest 19:50:04 INFO - Running setup.py install for mozversion 19:50:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:50:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:50:04 INFO - Cleaning up... 19:50:04 INFO - Return code: 0 19:50:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:50: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')]} 19:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50: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')]} 19:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:04 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 0x7f08a02c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc160>, '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 0x1ecd060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd4f0>, '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': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', '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 19:50:04 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 19:50:04 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 19:50:04 INFO - Using env: {'DISPLAY': ':0', 19:50:04 INFO - 'HOME': '/home/cltbld', 19:50:04 INFO - 'LANG': 'en_US.UTF-8', 19:50:04 INFO - 'LANGUAGE': 'en_US:en', 19:50:04 INFO - 'LOGNAME': 'cltbld', 19:50:04 INFO - 'MAIL': '/var/mail/cltbld', 19:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:04 INFO - 'MOZ_NO_REMOTE': '1', 19:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:04 INFO - 'NO_EM_RESTART': '1', 19:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:04 INFO - 'PWD': '/builds/slave/test', 19:50:04 INFO - 'SHELL': '/bin/bash', 19:50:04 INFO - 'SHLVL': '1', 19:50:04 INFO - 'TERM': 'linux', 19:50:04 INFO - 'TMOUT': '86400', 19:50:04 INFO - 'USER': 'cltbld', 19:50:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', 19:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:04 INFO - '_': '/tools/buildbot/bin/python'} 19:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:50:05 INFO - Running setup.py (path:/tmp/pip-_l_1QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:50:05 INFO - Running setup.py (path:/tmp/pip-FTw_Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:50:05 INFO - Running setup.py (path:/tmp/pip-KiEaFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:50:05 INFO - Running setup.py (path:/tmp/pip-XbrMTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:50:05 INFO - Running setup.py (path:/tmp/pip-ANXvKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:50:05 INFO - Running setup.py (path:/tmp/pip-7YfXmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:50:05 INFO - Running setup.py (path:/tmp/pip-fimxaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:50:05 INFO - Running setup.py (path:/tmp/pip-t4RZNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:50:05 INFO - Running setup.py (path:/tmp/pip-a4lWU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:50:05 INFO - Running setup.py (path:/tmp/pip-Y_7NJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:50:05 INFO - Running setup.py (path:/tmp/pip-TbSxU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:50:05 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)) 19:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:50:05 INFO - Running setup.py (path:/tmp/pip-9M8oCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:50:06 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)) 19:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:50:06 INFO - Running setup.py (path:/tmp/pip-kGv4f6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:50:06 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)) 19:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:50:06 INFO - Running setup.py (path:/tmp/pip-nr5Zni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:50:06 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)) 19:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:06 INFO - Running setup.py (path:/tmp/pip-JhMhY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:06 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)) 19:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:50:06 INFO - Running setup.py (path:/tmp/pip-BxEHLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:50:06 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)) 19:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:50:06 INFO - Running setup.py (path:/tmp/pip-A3gNcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:50:06 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)) 19:50:06 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)) 19:50:06 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)) 19:50:06 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)) 19:50:06 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)) 19:50:06 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)) 19:50:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:08 INFO - Downloading blessings-1.6.tar.gz 19:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:50:08 INFO - Installing collected packages: blessings 19:50:08 INFO - Running setup.py install for blessings 19:50:08 INFO - Successfully installed blessings 19:50:08 INFO - Cleaning up... 19:50:08 INFO - Return code: 0 19:50:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:50:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:50:08 INFO - Reading from file tmpfile_stdout 19:50:08 INFO - Current package versions: 19:50:08 INFO - argparse == 1.2.1 19:50:08 INFO - blessings == 1.6 19:50:08 INFO - blobuploader == 1.2.4 19:50:08 INFO - docopt == 0.6.1 19:50:08 INFO - manifestparser == 1.1 19:50:08 INFO - mozInstall == 1.12 19:50:08 INFO - mozcrash == 0.17 19:50:08 INFO - mozdebug == 0.1 19:50:08 INFO - mozdevice == 0.48 19:50:08 INFO - mozfile == 1.2 19:50:08 INFO - mozhttpd == 0.7 19:50:08 INFO - mozinfo == 0.9 19:50:08 INFO - mozleak == 0.1 19:50:08 INFO - mozlog == 3.1 19:50:08 INFO - moznetwork == 0.27 19:50:08 INFO - mozprocess == 0.22 19:50:08 INFO - mozprofile == 0.28 19:50:08 INFO - mozrunner == 6.11 19:50:08 INFO - mozscreenshot == 0.1 19:50:08 INFO - mozsystemmonitor == 0.0 19:50:08 INFO - moztest == 0.7 19:50:08 INFO - mozversion == 1.4 19:50:08 INFO - psutil == 3.1.1 19:50:08 INFO - requests == 1.2.3 19:50:08 INFO - wsgiref == 0.1.2 19:50:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:08 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 0x7f08a02c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc160>, '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 0x1ecd060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd4f0>, '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': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', '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 19:50:08 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 19:50:08 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 19:50:08 INFO - Using env: {'DISPLAY': ':0', 19:50:08 INFO - 'HOME': '/home/cltbld', 19:50:08 INFO - 'LANG': 'en_US.UTF-8', 19:50:08 INFO - 'LANGUAGE': 'en_US:en', 19:50:08 INFO - 'LOGNAME': 'cltbld', 19:50:08 INFO - 'MAIL': '/var/mail/cltbld', 19:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:08 INFO - 'MOZ_NO_REMOTE': '1', 19:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:08 INFO - 'NO_EM_RESTART': '1', 19:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:08 INFO - 'PWD': '/builds/slave/test', 19:50:08 INFO - 'SHELL': '/bin/bash', 19:50:08 INFO - 'SHLVL': '1', 19:50:08 INFO - 'TERM': 'linux', 19:50:08 INFO - 'TMOUT': '86400', 19:50:08 INFO - 'USER': 'cltbld', 19:50:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', 19:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:08 INFO - '_': '/tools/buildbot/bin/python'} 19:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 INFO - Cleaning up... 19:50:08 INFO - Return code: 0 19:50:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:08 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 0x7f08a02c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc160>, '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 0x1ecd060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd4f0>, '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': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', '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 19:50:08 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 19:50:08 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 19:50:08 INFO - Using env: {'DISPLAY': ':0', 19:50:08 INFO - 'HOME': '/home/cltbld', 19:50:08 INFO - 'LANG': 'en_US.UTF-8', 19:50:08 INFO - 'LANGUAGE': 'en_US:en', 19:50:08 INFO - 'LOGNAME': 'cltbld', 19:50:08 INFO - 'MAIL': '/var/mail/cltbld', 19:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:08 INFO - 'MOZ_NO_REMOTE': '1', 19:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:08 INFO - 'NO_EM_RESTART': '1', 19:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:08 INFO - 'PWD': '/builds/slave/test', 19:50:08 INFO - 'SHELL': '/bin/bash', 19:50:08 INFO - 'SHLVL': '1', 19:50:08 INFO - 'TERM': 'linux', 19:50:08 INFO - 'TMOUT': '86400', 19:50:08 INFO - 'USER': 'cltbld', 19:50:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', 19:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:08 INFO - '_': '/tools/buildbot/bin/python'} 19:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:09 INFO - Downloading/unpacking jsonschema 19:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:50:11 INFO - Downloading/unpacking functools32 (from jsonschema) 19:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:11 INFO - Downloading functools32-3.2.3-2.tar.gz 19:50:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:50:11 INFO - warning: no files found matching '*.txt' 19:50:11 INFO - no previously-included directories found matching 'build' 19:50:11 INFO - no previously-included directories found matching 'dist' 19:50:11 INFO - no previously-included directories found matching '.git*' 19:50:11 INFO - Installing collected packages: jsonschema, functools32 19:50:11 INFO - Running setup.py install for functools32 19:50:11 INFO - warning: no files found matching '*.txt' 19:50:11 INFO - no previously-included directories found matching 'build' 19:50:11 INFO - no previously-included directories found matching 'dist' 19:50:11 INFO - no previously-included directories found matching '.git*' 19:50:11 INFO - Successfully installed jsonschema functools32 19:50:11 INFO - Cleaning up... 19:50:11 INFO - Return code: 0 19:50:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08a02c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc160>, '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 0x1ecd060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd4f0>, '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': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', '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 19:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:50:11 INFO - Using env: {'DISPLAY': ':0', 19:50:11 INFO - 'HOME': '/home/cltbld', 19:50:11 INFO - 'LANG': 'en_US.UTF-8', 19:50:11 INFO - 'LANGUAGE': 'en_US:en', 19:50:11 INFO - 'LOGNAME': 'cltbld', 19:50:11 INFO - 'MAIL': '/var/mail/cltbld', 19:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:11 INFO - 'MOZ_NO_REMOTE': '1', 19:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:11 INFO - 'NO_EM_RESTART': '1', 19:50:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:11 INFO - 'PWD': '/builds/slave/test', 19:50:11 INFO - 'SHELL': '/bin/bash', 19:50:11 INFO - 'SHLVL': '1', 19:50:11 INFO - 'TERM': 'linux', 19:50:11 INFO - 'TMOUT': '86400', 19:50:11 INFO - 'USER': 'cltbld', 19:50:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', 19:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:11 INFO - '_': '/tools/buildbot/bin/python'} 19:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:11 INFO - Downloading/unpacking flake8 19:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:50:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:50: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 19:50: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 19:50: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 19:50: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 19:50: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 19:50: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 19:50:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:50:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:50: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 19:50: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 19:50: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 19:50: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 19:50: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 19:50: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 19:50:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:50: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 19:50: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 19:50: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 19:50: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 19:50: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 19:50: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 19:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:50:14 INFO - no previously-included directories found matching 'docs/_build' 19:50:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:50:14 INFO - Running setup.py install for pep8 19:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:50:14 INFO - no previously-included directories found matching 'docs/_build' 19:50:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:50:14 INFO - Cleaning up... 19:50:14 INFO - Return code: 0 19:50:14 INFO - Running post-action listener: _resource_record_post_action 19:50:14 INFO - Running post-action listener: _start_resource_monitoring 19:50:14 INFO - Starting resource monitoring. 19:50:14 INFO - ##### 19:50:14 INFO - ##### Running install step. 19:50:14 INFO - ##### 19:50:14 INFO - Running pre-action listener: _resource_record_pre_action 19:50:14 INFO - Running main action method: install 19:50:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:50:14 INFO - Reading from file tmpfile_stdout 19:50:14 INFO - Detecting whether we're running mozinstall >=1.0... 19:50:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:50:14 INFO - Reading from file tmpfile_stdout 19:50:14 INFO - Output received: 19:50:14 INFO - Usage: mozinstall [options] installer 19:50:14 INFO - Options: 19:50:14 INFO - -h, --help show this help message and exit 19:50:14 INFO - -d DEST, --destination=DEST 19:50:14 INFO - Directory to install application into. [default: 19:50:14 INFO - "/builds/slave/test"] 19:50:14 INFO - --app=APP Application being installed. [default: firefox] 19:50:14 INFO - mkdir: /builds/slave/test/build/application 19:50:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:50:29 INFO - Reading from file tmpfile_stdout 19:50:29 INFO - Output received: 19:50:29 INFO - /builds/slave/test/build/application/firefox/firefox 19:50:29 INFO - Running post-action listener: _resource_record_post_action 19:50:29 INFO - ##### 19:50:29 INFO - ##### Running run-tests step. 19:50:29 INFO - ##### 19:50:29 INFO - Running pre-action listener: _resource_record_pre_action 19:50:29 INFO - Running main action method: run_tests 19:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:50:29 INFO - Python 2.7.3 19:50:29 INFO - Return code: 0 19:50:29 INFO - grabbing minidump binary from tooltool 19:50: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')]} 19:50:29 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 0x1ecc160>, '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 0x1ecd060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:50:29 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 19:50:29 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 19:50:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:50:30 INFO - Return code: 0 19:50:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:50:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:50:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:50:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:50:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:50:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:50:31 INFO - Return code: 0 19:50:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 19:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 19:50:31 INFO - Using env: {'DISPLAY': ':0', 19:50:31 INFO - 'HOME': '/home/cltbld', 19:50:31 INFO - 'LANG': 'en_US.UTF-8', 19:50:31 INFO - 'LANGUAGE': 'en_US:en', 19:50:31 INFO - 'LOGNAME': 'cltbld', 19:50:31 INFO - 'MAIL': '/var/mail/cltbld', 19:50:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:50:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:31 INFO - 'MOZ_NO_REMOTE': '1', 19:50:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:31 INFO - 'NO_EM_RESTART': '1', 19:50:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:31 INFO - 'PWD': '/builds/slave/test', 19:50:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:50:31 INFO - 'SHELL': '/bin/bash', 19:50:31 INFO - 'SHLVL': '1', 19:50:31 INFO - 'TERM': 'linux', 19:50:31 INFO - 'TMOUT': '86400', 19:50:31 INFO - 'USER': 'cltbld', 19:50:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461112192.303179-881799550', 19:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:31 INFO - '_': '/tools/buildbot/bin/python'} 19:50:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 19:50:31 INFO - mozversion application_buildid: 20160419171636 19:50:31 INFO - mozversion application_changeset: 7c79a69e49c4c0daad06331acc29c61d19cb3673 19:50:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:50:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:50:31 INFO - mozversion application_name: Firefox 19:50:31 INFO - mozversion application_remotingname: firefox-dev 19:50:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:50:31 INFO - mozversion application_vendor: Mozilla 19:50:31 INFO - mozversion application_version: 47.0a2 19:50:31 INFO - mozversion platform_buildid: 20160419171636 19:50:31 INFO - mozversion platform_changeset: 7c79a69e49c4c0daad06331acc29c61d19cb3673 19:50:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:50:31 INFO - mozversion platform_version: 47.0a2 19:50:31 INFO - using testdate: 1461120631 19:50:31 INFO - actual date: 1461120631 19:50:31 INFO - starting webserver on 'localhost:39798' 19:50:31 INFO - SUITE-START | Running 2 tests 19:50:31 INFO - TEST-START | dromaeo_css 19:50:31 INFO - operating with platform_type : linux_ 19:50:31 INFO - Initialising browser for dromaeo_css test... 19:50:31 INFO - TEST-INFO | started process 5356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf88TFF/profile http://localhost:39798/getInfo.html) 19:50:35 INFO - PROCESS | 5356 | 19:50:35 INFO - PROCESS | 5356 | (process:5433): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:50:36 INFO - PROCESS | 5356 | __metrics Screen width/height:1600/1200 19:50:36 INFO - PROCESS | 5356 | colorDepth:24 19:50:36 INFO - PROCESS | 5356 | Browser inner width/height: 1024/697 19:50:36 INFO - PROCESS | 5356 | __metrics 19:50:37 ERROR - PROCESS | 5356 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:50:38 INFO - TEST-INFO | 5356: exit 0 19:50:38 INFO - Browser initialized. 19:50:38 INFO - Running cycle 1/1 for dromaeo_css test... 19:50:38 INFO - TEST-INFO | started process 5484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf88TFF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:40 INFO - PROCESS | 5484 | 19:50:40 INFO - PROCESS | 5484 | (process:5551): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:50:50 INFO - PROCESS | 5484 | RSS: Main: 151293952 19:50:50 INFO - PROCESS | 5484 | 19:51:40 INFO - PROCESS | 5484 | 1461120700010 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] 19:53:48 INFO - PROCESS | 5484 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39798/tests/dromaeo/cssquery-ext.html) 19:53:49 INFO - PROCESS | 5484 | RSS: Main: 154746880 19:53:49 INFO - PROCESS | 5484 | 19:56:51 INFO - PROCESS | 5484 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-ext.html (next: http://localhost:39798/tests/dromaeo/cssquery-jquery.html) 19:56:51 INFO - PROCESS | 5484 | RSS: Main: 153591808 19:56:51 INFO - PROCESS | 5484 | 19:59:53 INFO - PROCESS | 5484 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39798/tests/dromaeo/cssquery-mootools.html) 19:59:53 INFO - PROCESS | 5484 | RSS: Main: 152760320 19:59:53 INFO - PROCESS | 5484 | 20:02:55 INFO - PROCESS | 5484 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39798/tests/dromaeo/cssquery-prototype.html) 20:02:56 INFO - PROCESS | 5484 | RSS: Main: 152510464 20:02:56 INFO - PROCESS | 5484 | 20:05:58 INFO - PROCESS | 5484 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39798/tests/dromaeo/cssquery-yui.html) 20:05:59 INFO - PROCESS | 5484 | RSS: Main: 154132480 20:05:59 INFO - PROCESS | 5484 | 20:09:01 INFO - PROCESS | 5484 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-yui.html (next: http://localhost:39798/tests/dromaeo/cssquery-dojo.html) 20:09:01 INFO - PROCESS | 5484 | RSS: Main: 155652096 20:09:01 INFO - PROCESS | 5484 | 20:09:01 INFO - PROCESS | 5484 | __start_tp_report 20:09:01 INFO - PROCESS | 5484 | _x_x_mozilla_page_load 20:09:01 INFO - PROCESS | 5484 | _x_x_mozilla_page_load_details 20:09:01 INFO - PROCESS | 5484 | |i|pagename|runs| 20:09:01 INFO - PROCESS | 5484 | |0;dojo.html;3299.752518561108;3370.882019129331;3384.8984530464095;3387.0516255448483;3440.294739578385;5512.33851937767;5518.834434966952;5520.613557051008;5525.11598144297;5530.668159910409;5502.614816962814;5596.104623260279;5603.327600687923;5604.551635869131;5606.747696353664;5028.472010438906;5076.923846142311;5157.174852023677;5160.303359046518;5248.632595718302;4982.725950072744;5040.067587496325;5073.416557095926;5164.509371609691;5240.109181439165;5110.488951104897;5125.410577783547;5179.015986962484;5186.170212765958;5194.220866869962;5123.820666276681;5146.253793200002;5150.201718733602;5153.149730294497;5162.277281180638;4907.533784290486;4976.62675299354;5092.9236061459105;5102.387713474407;5116.258142569307;5378.300820893259;5388.353397592314;5401.756920938528;5403.351597808288;5416.133418653036;6007.879842403127;6013.849653758647;6060.666663333515;6064.514838812885;6070.2108725865355;5930.733117009701;5965.045592705146;5970.611910225864;5982.880342393128;6036.758529658809;5542.251796007527;5579.776808927638;5581.609287349846;5583.469570390806;5592.077307244341;5950.642961422329;6106.938930610726;6108.267007959073;6115.4190351916495;6118.010103775246;5949.9107513387335;5996.700164991733;5999.730012149464;6003.129546215774;6016.789412370634;6065.787697430569;6066.817995460143;6071.453569178795;6072.089186622042;6078.817635470943;5807.94192058074;5960.731767070492;6010.939890601126;6045.697715114226;6051.4553690168095;5987.790427335022;6019.187409699722;6046.969765151146;6050.48570871472;6076.422739839708;4551.226291530448;4585.564371384713;4587.990642058741;4599.540045995441;4622.768861556976;3951.1110000249714;4052.7365721228025;4121.093359460914;4135.813888375031;4177.164567086534;5575.219469274305;5726.341470730836;5751.223584815996;5774.04728219839;5795.7971470999155;5945.10823376497;6016.097585362143;6018.969905150534;6032.638041717511;6037.335893051761;5594.748236329375;5639.887202255932;5668.319801623831;5723.59934804568;5748.13777933305;5073.720945348041;5135.897282054413;5137.922931156036;5144.202648589475;5148.330717006766;6172.938270617236;6173.47525460332;6173.876522469525;6176.289726681399;6186.133941248138;5822.243108395882;5983.9401605983385;6021.307549631761;6071.51427885777;6101.938980610137;6155.132012955123;6192.040233763774;6201.131841542278;6202.751889924352;6216.844578885383;5950.077737950624;5957.880842383215;5967.045272756512;5980.461758441761;6002.639841609517;5852.4440178183;5931.436513531207;6018.909716354346;6021;6065.514758819196;5865.354810970875;5882.970585147047;5903.616264942937;5907;5913.408659134052;5694.857628559319;5865.560082993878;5893.970530147493;5924.259467566554;5924.674142922008;5770.711464426846;5831.271091113611;5868.911966320423;5877.500412464989;5882.441168089024;5874.765009399576;5922.940770592239;5929.6145750526075;5937.91093133612;5945.583809133319;5616.241807356118;5780.710964451677;5786.42135786418;5788.768449261982;5798.82603521895 20:09:01 INFO - PROCESS | 5484 | |1;ext.html;527.6280222443178;563.6195567991606;576.5790972590006;590.8020813027634;594;31757.841210793944;41113.79443102784;41278.793606031926;41417.58582414175;41508.584914150924;44949.77525112378;45384.3192352115;45569;45769;46063.539364606346;8856.247218986378;9202.309826762987;9204.907950920506;9219.815603687955;9230.07699230075;9014.68448604299;9137.954310228439;9138;9151.771205719877;9345.392549484295;9248.26013918885;9358.672446464376;9379.24966002718;9379.906200937972;9427.622895084189;9246.35275530713;9298;9316.767080823;9322.953385233099;9325.067493250688;9141.177294043568;9314.487703176323;9316.208122309612;9318.767030824216;9331.953340233324;45173.77413112946;45616.3157552637;45707.77146114282;45748;45801.31298030532;3802.9619703802887;3819.1216020315205;3847.2690188864026;4183.5398106208295;4714.952850471485;32805;33107.50338744921;33841.6615833841;33897.21234483409;34923.65076349255;4167.1040726244;4188.204241194163;4232.957670423287;4250.128723611683;4285.550017248175;228758;229602;230006.9999999983;230859;230943;67804.32195677981;68265;68410.65794670995;68526.31473685299;68551.3144868555;77732;78717.60641196757;78902.60548697335;79245.20754792493;79418.20581794223;18816.62366752657;18962.241510339707;19036.90481547611;19161.808381916002;19238.80761192398;14500;14659.120452772868;14696.706065878836;14775.187364695044;14818.555443336718;22688.773112268667;23035.654465183037;23122.3063308101;23140.53718925612;24191;8597.957010214908;8625;8736.606852691644;8763.123687631314;8763.298936085097;1070.314998401024;1072.3726619927274;1096.627146770102;1134.234391785558;1201.9879801201876;29741.85129074341;30021.39957200844;30240.395192096476;30899.8455007728;31132.066038018897;1096.6490722968574;1115.2583531951325;1142.2232881640398;1170.6488053583892;1245.8318127052912;15953.760693589606;16058.518244452685;16102;16236.350545978265;16280.267387967333;344198;547455;552500;552622;559772;58846.41153588409;59057.704711477025;59074.34165462565;59381.70309148427;59718;1520.4678362573231;1550.7363748162838;1569.5919061043983;1569.6389830339085;1573.402107199257;29985.700142998292;30841.69158308388;33061.00816975495;33191.17022074467;33211.50182747309;52126.21810672919;52973;53199;53252.201216982554;53252.73373633107;322415;330095;331161;334696;336622;48429.75785121193;48503.51496485131;48931.75534122306;49251;49670.25494617656;53106.20340694815;53170.468295316554;53767.193492098435;53887.19169212543;54248.45751542434;44283.33574996313;44696.776516117214;44927.775361122985;45359.54640453553;46654.30018549792;43557.56442435662;44233;44436.55563444324;45059;45284.54715452803;42071.7896410516;43019.78490107655;43105.56894431016;43170;43234;37765.62234377621;39036.21927561376;39146;39791.80104099461;40003.199936000536;29317;29508.78576312129;29595;29661.25846853846;29903.252418689706 20:09:01 INFO - PROCESS | 5484 | |2;jquery.html;380.5471488928176;396.5320921312853;398.5197836606889;400.41739269363063;415.86276528745515;16930.830691693078;17444.389446369365;17495.562610934732;18992.905035474836;19617.11722972466;16522.339106435727;16787.32850685971;17485.7377139343;17875.284988600473;17886.821131788678;5056.721880296592;5228.712420816853;5446.7276636168035;5546.084895992157;5955.374685657986;5852.12218167274;5922.318933322658;5927.110933360009;5931.169636250928;5948.732307046172;5576.442355764431;5798.246227990356;5851.15158302046;5856.443637854419;5919.763209471616;5792.073268277077;5836.883262334751;5851.1223316502865;5859.384764599698;5892.381299963485;5280.498352656491;5297.390800058004;5319.5478384337375;5327.493888080626;5528.198411230389;13894.652633684138;13947;13960.581182564438;14050.789238161437;14072.507462238773;2387.6418537219556;2449.6448015037718;2529.620556916459;2551.961720574193;2933.5159698649695;10137.189024877993;10172.44051577163;10270.7432314192;10629.255952083357;10644.41455719935;1857.7956424793263;1913.3303343829687;1941.6505029094758;1961.0292905011968;1961.3429501117143;66187;68009.55923526105;68592.3140768591;70454.29545704529;70769.99999999949;10387.480625968672;10545.31455455393;10709.892901071045;10733.946330268454;10895.400752958505;14878.92560537212;15006.174660393564;15049.548513544392;15211.771823422658;15264;8035.316998055114;8210.425270231146;8263.297619702273;8289.668413263402;8371.832563348698;7974.122846486882;8054.637541310655;8084.595770211466;8194.344452443791;8268.09051004389;4747.786349614275;4754.310624959361;4829.541193586674;4884;4913.533214344631;1946.6204090202557;1969.8325642320276;1996.1217064491577;2015.9899200503903;2026.6149431608242;923.9029901860342;1000.9949950250202;1021.8824835143905;1091.5591419326413;1133.3086817041763;17240;17350.56623584395;17613.471595852145;17768.11159442023;18143.637127257643;990.5047476261869;1002.478711070254;1015.1320620869051;1051.6529545250048;1059.3220338983058;8125.674973001013;9870.950645246729;10216.693499195037;10232.386056836614;10444.947775261075;421132;425617;430481;430968;431979;73621.2637873625;77733.61133194297;78503.60748196223;80353.19646803457;80700.59649701713;1084.3764835219781;1103.7240689827383;1145.169751929861;1153.7000379901285;1165.5570883064552;15689.98015129013;15722.13528255957;15915.840841591436;16032;16173.191340433166;29122.417551649272;33630.66369336275;34077;35666;36591.08522286964;40031;43794.34308485311;43878;43971;44071.77964110159;8561.785955351166;8624.655013799378;8684.261837743863;8880.86678699807;8990.145936136056;11855.55167074551;13684.52104176349;13842.238676872868;13879.583612491642;14191.64520886986;11510;11570.652880413601;12057.457414416196;12204.084693647834;12357.567485137977;11010.614628487965;11187;11696.35670038122;11789.115816313983;12283.69290767738;12054.337011464453;12230.388480576114;12257.816132757838;12622.242665439735;12666.683332916751;8085.878711819445;8431.53626550521;8806.779830504289;8843.778905527155;9288.256939444964;11113.388763618079;11718.23831450953;11971.760564788481;12017.879821202027;12125.393730313626 20:09:01 INFO - PROCESS | 5484 | |3;mootools.html;1570.6230504678877;1594.8644365228954;1882.9246830126795;1944.3389247655793;1995.2218634732449;7044.753433629824;8235.752927412172;8548.230659240668;8748.25639820616;8766.298696104312;8450.408471406989;8508.319334453245;8546.40175187737;8599.140085991397;8611.483311001328;2452.6566280720667;2474.653548503211;2474.8515089094712;2481.3548477395916;2490.340059884132;2443.898247507151;2468.049800826677;2473.1591258971944;2492.9252122436355;2494.4387512809562;2445.5842506773893;2449.4121410861353;2471.036295844613;2472.2706801493514;2474;2474.4679893822736;2490.7882829959476;2501.6622755927897;2567.7817385522253;2568.036986130201;2523.8485690858606;2531.1014589820716;2531.7847982921476;2542.1992072497287;2545.2491515002935;8720.956395217983;8729.34529910253;8746.86879696805;8802.823943521094;8828.382013259074;5271.894562108775;5386.111291636876;5413.729313534308;5417.945820541823;5431.891362172734;3446.3796516627;3492.7380446466364;3532.1346270163717;3571.8214089295693;3605.2428989911887;1216.2033867816594;1220.4020030185234;1234.0127897681818;1235.0860363331071;1283.4930202570026;11853.940730296294;11881.643550693492;11885.524579016828;11889.464974076187;11943.22369046018;4611;4629.560191781776;4760.880977975578;4765.11845308619;4800;10082;10100.797984040279;10103.393796372242;10107.69676909694;10126.240531960133;5343.893122137535;5358.303420555303;5372.946270537323;5376.73116344189;5386.515213630713;4031.415444760552;4732;4817.156997525419;4828.806847726122;4859.416869975555;3987.641112299907;3996.660283875903;4034.6772258219858;4077.327241005201;4084.673226141961;1327.4093028602372;1340.6916409225737;1342.3020029584561;1346.3941226447942;1363.9045266831424;1131.3833960491552;1176.717587778944;1410.4076287959083;1426.5078547900957;1447.7683570628649;8100.392470564731;8151.8777218341775;8236.588170591447;8237.670493180205;8257.05043919945;1231.1812644591246;1233.3709807997986;1240.3798100949525;1272.4094881398253;1272.6691060324383;6463.385978332051;6519.250286217146;6534.150560427209;6563.048357988065;6594.736210551524;10212.285140040125;10521.52653130611;10571.2600117991;10667.626633067961;10741.838872416763;10528.157747380192;10608.416537090534;10616.84074738864;10630.73423164427;10765.677029688964;8203.794905127419;8293.170682931779;8363.038250601137;8363.790905227417;8390.958045209734;7930.572496950605;7939.801504962422;7980.720674776355;8043.597820108854;8109;9246.815063698823;9428.10433008863;9477.952610236905;9570.856437153308;9602.08780165883;9625.229981601595;9725.562349694139;9747.805043899225;9937.055979681918;9941.900580994097;6033.276006879202;6760.256371799;6935.167779866449;7346.6326683666675;7455.776326710207;8183.427160098736;8234.958825205835;8259.297959673495;8275;8284.130166332689;7295.635218239173;7482.850342993219;7496.100467943882;7620.123685776207;7624.5425274483705;7204.53170543913;7325.267473252845;7334.853302933805;7369.115706115301;7428.2571742825285;7672.846543068996;7848.725294614661;7860.410469214946;7861.410394220342;7880.17258187882;6992.510524263253;7008.824779380557;7017.859642807218;7044.15470143586;7319.743808966874;7181.497295189287;7196.172440169447;7203.71185152588;7211.927880721126;7257.600831954293 20:09:01 INFO - PROCESS | 5484 | |4;prototype.html;329.6703296703297;333.8831409006848;355.46325049175744;355.58041511017007;363.26257696875336;6423.421892029716;6439.710213040413;6442.806715798528;6447;6450.193725784277;6393.616383017023;6397.10440538325;6397.200349956255;6406.487481001521;6407;4809.90380192396;4830.782614782343;4922.089413458521;4927.975360123194;4960.67755595887;4910.582600478946;4918.581920536759;4938.654294199408;4940.851774446773;4961.925571116418;4881.048195601859;4884.047610715912;4888.437829649582;4898.436679781835;4901.09329773993;4891.828785992491;4920.7785649645675;4922.532359425867;4930.408350997867;4960.404751429815;4378.474583050022;4380.102079073782;4388.166248412791;4389.846355377546;4391.8682439526865;5934.258217722785;6062.666553339564;6117.724702388403;6119.2350956130485;6129.969350153266;5740.856478588027;5770.307563092414;5771.913421298684;5776.59563830532;5778.393268706767;6766.391024807742;6815.079964204819;6820.181578210597;6823.829404264883;6841.828954276133;4800.975995120002;4818.638602104821;4829.734364609945;4833.154198015369;4841.612670986313;7045.612491312976;7066.858662826715;7112.857742845114;7121.181064177582;7138.072050633385;4723.173444647173;4839.491853355417;4874.53691899269;4961.032598643302;4962.131626965267;5081.822136225214;5085.1355269604255;5089.312942752755;5094.7962081516325;5094.847154585368;5758.395368486333;5779.913301300484;5780.479756821822;5793.391693872167;5829.47534721877;6875.243723190445;6877.2091209510545;6879;6881.243063263037;6885.311468853075;1775.4496106207116;1790.4181141129186;1790.9373171938919;1791.9910400448175;1792.345793785285;1171.6777886081225;1192.928424294545;1193.7731830952264;1197.4192516629428;1199.4542483170137;6397.904031439532;6410.230772307353;6438.424630147978;6454.870902581922;6490.610563366213;6924.619145947021;6988.545744526691;6992.0910281663055;6999.580025198505;7006.684699188549;6464.450521705708;6480.902786458207;6496.772612958618;6508.869822603616;6518.771842985473;3677.1174918019483;3751.531058617673;3754.981225093857;3758.4362345648374;3796.5064541609413;7189.532680375759;7191.964040179871;7193.496455248082;7200.639968001684;7222.927770722331;7098.432125429953;7135.89296160558;7142.178649455275;7152.284771522806;7155.141383034069;7160.749373771893;7160.854263317949;7168.211496735355;7181.497295189287;7183.5330703504105;6775.457963363017;6971.3028697129885;6977;6978.860422791414;6995.195552511526;6802.251752307341;6853.897191542231;6857.348551887562;6884.345987131214;6884.380405763505;7126.28737126304;7154.964225178841;7176.892346614909;7185.748498802517;7198.316159964795;4960.429550601582;4961.627877909244;4971.477994810492;4979.427365852828;4985.750712464434;6914.9308506914285;6963.721451141898;6975.895361569682;7103.396211321889;7128.857422851617;6834.384905358542;6843.965780171067;6863;6863.862722745617;6871.14110736158;6883.174019117738;6898.620575868375;6898.965505172442;6905.827354316182;6909.170899492093;6652.301508341555;6661.933380666132;6695.12963314766;6699;6718.697658605277;6709.698063587248;6904.585724856524;6947.93052069493;6948.062011628567;6962.547434416747;6632;6638.502112341497;6642.833929151617;6687.331266873273;6720.260771315054 20:09:01 INFO - PROCESS | 5484 | |5;yui.html;823.2056065896409;898.2275243290769;898.9685361012366;909.1590278991931;912.479886464715;14869.553913382602;15093.698126037472;15097.773533397009;15142.62143446413;15173.468928587488;13001.284929328884;14323.427062917497;14406.135631862096;14418.423263069464;14438.783418248735;922.6540047482194;940.5391358234484;944.773254418938;945.9385139965915;947.6114792934898;954.88063992001;957.1098878043417;960.8798900137483;961.500019989605;966.2415004221652;985.3250523391499;998.101708462386;1001.7595777013537;1001.9398836069859;1004.4375149916034;979.990200097997;982.9606815727362;989.5992123190119;994.1500017485018;995.0845222395413;727.0548287226637;731.0569365518475;731.5574077682978;731.9634018299064;735.5586648011204;14962.102273863604;14981.176035318053;15011;15046.924765376103;15047.172405517693;14293.213873236968;14600.34298456572;14644.560663180122;14807.555773326818;14810.259487025605;10317.174626029899;10412.79174416515;10421.27051106423;10475.371477711362;10529.736756581071;3894.2016886538477;3926.960730392688;3958.920821583581;3967.504061992251;3974.4038394240806;50251.74874125642;52150.99999999962;52383.73808130973;52546.47453525492;53051.469485305424;11184.44077796107;11228.326300422;11388.316700997966;11537.077033837273;11728.296302221894;20318.898405508175;20351.796482035286;20363;20400.489987750425;20422.08100635475;8498.957505212435;8539.615717292736;8587.355948303777;8620.741377758677;8637.827243455222;4709.458412282563;4719.292106184032;4721.102990431807;4850.320955066293;4870.8782280442565;3532.3641744485726;3560.430331147004;3561.465780133001;3565.2512972275595;3571.160777217352;679.3104998426601;687.5702685821361;692.650211643117;693.9306069393122;707.6532499075416;629.9842503937347;739.8631253218172;742.3133601418774;743.5761615878897;750.5009168902618;9458.668946586975;9484.668036618823;9569.808603827885;9572.952135239419;9810.803783924424;610.5603965145089;636.2492259134266;658.868226354731;743.8136172804368;746.2649290448903;4114.382842573638;4439.689221754511;4474.798634061475;4477.865664030084;4632.189366860786;58114.418855811746;61809.38190618126;64760;65318.346816532176;65479;54521.45478545243;55354.446455534926;55728.164077538866;57827;57965;50861.745691272044;51814.22278665823;52133.478665213624;52134.73932630388;53318.46681533135;9345.719628411158;9350.719478415658;9407.200387966826;9507.762305942406;9634.181094607036;37855.62144378521;37983.240335193696;38062.80968595139;39480.60519394769;39500.604993949695;44314.3352849714;50018.249726254864;50028;50320;51183;11765.764684706086;12983.156094853804;13003.219806811621;13122.737545249232;13268;13692.31538423055;14007.929960350133;14163.716725665223;14273.14361138335;14290.28548572588;12640.115191936477;12779;12867.292298923649;12910.419031143809;12951.870481295067;12673.746525069262;12710.300933448749;13140.27728474943;13246.668833279246;13478.595642130751;12724.363781811058;12887.742245154857;12996.545120920722;13130.671733206746;13424.530141445002;10574.15406767472;10598.788024239626;10675.306105103144;11039.558417663204;11064.17018723615;10439.739006524898;11051.557937682725;11123.221374503708;11177.776444471228;11218.270812397168 20:09:01 INFO - PROCESS | 5484 | __end_tp_report 20:09:01 INFO - PROCESS | 5484 | __start_cc_report 20:09:01 INFO - PROCESS | 5484 | _x_x_mozilla_cycle_collect,344 20:09:01 INFO - PROCESS | 5484 | __end_cc_report 20:09:01 INFO - PROCESS | 5484 | __startTimestamp1461121741451__endTimestamp 20:09:01 INFO - PROCESS | 5484 | 20:09:01 INFO - PROCESS | 5484 | ------- Summary: start ------- 20:09:01 INFO - PROCESS | 5484 | Number of tests: 6 20:09:01 INFO - PROCESS | 5484 | 20:09:01 INFO - PROCESS | 5484 | [#0] dojo.html Cycles:165 Average:5576.43 Median:5807.94 stddev:622.52 (10.7%) stddev-sans-first:598.26 20:09:01 INFO - PROCESS | 5484 | Values: 3299.8 3370.9 3384.9 3387.1 3440.3 5512.3 5518.8 5520.6 5525.1 5530.7 5502.6 5596.1 5603.3 5604.6 5606.7 5028.5 5076.9 5157.2 5160.3 5248.6 4982.7 5040.1 5073.4 5164.5 5240.1 5110.5 5125.4 5179.0 5186.2 5194.2 5123.8 5146.3 5150.2 5153.1 5162.3 4907.5 4976.6 5092.9 5102.4 5116.3 5378.3 5388.4 5401.8 5403.4 5416.1 6007.9 6013.8 6060.7 6064.5 6070.2 5930.7 5965.0 5970.6 5982.9 6036.8 5542.3 5579.8 5581.6 5583.5 5592.1 5950.6 6106.9 6108.3 6115.4 6118.0 5949.9 5996.7 5999.7 6003.1 6016.8 6065.8 6066.8 6071.5 6072.1 6078.8 5807.9 5960.7 6010.9 6045.7 6051.5 5987.8 6019.2 6047.0 6050.5 6076.4 4551.2 4585.6 4588.0 4599.5 4622.8 3951.1 4052.7 4121.1 4135.8 4177.2 5575.2 5726.3 5751.2 5774.0 5795.8 5945.1 6016.1 6019.0 6032.6 6037.3 5594.7 5639.9 5668.3 5723.6 5748.1 5073.7 5135.9 5137.9 5144.2 5148.3 6172.9 6173.5 6173.9 6176.3 6186.1 5822.2 5983.9 6021.3 6071.5 6101.9 6155.1 6192.0 6201.1 6202.8 6216.8 5950.1 5957.9 5967.0 5980.5 6002.6 5852.4 5931.4 6018.9 6021.0 6065.5 5865.4 5883.0 5903.6 5907.0 5913.4 5694.9 5865.6 5894.0 5924.3 5924.7 5770.7 5831.3 5868.9 5877.5 5882.4 5874.8 5922.9 5929.6 5937.9 5945.6 5616.2 5780.7 5786.4 5788.8 5798.8 20:09:01 INFO - PROCESS | 5484 | 20:09:01 INFO - PROCESS | 5484 | [#1] ext.html Cycles:180 Average:55640.95 Median:43895.28 stddev:100412.03 (228.8%) stddev-sans-first:100608.44 20:09:01 INFO - PROCESS | 5484 | Values: 527.6 563.6 576.6 590.8 594.0 31757.8 41113.8 41278.8 41417.6 41508.6 44949.8 45384.3 45569.0 45769.0 46063.5 8856.2 9202.3 9204.9 9219.8 9230.1 9014.7 9138.0 9138.0 9151.8 9345.4 9248.3 9358.7 9379.2 9379.9 9427.6 9246.4 9298.0 9316.8 9323.0 9325.1 9141.2 9314.5 9316.2 9318.8 9332.0 45173.8 45616.3 45707.8 45748.0 45801.3 3803.0 3819.1 3847.3 4183.5 4715.0 32805.0 33107.5 33841.7 33897.2 34923.7 4167.1 4188.2 4233.0 4250.1 4285.6 228758.0 229602.0 230007.0 230859.0 230943.0 67804.3 68265.0 68410.7 68526.3 68551.3 77732.0 78717.6 78902.6 79245.2 79418.2 18816.6 18962.2 19036.9 19161.8 19238.8 14500.0 14659.1 14696.7 14775.2 14818.6 22688.8 23035.7 23122.3 23140.5 24191.0 8598.0 8625.0 8736.6 8763.1 8763.3 1070.3 1072.4 1096.6 1134.2 1202.0 29741.9 30021.4 30240.4 30899.8 31132.1 1096.6 1115.3 1142.2 1170.6 1245.8 15953.8 16058.5 16102.0 16236.4 16280.3 344198.0 547455.0 552500.0 552622.0 559772.0 58846.4 59057.7 59074.3 59381.7 59718.0 1520.5 1550.7 1569.6 1569.6 1573.4 29985.7 30841.7 33061.0 33191.2 33211.5 52126.2 52973.0 53199.0 53252.2 53252.7 322415.0 330095.0 331161.0 334696.0 336622.0 48429.8 48503.5 48931.8 49251.0 49670.3 53106.2 53170.5 53767.2 53887.2 54248.5 44283.3 44696.8 44927.8 45359.5 46654.3 43557.6 44233.0 44436.6 45059.0 45284.5 42071.8 43019.8 43105.6 43170.0 43234.0 37765.6 39036.2 39146.0 39791.8 40003.2 29317.0 29508.8 29595.0 29661.3 29903.3 20:09:01 INFO - PROCESS | 5484 | 20:09:01 INFO - PROCESS | 5484 | [#2] jquery.html Cycles:180 Average:25528.48 Median:2207.13 stddev:70277.40 (3184.1%) stddev-sans-first:70449.18 20:09:01 INFO - PROCESS | 5484 | Values: 380.5 396.5 398.5 400.4 415.9 16930.8 17444.4 17495.6 18992.9 19617.1 16522.3 16787.3 17485.7 17875.3 17886.8 5056.7 5228.7 5446.7 5546.1 5955.4 5852.1 5922.3 5927.1 5931.2 5948.7 5576.4 5798.2 5851.2 5856.4 5919.8 5792.1 5836.9 5851.1 5859.4 5892.4 5280.5 5297.4 5319.5 5327.5 5528.2 13894.7 13947.0 13960.6 14050.8 14072.5 2387.6 2449.6 2529.6 2552.0 2933.5 10137.2 10172.4 10270.7 10629.3 10644.4 1857.8 1913.3 1941.7 1961.0 1961.3 66187.0 68009.6 68592.3 70454.3 70770.0 10387.5 10545.3 10709.9 10733.9 10895.4 14878.9 15006.2 15049.5 15211.8 15264.0 8035.3 8210.4 8263.3 8289.7 8371.8 7974.1 8054.6 8084.6 8194.3 8268.1 4747.8 4754.3 4829.5 4884.0 4913.5 1946.6 1969.8 1996.1 2016.0 2026.6 923.9 1001.0 1021.9 1091.6 1133.3 17240.0 17350.6 17613.5 17768.1 18143.6 990.5 1002.5 1015.1 1051.7 1059.3 8125.7 9871.0 10216.7 10232.4 10444.9 421132.0 425617.0 430481.0 430968.0 431979.0 73621.3 77733.6 78503.6 80353.2 80700.6 1084.4 1103.7 1145.2 1153.7 1165.6 15690.0 15722.1 15915.8 16032.0 16173.2 29122.4 33630.7 34077.0 35666.0 36591.1 40031.0 43794.3 43878.0 43971.0 44071.8 8561.8 8624.7 8684.3 8880.9 8990.1 11855.6 13684.5 13842.2 13879.6 14191.6 11510.0 11570.7 12057.5 12204.1 12357.6 11010.6 11187.0 11696.4 11789.1 12283.7 12054.3 12230.4 12257.8 12622.2 12666.7 8085.9 8431.5 8806.8 8843.8 9288.3 11113.4 11718.2 11971.8 12017.9 12125.4 20:09:01 INFO - PROCESS | 5484 | 20:09:01 INFO - PROCESS | 5484 | [#3] mootools.html Cycles:180 Average:6062.85 Median:5307.89 stddev:3138.68 (59.1%) stddev-sans-first:3129.33 20:09:01 INFO - PROCESS | 5484 | Values: 1570.6 1594.9 1882.9 1944.3 1995.2 7044.8 8235.8 8548.2 8748.3 8766.3 8450.4 8508.3 8546.4 8599.1 8611.5 2452.7 2474.7 2474.9 2481.4 2490.3 2443.9 2468.0 2473.2 2492.9 2494.4 2445.6 2449.4 2471.0 2472.3 2474.0 2474.5 2490.8 2501.7 2567.8 2568.0 2523.8 2531.1 2531.8 2542.2 2545.2 8721.0 8729.3 8746.9 8802.8 8828.4 5271.9 5386.1 5413.7 5417.9 5431.9 3446.4 3492.7 3532.1 3571.8 3605.2 1216.2 1220.4 1234.0 1235.1 1283.5 11853.9 11881.6 11885.5 11889.5 11943.2 4611.0 4629.6 4760.9 4765.1 4800.0 10082.0 10100.8 10103.4 10107.7 10126.2 5343.9 5358.3 5372.9 5376.7 5386.5 4031.4 4732.0 4817.2 4828.8 4859.4 3987.6 3996.7 4034.7 4077.3 4084.7 1327.4 1340.7 1342.3 1346.4 1363.9 1131.4 1176.7 1410.4 1426.5 1447.8 8100.4 8151.9 8236.6 8237.7 8257.1 1231.2 1233.4 1240.4 1272.4 1272.7 6463.4 6519.3 6534.2 6563.0 6594.7 10212.3 10521.5 10571.3 10667.6 10741.8 10528.2 10608.4 10616.8 10630.7 10765.7 8203.8 8293.2 8363.0 8363.8 8391.0 7930.6 7939.8 7980.7 8043.6 8109.0 9246.8 9428.1 9478.0 9570.9 9602.1 9625.2 9725.6 9747.8 9937.1 9941.9 6033.3 6760.3 6935.2 7346.6 7455.8 8183.4 8235.0 8259.3 8275.0 8284.1 7295.6 7482.9 7496.1 7620.1 7624.5 7204.5 7325.3 7334.9 7369.1 7428.3 7672.8 7848.7 7860.4 7861.4 7880.2 6992.5 7008.8 7017.9 7044.2 7319.7 7181.5 7196.2 7203.7 7211.9 7257.6 20:09:01 INFO - PROCESS | 5484 | 20:09:01 INFO - PROCESS | 5484 | [#4] prototype.html Cycles:180 Average:5708.90 Median:6444.90 stddev:1693.38 (26.3%) stddev-sans-first:1649.29 20:09:01 INFO - PROCESS | 5484 | Values: 329.7 333.9 355.5 355.6 363.3 6423.4 6439.7 6442.8 6447.0 6450.2 6393.6 6397.1 6397.2 6406.5 6407.0 4809.9 4830.8 4922.1 4928.0 4960.7 4910.6 4918.6 4938.7 4940.9 4961.9 4881.0 4884.0 4888.4 4898.4 4901.1 4891.8 4920.8 4922.5 4930.4 4960.4 4378.5 4380.1 4388.2 4389.8 4391.9 5934.3 6062.7 6117.7 6119.2 6130.0 5740.9 5770.3 5771.9 5776.6 5778.4 6766.4 6815.1 6820.2 6823.8 6841.8 4801.0 4818.6 4829.7 4833.2 4841.6 7045.6 7066.9 7112.9 7121.2 7138.1 4723.2 4839.5 4874.5 4961.0 4962.1 5081.8 5085.1 5089.3 5094.8 5094.8 5758.4 5779.9 5780.5 5793.4 5829.5 6875.2 6877.2 6879.0 6881.2 6885.3 1775.4 1790.4 1790.9 1792.0 1792.3 1171.7 1192.9 1193.8 1197.4 1199.5 6397.9 6410.2 6438.4 6454.9 6490.6 6924.6 6988.5 6992.1 6999.6 7006.7 6464.5 6480.9 6496.8 6508.9 6518.8 3677.1 3751.5 3755.0 3758.4 3796.5 7189.5 7192.0 7193.5 7200.6 7222.9 7098.4 7135.9 7142.2 7152.3 7155.1 7160.7 7160.9 7168.2 7181.5 7183.5 6775.5 6971.3 6977.0 6978.9 6995.2 6802.3 6853.9 6857.3 6884.3 6884.4 7126.3 7155.0 7176.9 7185.7 7198.3 4960.4 4961.6 4971.5 4979.4 4985.8 6914.9 6963.7 6975.9 7103.4 7128.9 6834.4 6844.0 6863.0 6863.9 6871.1 6883.2 6898.6 6899.0 6905.8 6909.2 6652.3 6661.9 6695.1 6699.0 6718.7 6709.7 6904.6 6947.9 6948.1 6962.5 6632.0 6638.5 6642.8 6687.3 6720.3 20:09:01 INFO - PROCESS | 5484 | 20:09:01 INFO - PROCESS | 5484 | [#5] yui.html Cycles:180 Average:15328.68 Median:4457.24 stddev:17523.62 (393.1%) stddev-sans-first:17538.92 20:09:01 INFO - PROCESS | 5484 | Values: 823.2 898.2 899.0 909.2 912.5 14869.6 15093.7 15097.8 15142.6 15173.5 13001.3 14323.4 14406.1 14418.4 14438.8 922.7 940.5 944.8 945.9 947.6 954.9 957.1 960.9 961.5 966.2 985.3 998.1 1001.8 1001.9 1004.4 980.0 983.0 989.6 994.2 995.1 727.1 731.1 731.6 732.0 735.6 14962.1 14981.2 15011.0 15046.9 15047.2 14293.2 14600.3 14644.6 14807.6 14810.3 10317.2 10412.8 10421.3 10475.4 10529.7 3894.2 3927.0 3958.9 3967.5 3974.4 50251.7 52151.0 52383.7 52546.5 53051.5 11184.4 11228.3 11388.3 11537.1 11728.3 20318.9 20351.8 20363.0 20400.5 20422.1 8499.0 8539.6 8587.4 8620.7 8637.8 4709.5 4719.3 4721.1 4850.3 4870.9 3532.4 3560.4 3561.5 3565.3 3571.2 679.3 687.6 692.7 693.9 707.7 630.0 739.9 742.3 743.6 750.5 9458.7 9484.7 9569.8 9573.0 9810.8 610.6 636.2 658.9 743.8 746.3 4114.4 4439.7 4474.8 4477.9 4632.2 58114.4 61809.4 64760.0 65318.3 65479.0 54521.5 55354.4 55728.2 57827.0 57965.0 50861.7 51814.2 52133.5 52134.7 53318.5 9345.7 9350.7 9407.2 9507.8 9634.2 37855.6 37983.2 38062.8 39480.6 39500.6 44314.3 50018.2 50028.0 50320.0 51183.0 11765.8 12983.2 13003.2 13122.7 13268.0 13692.3 14007.9 14163.7 14273.1 14290.3 12640.1 12779.0 12867.3 12910.4 12951.9 12673.7 12710.3 13140.3 13246.7 13478.6 12724.4 12887.7 12996.5 13130.7 13424.5 10574.2 10598.8 10675.3 11039.6 11064.2 10439.7 11051.6 11123.2 11177.8 11218.3 20:09:01 INFO - PROCESS | 5484 | -------- Summary: end -------- 20:09:01 INFO - PROCESS | 5484 | 20:09:02 INFO - TEST-INFO | 5484: exit 0 20:09:02 INFO - TEST-OK | dromaeo_css | took 1110906ms 20:09:02 INFO - TEST-START | kraken 20:09:02 INFO - operating with platform_type : linux_ 20:09:02 INFO - Initialising browser for kraken test... 20:09:02 INFO - TEST-INFO | started process 5726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk1Tumk/profile http://localhost:39798/getInfo.html) 20:09:05 INFO - PROCESS | 5726 | 20:09:05 INFO - PROCESS | 5726 | (process:5804): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:09:06 INFO - PROCESS | 5726 | __metrics Screen width/height:1600/1200 20:09:06 INFO - PROCESS | 5726 | colorDepth:24 20:09:06 INFO - PROCESS | 5726 | Browser inner width/height: 1024/697 20:09:06 INFO - PROCESS | 5726 | __metrics 20:09:07 ERROR - PROCESS | 5726 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 20:09:08 INFO - TEST-INFO | 5726: exit 0 20:09:08 INFO - Browser initialized. 20:09:08 INFO - Running cycle 1/1 for kraken test... 20:09:08 INFO - TEST-INFO | started process 5855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk1Tumk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:10 INFO - PROCESS | 5855 | 20:09:10 INFO - PROCESS | 5855 | (process:5924): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:09:20 INFO - PROCESS | 5855 | RSS: Main: 151326720 20:09:20 INFO - PROCESS | 5855 | 20:09:22 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39798/tests/kraken/driver.html?testName=audio-beat-detection) 20:09:23 INFO - PROCESS | 5855 | RSS: Main: 155926528 20:09:23 INFO - PROCESS | 5855 | 20:09:26 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39798/tests/kraken/driver.html?testName=audio-dft) 20:09:26 INFO - PROCESS | 5855 | RSS: Main: 156622848 20:09:26 INFO - PROCESS | 5855 | 20:09:29 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39798/tests/kraken/driver.html?testName=audio-fft) 20:09:30 INFO - PROCESS | 5855 | RSS: Main: 156479488 20:09:30 INFO - PROCESS | 5855 | 20:09:32 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39798/tests/kraken/driver.html?testName=audio-oscillator) 20:09:32 INFO - PROCESS | 5855 | RSS: Main: 156508160 20:09:32 INFO - PROCESS | 5855 | 20:09:35 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39798/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:09:35 INFO - PROCESS | 5855 | RSS: Main: 156532736 20:09:35 INFO - PROCESS | 5855 | 20:09:38 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39798/tests/kraken/driver.html?testName=imaging-darkroom) 20:09:39 INFO - PROCESS | 5855 | RSS: Main: 156368896 20:09:39 INFO - PROCESS | 5855 | 20:09:42 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39798/tests/kraken/driver.html?testName=imaging-desaturate) 20:09:43 INFO - PROCESS | 5855 | RSS: Main: 156839936 20:09:43 INFO - PROCESS | 5855 | 20:09:46 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39798/tests/kraken/driver.html?testName=json-parse-financial) 20:09:46 INFO - PROCESS | 5855 | RSS: Main: 156606464 20:09:46 INFO - PROCESS | 5855 | 20:09:48 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39798/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:09:48 INFO - PROCESS | 5855 | RSS: Main: 156643328 20:09:48 INFO - PROCESS | 5855 | 20:09:50 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:09:51 INFO - PROCESS | 5855 | RSS: Main: 157446144 20:09:51 INFO - PROCESS | 5855 | 20:09:53 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:09:53 INFO - PROCESS | 5855 | RSS: Main: 157151232 20:09:53 INFO - PROCESS | 5855 | 20:09:56 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:09:57 INFO - PROCESS | 5855 | RSS: Main: 157036544 20:09:57 INFO - PROCESS | 5855 | 20:09:59 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:10:00 INFO - PROCESS | 5855 | RSS: Main: 157749248 20:10:00 INFO - PROCESS | 5855 | 20:10:01 INFO - PROCESS | 5855 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39798/tests/kraken/driver.html?testName=ai-astar) 20:10:02 INFO - PROCESS | 5855 | RSS: Main: 158552064 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | __start_tp_report 20:10:02 INFO - PROCESS | 5855 | _x_x_mozilla_page_load 20:10:02 INFO - PROCESS | 5855 | _x_x_mozilla_page_load_details 20:10:02 INFO - PROCESS | 5855 | |i|pagename|runs| 20:10:02 INFO - PROCESS | 5855 | |0;ai-astar;111;104;111;110;109;121;110;110;111;110 20:10:02 INFO - PROCESS | 5855 | |1;audio-beat-detection;158;132;167;179;128;156;163;127;180;127 20:10:02 INFO - PROCESS | 5855 | |2;audio-dft;162;163;163;165;163;169;161;162;163;162 20:10:02 INFO - PROCESS | 5855 | |3;audio-fft;76;76;76;160;74;76;75;76;168;75 20:10:02 INFO - PROCESS | 5855 | |4;audio-oscillator;92;93;149;94;93;93;137;93;94;143 20:10:02 INFO - PROCESS | 5855 | |5;imaging-gaussian-blur;116;118;117;117;117;117;117;118;116;117 20:10:02 INFO - PROCESS | 5855 | |6;imaging-darkroom;147;146;148;148;148;147;147;147;148;146 20:10:02 INFO - PROCESS | 5855 | |7;imaging-desaturate;96;96;96;96;96;97;96;97;96;96 20:10:02 INFO - PROCESS | 5855 | |8;json-parse-financial;56;56;57;56;57;58;56;62;54;55 20:10:02 INFO - PROCESS | 5855 | |9;json-stringify-tinderbox;72;73;73;72;73;75;73;73;73;73 20:10:02 INFO - PROCESS | 5855 | |10;stanford-crypto-aes;77;80;80;80;78;78;78;77;77;78 20:10:02 INFO - PROCESS | 5855 | |11;stanford-crypto-ccm;130;120;112;110;128;124;119;119;115;125 20:10:02 INFO - PROCESS | 5855 | |12;stanford-crypto-pbkdf2;134;147;145;144;145;157;146;144;155;137 20:10:02 INFO - PROCESS | 5855 | |13;stanford-crypto-sha256-iterative;66;65;68;74;65;65;72;71;68;67 20:10:02 INFO - PROCESS | 5855 | __end_tp_report 20:10:02 INFO - PROCESS | 5855 | __start_cc_report 20:10:02 INFO - PROCESS | 5855 | _x_x_mozilla_cycle_collect,839 20:10:02 INFO - PROCESS | 5855 | __end_cc_report 20:10:02 INFO - PROCESS | 5855 | __startTimestamp1461121802111__endTimestamp 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | ------- Summary: start ------- 20:10:02 INFO - PROCESS | 5855 | Number of tests: 14 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#0] ai-astar Cycles:10 Average:110.70 Median:110.50 stddev:4.16 (3.8%) stddev-sans-first:4.42 20:10:02 INFO - PROCESS | 5855 | Values: 111.0 104.0 111.0 110.0 109.0 121.0 110.0 110.0 111.0 110.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:160.50 stddev:21.44 (13.4%) stddev-sans-first:22.62 20:10:02 INFO - PROCESS | 5855 | Values: 158.0 132.0 167.0 179.0 128.0 156.0 163.0 127.0 180.0 127.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.26 (1.4%) stddev-sans-first:2.35 20:10:02 INFO - PROCESS | 5855 | Values: 162.0 163.0 163.0 165.0 163.0 169.0 161.0 162.0 163.0 162.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.00 stddev:37.37 (49.2%) stddev-sans-first:39.11 20:10:02 INFO - PROCESS | 5855 | Values: 76.0 76.0 76.0 160.0 74.0 76.0 75.0 76.0 168.0 75.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:93.00 stddev:24.26 (26.1%) stddev-sans-first:25.02 20:10:02 INFO - PROCESS | 5855 | Values: 92.0 93.0 149.0 94.0 93.0 93.0 137.0 93.0 94.0 143.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 20:10:02 INFO - PROCESS | 5855 | Values: 116.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 117.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 20:10:02 INFO - PROCESS | 5855 | Values: 147.0 146.0 148.0 148.0 148.0 147.0 147.0 147.0 148.0 146.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:10:02 INFO - PROCESS | 5855 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:2.16 (3.8%) stddev-sans-first:2.28 20:10:02 INFO - PROCESS | 5855 | Values: 56.0 56.0 57.0 56.0 57.0 58.0 56.0 62.0 54.0 55.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.78 20:10:02 INFO - PROCESS | 5855 | Values: 72.0 73.0 73.0 72.0 73.0 75.0 73.0 73.0 73.0 73.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:1.25 (1.6%) stddev-sans-first:1.24 20:10:02 INFO - PROCESS | 5855 | Values: 77.0 80.0 80.0 80.0 78.0 78.0 78.0 77.0 77.0 78.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:122.00 stddev:6.63 (5.4%) stddev-sans-first:6.01 20:10:02 INFO - PROCESS | 5855 | Values: 130.0 120.0 112.0 110.0 128.0 124.0 119.0 119.0 115.0 125.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:145.50 stddev:6.95 (4.8%) stddev-sans-first:6.02 20:10:02 INFO - PROCESS | 5855 | Values: 134.0 147.0 145.0 144.0 145.0 157.0 146.0 144.0 155.0 137.0 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - PROCESS | 5855 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:3.21 (4.7%) stddev-sans-first:3.32 20:10:02 INFO - PROCESS | 5855 | Values: 66.0 65.0 68.0 74.0 65.0 65.0 72.0 71.0 68.0 67.0 20:10:02 INFO - PROCESS | 5855 | -------- Summary: end -------- 20:10:02 INFO - PROCESS | 5855 | 20:10:02 INFO - TEST-INFO | 5855: exit 0 20:10:03 INFO - TEST-OK | kraken | took 60909ms 20:10:03 INFO - SUITE-END | took 1171s 20:10:03 INFO - Completed test suite (00:19:32) 20:10:03 INFO - javascript benchmark 20:10:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3299.752518561108, 3370.882019129331, 3384.8984530464095, 3387.0516255448483, 3440.294739578385, 5512.33851937767, 5518.834434966952, 5520.613557051008, 5525.11598144297, 5530.668159910409, 5502.614816962814, 5596.104623260279, 5603.327600687923, 5604.551635869131, 5606.747696353664, 5028.472010438906, 5076.923846142311, 5157.174852023677, 5160.303359046518, 5248.632595718302, 4982.725950072744, 5040.067587496325, 5073.416557095926, 5164.509371609691, 5240.109181439165, 5110.488951104897, 5125.410577783547, 5179.015986962484, 5186.170212765958, 5194.220866869962, 5123.820666276681, 5146.253793200002, 5150.201718733602, 5153.149730294497, 5162.277281180638, 4907.533784290486, 4976.62675299354, 5092.9236061459105, 5102.387713474407, 5116.258142569307, 5378.300820893259, 5388.353397592314, 5401.756920938528, 5403.351597808288, 5416.133418653036, 6007.879842403127, 6013.849653758647, 6060.666663333515, 6064.514838812885, 6070.2108725865355, 5930.733117009701, 5965.045592705146, 5970.611910225864, 5982.880342393128, 6036.758529658809, 5542.251796007527, 5579.776808927638, 5581.609287349846, 5583.469570390806, 5592.077307244341, 5950.642961422329, 6106.938930610726, 6108.267007959073, 6115.4190351916495, 6118.010103775246, 5949.9107513387335, 5996.700164991733, 5999.730012149464, 6003.129546215774, 6016.789412370634, 6065.787697430569, 6066.817995460143, 6071.453569178795, 6072.089186622042, 6078.817635470943, 5807.94192058074, 5960.731767070492, 6010.939890601126, 6045.697715114226, 6051.4553690168095, 5987.790427335022, 6019.187409699722, 6046.969765151146, 6050.48570871472, 6076.422739839708, 4551.226291530448, 4585.564371384713, 4587.990642058741, 4599.540045995441, 4622.768861556976, 3951.1110000249714, 4052.7365721228025, 4121.093359460914, 4135.813888375031, 4177.164567086534, 5575.219469274305, 5726.341470730836, 5751.223584815996, 5774.04728219839, 5795.7971470999155, 5945.10823376497, 6016.097585362143, 6018.969905150534, 6032.638041717511, 6037.335893051761, 5594.748236329375, 5639.887202255932, 5668.319801623831, 5723.59934804568, 5748.13777933305, 5073.720945348041, 5135.897282054413, 5137.922931156036, 5144.202648589475, 5148.330717006766, 6172.938270617236, 6173.47525460332, 6173.876522469525, 6176.289726681399, 6186.133941248138, 5822.243108395882, 5983.9401605983385, 6021.307549631761, 6071.51427885777, 6101.938980610137, 6155.132012955123, 6192.040233763774, 6201.131841542278, 6202.751889924352, 6216.844578885383, 5950.077737950624, 5957.880842383215, 5967.045272756512, 5980.461758441761, 6002.639841609517, 5852.4440178183, 5931.436513531207, 6018.909716354346, 6021.0, 6065.514758819196, 5865.354810970875, 5882.970585147047, 5903.616264942937, 5907.0, 5913.408659134052, 5694.857628559319, 5865.560082993878, 5893.970530147493, 5924.259467566554, 5924.674142922008, 5770.711464426846, 5831.271091113611, 5868.911966320423, 5877.500412464989, 5882.441168089024, 5874.765009399576, 5922.940770592239, 5929.6145750526075, 5937.91093133612, 5945.583809133319, 5616.241807356118, 5780.710964451677, 5786.42135786418, 5788.768449261982, 5798.82603521895], "unit": "score", "name": "dojo.html", "value": 5535.879464202982}, {"lowerIsBetter": false, "replicates": [527.6280222443178, 563.6195567991606, 576.5790972590006, 590.8020813027634, 594.0, 31757.841210793944, 41113.79443102784, 41278.793606031926, 41417.58582414175, 41508.584914150924, 44949.77525112378, 45384.3192352115, 45569.0, 45769.0, 46063.539364606346, 8856.247218986378, 9202.309826762987, 9204.907950920506, 9219.815603687955, 9230.07699230075, 9014.68448604299, 9137.954310228439, 9138.0, 9151.771205719877, 9345.392549484295, 9248.26013918885, 9358.672446464376, 9379.24966002718, 9379.906200937972, 9427.622895084189, 9246.35275530713, 9298.0, 9316.767080823, 9322.953385233099, 9325.067493250688, 9141.177294043568, 9314.487703176323, 9316.208122309612, 9318.767030824216, 9331.953340233324, 45173.77413112946, 45616.3157552637, 45707.77146114282, 45748.0, 45801.31298030532, 3802.9619703802887, 3819.1216020315205, 3847.2690188864026, 4183.5398106208295, 4714.952850471485, 32805.0, 33107.50338744921, 33841.6615833841, 33897.21234483409, 34923.65076349255, 4167.1040726244, 4188.204241194163, 4232.957670423287, 4250.128723611683, 4285.550017248175, 228758.0, 229602.0, 230006.9999999983, 230859.0, 230943.0, 67804.32195677981, 68265.0, 68410.65794670995, 68526.31473685299, 68551.3144868555, 77732.0, 78717.60641196757, 78902.60548697335, 79245.20754792493, 79418.20581794223, 18816.62366752657, 18962.241510339707, 19036.90481547611, 19161.808381916002, 19238.80761192398, 14500.0, 14659.120452772868, 14696.706065878836, 14775.187364695044, 14818.555443336718, 22688.773112268667, 23035.654465183037, 23122.3063308101, 23140.53718925612, 24191.0, 8597.957010214908, 8625.0, 8736.606852691644, 8763.123687631314, 8763.298936085097, 1070.314998401024, 1072.3726619927274, 1096.627146770102, 1134.234391785558, 1201.9879801201876, 29741.85129074341, 30021.39957200844, 30240.395192096476, 30899.8455007728, 31132.066038018897, 1096.6490722968574, 1115.2583531951325, 1142.2232881640398, 1170.6488053583892, 1245.8318127052912, 15953.760693589606, 16058.518244452685, 16102.0, 16236.350545978265, 16280.267387967333, 344198.0, 547455.0, 552500.0, 552622.0, 559772.0, 58846.41153588409, 59057.704711477025, 59074.34165462565, 59381.70309148427, 59718.0, 1520.4678362573231, 1550.7363748162838, 1569.5919061043983, 1569.6389830339085, 1573.402107199257, 29985.700142998292, 30841.69158308388, 33061.00816975495, 33191.17022074467, 33211.50182747309, 52126.21810672919, 52973.0, 53199.0, 53252.201216982554, 53252.73373633107, 322415.0, 330095.0, 331161.0, 334696.0, 336622.0, 48429.75785121193, 48503.51496485131, 48931.75534122306, 49251.0, 49670.25494617656, 53106.20340694815, 53170.468295316554, 53767.193492098435, 53887.19169212543, 54248.45751542434, 44283.33574996313, 44696.776516117214, 44927.775361122985, 45359.54640453553, 46654.30018549792, 43557.56442435662, 44233.0, 44436.55563444324, 45059.0, 45284.54715452803, 42071.7896410516, 43019.78490107655, 43105.56894431016, 43170.0, 43234.0, 37765.62234377621, 39036.21927561376, 39146.0, 39791.80104099461, 40003.199936000536, 29317.0, 29508.78576312129, 29595.0, 29661.25846853846, 29903.252418689706], "unit": "score", "name": "ext.html", "value": 21206.57279761275}, {"lowerIsBetter": false, "replicates": [380.5471488928176, 396.5320921312853, 398.5197836606889, 400.41739269363063, 415.86276528745515, 16930.830691693078, 17444.389446369365, 17495.562610934732, 18992.905035474836, 19617.11722972466, 16522.339106435727, 16787.32850685971, 17485.7377139343, 17875.284988600473, 17886.821131788678, 5056.721880296592, 5228.712420816853, 5446.7276636168035, 5546.084895992157, 5955.374685657986, 5852.12218167274, 5922.318933322658, 5927.110933360009, 5931.169636250928, 5948.732307046172, 5576.442355764431, 5798.246227990356, 5851.15158302046, 5856.443637854419, 5919.763209471616, 5792.073268277077, 5836.883262334751, 5851.1223316502865, 5859.384764599698, 5892.381299963485, 5280.498352656491, 5297.390800058004, 5319.5478384337375, 5327.493888080626, 5528.198411230389, 13894.652633684138, 13947.0, 13960.581182564438, 14050.789238161437, 14072.507462238773, 2387.6418537219556, 2449.6448015037718, 2529.620556916459, 2551.961720574193, 2933.5159698649695, 10137.189024877993, 10172.44051577163, 10270.7432314192, 10629.255952083357, 10644.41455719935, 1857.7956424793263, 1913.3303343829687, 1941.6505029094758, 1961.0292905011968, 1961.3429501117143, 66187.0, 68009.55923526105, 68592.3140768591, 70454.29545704529, 70769.99999999949, 10387.480625968672, 10545.31455455393, 10709.892901071045, 10733.946330268454, 10895.400752958505, 14878.92560537212, 15006.174660393564, 15049.548513544392, 15211.771823422658, 15264.0, 8035.316998055114, 8210.425270231146, 8263.297619702273, 8289.668413263402, 8371.832563348698, 7974.122846486882, 8054.637541310655, 8084.595770211466, 8194.344452443791, 8268.09051004389, 4747.786349614275, 4754.310624959361, 4829.541193586674, 4884.0, 4913.533214344631, 1946.6204090202557, 1969.8325642320276, 1996.1217064491577, 2015.9899200503903, 2026.6149431608242, 923.9029901860342, 1000.9949950250202, 1021.8824835143905, 1091.5591419326413, 1133.3086817041763, 17240.0, 17350.56623584395, 17613.471595852145, 17768.11159442023, 18143.637127257643, 990.5047476261869, 1002.478711070254, 1015.1320620869051, 1051.6529545250048, 1059.3220338983058, 8125.674973001013, 9870.950645246729, 10216.693499195037, 10232.386056836614, 10444.947775261075, 421132.0, 425617.0, 430481.0, 430968.0, 431979.0, 73621.2637873625, 77733.61133194297, 78503.60748196223, 80353.19646803457, 80700.59649701713, 1084.3764835219781, 1103.7240689827383, 1145.169751929861, 1153.7000379901285, 1165.5570883064552, 15689.98015129013, 15722.13528255957, 15915.840841591436, 16032.0, 16173.191340433166, 29122.417551649272, 33630.66369336275, 34077.0, 35666.0, 36591.08522286964, 40031.0, 43794.34308485311, 43878.0, 43971.0, 44071.77964110159, 8561.785955351166, 8624.655013799378, 8684.261837743863, 8880.86678699807, 8990.145936136056, 11855.55167074551, 13684.52104176349, 13842.238676872868, 13879.583612491642, 14191.64520886986, 11510.0, 11570.652880413601, 12057.457414416196, 12204.084693647834, 12357.567485137977, 11010.614628487965, 11187.0, 11696.35670038122, 11789.115816313983, 12283.69290767738, 12054.337011464453, 12230.388480576114, 12257.816132757838, 12622.242665439735, 12666.683332916751, 8085.878711819445, 8431.53626550521, 8806.779830504289, 8843.778905527155, 9288.256939444964, 11113.388763618079, 11718.23831450953, 11971.760564788481, 12017.879821202027, 12125.393730313626], "unit": "score", "name": "jquery.html", "value": 8852.170316646785}, {"lowerIsBetter": false, "replicates": [1570.6230504678877, 1594.8644365228954, 1882.9246830126795, 1944.3389247655793, 1995.2218634732449, 7044.753433629824, 8235.752927412172, 8548.230659240668, 8748.25639820616, 8766.298696104312, 8450.408471406989, 8508.319334453245, 8546.40175187737, 8599.140085991397, 8611.483311001328, 2452.6566280720667, 2474.653548503211, 2474.8515089094712, 2481.3548477395916, 2490.340059884132, 2443.898247507151, 2468.049800826677, 2473.1591258971944, 2492.9252122436355, 2494.4387512809562, 2445.5842506773893, 2449.4121410861353, 2471.036295844613, 2472.2706801493514, 2474.0, 2474.4679893822736, 2490.7882829959476, 2501.6622755927897, 2567.7817385522253, 2568.036986130201, 2523.8485690858606, 2531.1014589820716, 2531.7847982921476, 2542.1992072497287, 2545.2491515002935, 8720.956395217983, 8729.34529910253, 8746.86879696805, 8802.823943521094, 8828.382013259074, 5271.894562108775, 5386.111291636876, 5413.729313534308, 5417.945820541823, 5431.891362172734, 3446.3796516627, 3492.7380446466364, 3532.1346270163717, 3571.8214089295693, 3605.2428989911887, 1216.2033867816594, 1220.4020030185234, 1234.0127897681818, 1235.0860363331071, 1283.4930202570026, 11853.940730296294, 11881.643550693492, 11885.524579016828, 11889.464974076187, 11943.22369046018, 4611.0, 4629.560191781776, 4760.880977975578, 4765.11845308619, 4800.0, 10082.0, 10100.797984040279, 10103.393796372242, 10107.69676909694, 10126.240531960133, 5343.893122137535, 5358.303420555303, 5372.946270537323, 5376.73116344189, 5386.515213630713, 4031.415444760552, 4732.0, 4817.156997525419, 4828.806847726122, 4859.416869975555, 3987.641112299907, 3996.660283875903, 4034.6772258219858, 4077.327241005201, 4084.673226141961, 1327.4093028602372, 1340.6916409225737, 1342.3020029584561, 1346.3941226447942, 1363.9045266831424, 1131.3833960491552, 1176.717587778944, 1410.4076287959083, 1426.5078547900957, 1447.7683570628649, 8100.392470564731, 8151.8777218341775, 8236.588170591447, 8237.670493180205, 8257.05043919945, 1231.1812644591246, 1233.3709807997986, 1240.3798100949525, 1272.4094881398253, 1272.6691060324383, 6463.385978332051, 6519.250286217146, 6534.150560427209, 6563.048357988065, 6594.736210551524, 10212.285140040125, 10521.52653130611, 10571.2600117991, 10667.626633067961, 10741.838872416763, 10528.157747380192, 10608.416537090534, 10616.84074738864, 10630.73423164427, 10765.677029688964, 8203.794905127419, 8293.170682931779, 8363.038250601137, 8363.790905227417, 8390.958045209734, 7930.572496950605, 7939.801504962422, 7980.720674776355, 8043.597820108854, 8109.0, 9246.815063698823, 9428.10433008863, 9477.952610236905, 9570.856437153308, 9602.08780165883, 9625.229981601595, 9725.562349694139, 9747.805043899225, 9937.055979681918, 9941.900580994097, 6033.276006879202, 6760.256371799, 6935.167779866449, 7346.6326683666675, 7455.776326710207, 8183.427160098736, 8234.958825205835, 8259.297959673495, 8275.0, 8284.130166332689, 7295.635218239173, 7482.850342993219, 7496.100467943882, 7620.123685776207, 7624.5425274483705, 7204.53170543913, 7325.267473252845, 7334.853302933805, 7369.115706115301, 7428.2571742825285, 7672.846543068996, 7848.725294614661, 7860.410469214946, 7861.410394220342, 7880.17258187882, 6992.510524263253, 7008.824779380557, 7017.859642807218, 7044.15470143586, 7319.743808966874, 7181.497295189287, 7196.172440169447, 7203.71185152588, 7211.927880721126, 7257.600831954293], "unit": "score", "name": "mootools.html", "value": 5002.635120390381}, {"lowerIsBetter": false, "replicates": [329.6703296703297, 333.8831409006848, 355.46325049175744, 355.58041511017007, 363.26257696875336, 6423.421892029716, 6439.710213040413, 6442.806715798528, 6447.0, 6450.193725784277, 6393.616383017023, 6397.10440538325, 6397.200349956255, 6406.487481001521, 6407.0, 4809.90380192396, 4830.782614782343, 4922.089413458521, 4927.975360123194, 4960.67755595887, 4910.582600478946, 4918.581920536759, 4938.654294199408, 4940.851774446773, 4961.925571116418, 4881.048195601859, 4884.047610715912, 4888.437829649582, 4898.436679781835, 4901.09329773993, 4891.828785992491, 4920.7785649645675, 4922.532359425867, 4930.408350997867, 4960.404751429815, 4378.474583050022, 4380.102079073782, 4388.166248412791, 4389.846355377546, 4391.8682439526865, 5934.258217722785, 6062.666553339564, 6117.724702388403, 6119.2350956130485, 6129.969350153266, 5740.856478588027, 5770.307563092414, 5771.913421298684, 5776.59563830532, 5778.393268706767, 6766.391024807742, 6815.079964204819, 6820.181578210597, 6823.829404264883, 6841.828954276133, 4800.975995120002, 4818.638602104821, 4829.734364609945, 4833.154198015369, 4841.612670986313, 7045.612491312976, 7066.858662826715, 7112.857742845114, 7121.181064177582, 7138.072050633385, 4723.173444647173, 4839.491853355417, 4874.53691899269, 4961.032598643302, 4962.131626965267, 5081.822136225214, 5085.1355269604255, 5089.312942752755, 5094.7962081516325, 5094.847154585368, 5758.395368486333, 5779.913301300484, 5780.479756821822, 5793.391693872167, 5829.47534721877, 6875.243723190445, 6877.2091209510545, 6879.0, 6881.243063263037, 6885.311468853075, 1775.4496106207116, 1790.4181141129186, 1790.9373171938919, 1791.9910400448175, 1792.345793785285, 1171.6777886081225, 1192.928424294545, 1193.7731830952264, 1197.4192516629428, 1199.4542483170137, 6397.904031439532, 6410.230772307353, 6438.424630147978, 6454.870902581922, 6490.610563366213, 6924.619145947021, 6988.545744526691, 6992.0910281663055, 6999.580025198505, 7006.684699188549, 6464.450521705708, 6480.902786458207, 6496.772612958618, 6508.869822603616, 6518.771842985473, 3677.1174918019483, 3751.531058617673, 3754.981225093857, 3758.4362345648374, 3796.5064541609413, 7189.532680375759, 7191.964040179871, 7193.496455248082, 7200.639968001684, 7222.927770722331, 7098.432125429953, 7135.89296160558, 7142.178649455275, 7152.284771522806, 7155.141383034069, 7160.749373771893, 7160.854263317949, 7168.211496735355, 7181.497295189287, 7183.5330703504105, 6775.457963363017, 6971.3028697129885, 6977.0, 6978.860422791414, 6995.195552511526, 6802.251752307341, 6853.897191542231, 6857.348551887562, 6884.345987131214, 6884.380405763505, 7126.28737126304, 7154.964225178841, 7176.892346614909, 7185.748498802517, 7198.316159964795, 4960.429550601582, 4961.627877909244, 4971.477994810492, 4979.427365852828, 4985.750712464434, 6914.9308506914285, 6963.721451141898, 6975.895361569682, 7103.396211321889, 7128.857422851617, 6834.384905358542, 6843.965780171067, 6863.0, 6863.862722745617, 6871.14110736158, 6883.174019117738, 6898.620575868375, 6898.965505172442, 6905.827354316182, 6909.170899492093, 6652.301508341555, 6661.933380666132, 6695.12963314766, 6699.0, 6718.697658605277, 6709.698063587248, 6904.585724856524, 6947.93052069493, 6948.062011628567, 6962.547434416747, 6632.0, 6638.502112341497, 6642.833929151617, 6687.331266873273, 6720.260771315054], "unit": "score", "name": "prototype.html", "value": 5155.61511371539}, {"lowerIsBetter": false, "replicates": [823.2056065896409, 898.2275243290769, 898.9685361012366, 909.1590278991931, 912.479886464715, 14869.553913382602, 15093.698126037472, 15097.773533397009, 15142.62143446413, 15173.468928587488, 13001.284929328884, 14323.427062917497, 14406.135631862096, 14418.423263069464, 14438.783418248735, 922.6540047482194, 940.5391358234484, 944.773254418938, 945.9385139965915, 947.6114792934898, 954.88063992001, 957.1098878043417, 960.8798900137483, 961.500019989605, 966.2415004221652, 985.3250523391499, 998.101708462386, 1001.7595777013537, 1001.9398836069859, 1004.4375149916034, 979.990200097997, 982.9606815727362, 989.5992123190119, 994.1500017485018, 995.0845222395413, 727.0548287226637, 731.0569365518475, 731.5574077682978, 731.9634018299064, 735.5586648011204, 14962.102273863604, 14981.176035318053, 15011.0, 15046.924765376103, 15047.172405517693, 14293.213873236968, 14600.34298456572, 14644.560663180122, 14807.555773326818, 14810.259487025605, 10317.174626029899, 10412.79174416515, 10421.27051106423, 10475.371477711362, 10529.736756581071, 3894.2016886538477, 3926.960730392688, 3958.920821583581, 3967.504061992251, 3974.4038394240806, 50251.74874125642, 52150.99999999962, 52383.73808130973, 52546.47453525492, 53051.469485305424, 11184.44077796107, 11228.326300422, 11388.316700997966, 11537.077033837273, 11728.296302221894, 20318.898405508175, 20351.796482035286, 20363.0, 20400.489987750425, 20422.08100635475, 8498.957505212435, 8539.615717292736, 8587.355948303777, 8620.741377758677, 8637.827243455222, 4709.458412282563, 4719.292106184032, 4721.102990431807, 4850.320955066293, 4870.8782280442565, 3532.3641744485726, 3560.430331147004, 3561.465780133001, 3565.2512972275595, 3571.160777217352, 679.3104998426601, 687.5702685821361, 692.650211643117, 693.9306069393122, 707.6532499075416, 629.9842503937347, 739.8631253218172, 742.3133601418774, 743.5761615878897, 750.5009168902618, 9458.668946586975, 9484.668036618823, 9569.808603827885, 9572.952135239419, 9810.803783924424, 610.5603965145089, 636.2492259134266, 658.868226354731, 743.8136172804368, 746.2649290448903, 4114.382842573638, 4439.689221754511, 4474.798634061475, 4477.865664030084, 4632.189366860786, 58114.418855811746, 61809.38190618126, 64760.0, 65318.346816532176, 65479.0, 54521.45478545243, 55354.446455534926, 55728.164077538866, 57827.0, 57965.0, 50861.745691272044, 51814.22278665823, 52133.478665213624, 52134.73932630388, 53318.46681533135, 9345.719628411158, 9350.719478415658, 9407.200387966826, 9507.762305942406, 9634.181094607036, 37855.62144378521, 37983.240335193696, 38062.80968595139, 39480.60519394769, 39500.604993949695, 44314.3352849714, 50018.249726254864, 50028.0, 50320.0, 51183.0, 11765.764684706086, 12983.156094853804, 13003.219806811621, 13122.737545249232, 13268.0, 13692.31538423055, 14007.929960350133, 14163.716725665223, 14273.14361138335, 14290.28548572588, 12640.115191936477, 12779.0, 12867.292298923649, 12910.419031143809, 12951.870481295067, 12673.746525069262, 12710.300933448749, 13140.27728474943, 13246.668833279246, 13478.595642130751, 12724.363781811058, 12887.742245154857, 12996.545120920722, 13130.671733206746, 13424.530141445002, 10574.15406767472, 10598.788024239626, 10675.306105103144, 11039.558417663204, 11064.17018723615, 10439.739006524898, 11051.557937682725, 11123.221374503708, 11177.776444471228, 11218.270812397168], "unit": "score", "name": "yui.html", "value": 7099.902319265393}], "name": "dromaeo_css", "value": 7584.248101565344}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 111.0, 110.0, 109.0, 121.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [158.0, 132.0, 167.0, 179.0, 128.0, 156.0, 163.0, 127.0, 180.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 151.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 165.0, 163.0, 169.0, 161.0, 162.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 76.0, 160.0, 74.0, 76.0, 75.0, 76.0, 168.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.2}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 149.0, 94.0, 93.0, 93.0, 137.0, 93.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 56.0, 57.0, 58.0, 56.0, 62.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 72.0, 73.0, 75.0, 73.0, 73.0, 73.0, 73.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.0}, {"lowerIsBetter": true, "replicates": [77.0, 80.0, 80.0, 80.0, 78.0, 78.0, 78.0, 77.0, 77.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.3}, {"lowerIsBetter": true, "replicates": [130.0, 120.0, 112.0, 110.0, 128.0, 124.0, 119.0, 119.0, 115.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [134.0, 147.0, 145.0, 144.0, 145.0, 157.0, 146.0, 144.0, 155.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 68.0, 74.0, 65.0, 65.0, 72.0, 71.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1529.1000000000001}]} 20:10:03 INFO - Return code: 0 20:10:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:10:03 ERROR - # TBPL SUCCESS # 20:10:03 INFO - Running post-action listener: _resource_record_post_action 20:10:03 INFO - Running post-run listener: _resource_record_post_run 20:10:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 778240; Write bytes: 253616128; Read time: 104; Write time: 341772 20:10:04 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5189632; Read time: 0; Write time: 724 20:10:04 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 778240; Write bytes: 248426496; Read time: 104; Write time: 341048 20:10:04 INFO - Running post-run listener: _upload_blobber_files 20:10:04 INFO - Blob upload gear active. 20:10:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:10:04 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 20:10:04 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:10:04 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:10:04 INFO - (blobuploader) - INFO - Open directory for files ... 20:10:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:10:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:10:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:06 INFO - (blobuploader) - INFO - Done attempting. 20:10:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:10:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:10:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:07 INFO - (blobuploader) - INFO - Done attempting. 20:10:07 INFO - (blobuploader) - INFO - Iteration through files over. 20:10:07 INFO - Return code: 0 20:10:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:10:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:10:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7b0aaa51d3eb94ed017516e435dcfef375facce67500b271f4481740b6b1289af771c02c6d1c9c8e829f480e56b5da5d536077bd3a492e48e2873778de1435c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8f2ba54a726edfd7c68f128a22d312bbacb70eee2a99040dff9ddfd70cb26a3fec16984ffa96b00d0deeca9ccfbbfd0b11169b42b44c1a8abcc4e2fc41cad80"} 20:10:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:10:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:10:07 INFO - Contents: 20:10:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7b0aaa51d3eb94ed017516e435dcfef375facce67500b271f4481740b6b1289af771c02c6d1c9c8e829f480e56b5da5d536077bd3a492e48e2873778de1435c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8f2ba54a726edfd7c68f128a22d312bbacb70eee2a99040dff9ddfd70cb26a3fec16984ffa96b00d0deeca9ccfbbfd0b11169b42b44c1a8abcc4e2fc41cad80"} 20:10:07 INFO - Running post-run listener: copy_logs_to_upload_dir 20:10:07 INFO - Copying logs to upload dir... 20:10:07 INFO - mkdir: /builds/slave/test/build/upload/logs 20:10:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.477868 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-19 20:10:06.976343) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 20:10:06.979663) ========= 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=745a4373a2a16df560f216e000000264-1461112192.303179-881799550 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/Mozilla-Aurora/sha512/d7b0aaa51d3eb94ed017516e435dcfef375facce67500b271f4481740b6b1289af771c02c6d1c9c8e829f480e56b5da5d536077bd3a492e48e2873778de1435c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8f2ba54a726edfd7c68f128a22d312bbacb70eee2a99040dff9ddfd70cb26a3fec16984ffa96b00d0deeca9ccfbbfd0b11169b42b44c1a8abcc4e2fc41cad80"} build_url:https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/KKDzEXh7RiaRTKKq5ZSJGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7b0aaa51d3eb94ed017516e435dcfef375facce67500b271f4481740b6b1289af771c02c6d1c9c8e829f480e56b5da5d536077bd3a492e48e2873778de1435c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8f2ba54a726edfd7c68f128a22d312bbacb70eee2a99040dff9ddfd70cb26a3fec16984ffa96b00d0deeca9ccfbbfd0b11169b42b44c1a8abcc4e2fc41cad80"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 20:10:07.006183) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 20:10:07.006585) ========= 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=745a4373a2a16df560f216e000000264-1461112192.303179-881799550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 20:10:07.095900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 20:10:07.096711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 20:10:07.097280) ========= ========= Total master_lag: 0.17 =========