builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1464344837.92 results: success (0) buildid: 20160527004031 builduid: f910c1463e004464956fa656dd7dc3d2 revision: 9cbc4f2d34a30255c3a093f6005f87b453491a7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:17.924831) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:17.925276) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:17.925568) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:17.941734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:17.942021) ========= 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=574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 03:27:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.2M=0s 2016-05-27 03:27:18 (23.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114196 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:18.079384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:18.079687) ========= 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=574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017643 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:18.139642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:18.139959) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9cbc4f2d34a30255c3a093f6005f87b453491a7a --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 9cbc4f2d34a30255c3a093f6005f87b453491a7a --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=574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 03:27:18,364 truncating revision to first 12 chars 2016-05-27 03:27:18,364 Setting DEBUG logging. 2016-05-27 03:27:18,364 attempt 1/10 2016-05-27 03:27:18,364 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9cbc4f2d34a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 03:27:18,731 unpacking tar archive at: mozilla-aurora-9cbc4f2d34a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.688081 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:18.841302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:18.841597) ========= script_repo_revision: 9cbc4f2d34a30255c3a093f6005f87b453491a7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:18.841984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:18.842372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 03:27:18.854390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-27 03:27:18.854675) ========= /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=574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:19 INFO - MultiFileLogger online at 20160527 03:27:19 in /builds/slave/test 03:27:19 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 03:27:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:19 INFO - {'append_to_log': False, 03:27:19 INFO - 'base_work_dir': '/builds/slave/test', 03:27:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:27:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:19 INFO - 'branch': 'Mozilla-Aurora', 03:27:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:19 INFO - 'config_files': ('talos/linux_config.py',), 03:27:19 INFO - 'default_actions': ('clobber', 03:27:19 INFO - 'read-buildbot-config', 03:27:19 INFO - 'download-and-extract', 03:27:19 INFO - 'populate-webroot', 03:27:19 INFO - 'create-virtualenv', 03:27:19 INFO - 'install', 03:27:19 INFO - 'run-tests'), 03:27:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:19 INFO - 'download_minidump_stackwalk': True, 03:27:19 INFO - 'download_symbols': 'ondemand', 03:27:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:19 INFO - 'installer_path': 'installer.exe', 03:27:19 INFO - 'log_level': 'info', 03:27:19 INFO - 'log_name': 'talos', 03:27:19 INFO - 'log_to_console': True, 03:27:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:19 INFO - 'opt_config_files': (), 03:27:19 INFO - 'pip_index': False, 03:27:19 INFO - 'sps_profile': False, 03:27:19 INFO - 'sps_profile_interval': 0, 03:27:19 INFO - 'suite': 'dromaeojs-e10s', 03:27:19 INFO - 'system_bits': '32', 03:27:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:19 INFO - 'title': 'talos-linux64-ix-044', 03:27:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:19 INFO - 'use_talos_json': True, 03:27:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:19 INFO - 'work_dir': 'build'} 03:27:19 INFO - ##### 03:27:19 INFO - ##### Running clobber step. 03:27:19 INFO - ##### 03:27:19 INFO - Running pre-action listener: _resource_record_pre_action 03:27:19 INFO - Running main action method: clobber 03:27:19 INFO - rmtree: /builds/slave/test/build 03:27:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:19 INFO - Running post-action listener: _resource_record_post_action 03:27:19 INFO - ##### 03:27:19 INFO - ##### Running read-buildbot-config step. 03:27:19 INFO - ##### 03:27:19 INFO - Running pre-action listener: _resource_record_pre_action 03:27:19 INFO - Running main action method: read_buildbot_config 03:27:19 INFO - Using buildbot properties: 03:27:19 INFO - { 03:27:19 INFO - "project": "", 03:27:19 INFO - "product": "firefox", 03:27:19 INFO - "script_repo_revision": "production", 03:27:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:27:19 INFO - "repository": "", 03:27:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:27:19 INFO - "buildid": "20160527004031", 03:27:19 INFO - "stage_platform": "linux64-pgo", 03:27:19 INFO - "basedir": "/builds/slave/test", 03:27:19 INFO - "nightly_build": "True", 03:27:19 INFO - "buildnumber": 295, 03:27:19 INFO - "slavename": "talos-linux64-ix-044", 03:27:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:27:19 INFO - "platform": "ubuntu64_hw", 03:27:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:27:19 INFO - "branch": "mozilla-aurora", 03:27:19 INFO - "repo_path": "releases/mozilla-aurora", 03:27:19 INFO - "revision": "9cbc4f2d34a30255c3a093f6005f87b453491a7a", 03:27:19 INFO - "pgo_build": "True", 03:27:19 INFO - "builduid": "f910c1463e004464956fa656dd7dc3d2", 03:27:19 INFO - "slavebuilddir": "test" 03:27:19 INFO - } 03:27:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:27:19 INFO - Running post-action listener: _resource_record_post_action 03:27:19 INFO - ##### 03:27:19 INFO - ##### Running download-and-extract step. 03:27:19 INFO - ##### 03:27:19 INFO - Running pre-action listener: _resource_record_pre_action 03:27:19 INFO - Running main action method: download_and_extract 03:27:19 INFO - mkdir: /builds/slave/test/build/tests 03:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:19 INFO - https://queue.taskcluster.net/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:27:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:27:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:27:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:27:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:27:30 INFO - Downloaded 1361 bytes. 03:27:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:27:30 INFO - Using the following test package requirements: 03:27:30 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:30 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:27:30 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:27:30 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'jsshell-linux-x86_64.zip'], 03:27:30 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:27:30 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:30 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:27:30 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:27:30 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:27:30 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:27:30 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:27:30 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')]} 03:27:30 INFO - https://queue.taskcluster.net/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:27:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:27:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:27:33 INFO - Downloaded 24135969 bytes. 03:27:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:27:35 INFO - Return code: 0 03:27:35 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:35 INFO - https://queue.taskcluster.net/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:27:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:27:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:27:38 INFO - Downloaded 24135969 bytes. 03:27:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:27:39 INFO - Return code: 0 03:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:39 INFO - https://queue.taskcluster.net/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:27:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:27:40 INFO - Downloaded 10840145 bytes. 03:27:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:27:40 INFO - Return code: 0 03:27: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')]} 03:27:40 INFO - https://queue.taskcluster.net/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:27:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:27:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:27:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:27:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:27:42 INFO - Downloaded 62758234 bytes. 03:27:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:27:42 INFO - mkdir: /builds/slave/test/properties 03:27:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:27:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:27:42 INFO - Contents: 03:27:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:27:43 INFO - Running post-action listener: _resource_record_post_action 03:27:43 INFO - Running post-action listener: set_extra_try_arguments 03:27:43 INFO - ##### 03:27:43 INFO - ##### Running populate-webroot step. 03:27:43 INFO - ##### 03:27:43 INFO - Running pre-action listener: _resource_record_pre_action 03:27:43 INFO - Running main action method: populate_webroot 03:27:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:27:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:27:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:27:43 INFO - '--tppagecycles', 03:27:43 INFO - '7'], 03:27:43 INFO - 'tests': ['tsvgm']}}, 03:27:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:27:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:27:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:27:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:27:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:27:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:27:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:43 INFO - 'talos_options': ['--disable-e10s'], 03:27:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:43 INFO - 'talos_options': ['--disable-e10s'], 03:27:43 INFO - 'tests': ['damp', 'tps']}, 03:27:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:43 INFO - 'tests': ['damp', 'tps']}, 03:27:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:27:43 INFO - 'tests': ['dromaeo_dom']}, 03:27:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:27:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:27:43 INFO - 'tests': ['a11yr', 03:27:43 INFO - 'ts_paint', 03:27:43 INFO - 'tpaint', 03:27:43 INFO - 'sessionrestore', 03:27:43 INFO - 'sessionrestore_no_auto_restore', 03:27:43 INFO - 'tabpaint']}, 03:27:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:27:43 INFO - 'ts_paint', 03:27:43 INFO - 'tpaint', 03:27:43 INFO - 'sessionrestore', 03:27:43 INFO - 'sessionrestore_no_auto_restore', 03:27:43 INFO - 'tabpaint']}, 03:27:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:27:43 INFO - 'ts_paint', 03:27:43 INFO - 'tpaint', 03:27:43 INFO - 'sessionrestore', 03:27:43 INFO - 'sessionrestore_no_auto_restore', 03:27:43 INFO - 'tabpaint']}, 03:27:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:27:43 INFO - 'ts_paint', 03:27:43 INFO - 'tpaint', 03:27:43 INFO - 'sessionrestore', 03:27:43 INFO - 'sessionrestore_no_auto_restore', 03:27:43 INFO - 'tabpaint']}, 03:27:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:27:43 INFO - 'tests': ['a11yr', 03:27:43 INFO - 'ts_paint', 03:27:43 INFO - 'tpaint', 03:27:43 INFO - 'sessionrestore', 03:27:43 INFO - 'sessionrestore_no_auto_restore', 03:27:43 INFO - 'tabpaint']}, 03:27:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:27:43 INFO - 'tests': ['a11yr', 03:27:43 INFO - 'ts_paint', 03:27:43 INFO - 'tpaint', 03:27:43 INFO - 'sessionrestore', 03:27:43 INFO - 'sessionrestore_no_auto_restore', 03:27:43 INFO - 'tabpaint']}, 03:27:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:27:43 INFO - 'tests': ['tsvgx', 03:27:43 INFO - 'tsvgr_opacity', 03:27:43 INFO - 'tart', 03:27:43 INFO - 'tscrollx', 03:27:43 INFO - 'cart']}, 03:27:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:27:43 INFO - 'tsvgr_opacity', 03:27:43 INFO - 'tart', 03:27:43 INFO - 'tscrollx', 03:27:43 INFO - 'cart']}, 03:27:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:43 INFO - 'talos_options': ['--disable-e10s'], 03:27:43 INFO - 'tests': ['tp5o']}, 03:27:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:43 INFO - 'tests': ['tp5o']}, 03:27:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:43 INFO - 'talos_options': ['--disable-e10s', 03:27:43 INFO - '--xperf_path', 03:27:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:43 INFO - 'tests': ['tp5n']}, 03:27:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:43 INFO - 'talos_options': ['--xperf_path', 03:27:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:43 INFO - 'tests': ['tp5n']}}, 03:27:43 INFO - 'talos.zip': {'path': '', 03:27:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:27:43 INFO - Running post-action listener: _resource_record_post_action 03:27:43 INFO - ##### 03:27:43 INFO - ##### Running create-virtualenv step. 03:27:43 INFO - ##### 03:27:43 INFO - Running pre-action listener: _resource_record_pre_action 03:27:43 INFO - Running main action method: create_virtualenv 03:27:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:27:43 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 03:27:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:27:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:27:43 INFO - Using real prefix '/usr' 03:27:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:27:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:45 INFO - Installing pip.................done. 03:27:45 INFO - Return code: 0 03:27:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27:45 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')]} 03:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:45 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')]} 03:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:45 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 0x7f72e2d41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf255a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb4410>, '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 0xfb5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb57a0>, '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': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', '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 03:27:45 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 03:27:45 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 03:27:45 INFO - Using env: {'DISPLAY': ':0', 03:27:45 INFO - 'HOME': '/home/cltbld', 03:27:45 INFO - 'LANG': 'en_US.UTF-8', 03:27:45 INFO - 'LANGUAGE': 'en_US:en', 03:27:45 INFO - 'LOGNAME': 'cltbld', 03:27:45 INFO - 'MAIL': '/var/mail/cltbld', 03:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:45 INFO - 'MOZ_NO_REMOTE': '1', 03:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:45 INFO - 'NO_EM_RESTART': '1', 03:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:45 INFO - 'PWD': '/builds/slave/test', 03:27:45 INFO - 'SHELL': '/bin/bash', 03:27:45 INFO - 'SHLVL': '1', 03:27:45 INFO - 'TERM': 'linux', 03:27:45 INFO - 'TMOUT': '86400', 03:27:45 INFO - 'USER': 'cltbld', 03:27:45 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', 03:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:45 INFO - '_': '/tools/buildbot/bin/python'} 03:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:46 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 03:27:46 INFO - Cleaning up... 03:27:46 INFO - Return code: 0 03:27:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:27:46 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')]} 03:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:46 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')]} 03:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:46 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 0x7f72e2d41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf255a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb4410>, '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 0xfb5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb57a0>, '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': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', '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 03:27:46 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 03:27:46 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 03:27:46 INFO - Using env: {'DISPLAY': ':0', 03:27:46 INFO - 'HOME': '/home/cltbld', 03:27:46 INFO - 'LANG': 'en_US.UTF-8', 03:27:46 INFO - 'LANGUAGE': 'en_US:en', 03:27:46 INFO - 'LOGNAME': 'cltbld', 03:27:46 INFO - 'MAIL': '/var/mail/cltbld', 03:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:46 INFO - 'MOZ_NO_REMOTE': '1', 03:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:46 INFO - 'NO_EM_RESTART': '1', 03:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:46 INFO - 'PWD': '/builds/slave/test', 03:27:46 INFO - 'SHELL': '/bin/bash', 03:27:46 INFO - 'SHLVL': '1', 03:27:46 INFO - 'TERM': 'linux', 03:27:46 INFO - 'TMOUT': '86400', 03:27:46 INFO - 'USER': 'cltbld', 03:27:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', 03:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:46 INFO - '_': '/tools/buildbot/bin/python'} 03:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:46 INFO - Downloading/unpacking psutil>=0.7.1 03:27:46 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 03:27:46 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 03:27:46 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 03:27:46 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 03:27:46 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 03:27:46 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 03:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:48 INFO - Installing collected packages: psutil 03:27:48 INFO - Running setup.py install for psutil 03:27:48 INFO - building 'psutil._psutil_linux' extension 03:27:48 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 03:27:48 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 03:27:48 INFO - building 'psutil._psutil_posix' extension 03:27:48 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 03:27:48 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 03:27:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:48 INFO - Successfully installed psutil 03:27:48 INFO - Cleaning up... 03:27:48 INFO - Return code: 0 03:27:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:48 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 0x7f72e2d41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf255a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb4410>, '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 0xfb5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb57a0>, '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': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', '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 03:27:48 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 03:27:48 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 03:27:48 INFO - Using env: {'DISPLAY': ':0', 03:27:48 INFO - 'HOME': '/home/cltbld', 03:27:48 INFO - 'LANG': 'en_US.UTF-8', 03:27:48 INFO - 'LANGUAGE': 'en_US:en', 03:27:48 INFO - 'LOGNAME': 'cltbld', 03:27:48 INFO - 'MAIL': '/var/mail/cltbld', 03:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:48 INFO - 'MOZ_NO_REMOTE': '1', 03:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:48 INFO - 'NO_EM_RESTART': '1', 03:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:48 INFO - 'PWD': '/builds/slave/test', 03:27:48 INFO - 'SHELL': '/bin/bash', 03:27:48 INFO - 'SHLVL': '1', 03:27:48 INFO - 'TERM': 'linux', 03:27:48 INFO - 'TMOUT': '86400', 03:27:48 INFO - 'USER': 'cltbld', 03:27:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', 03:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:48 INFO - '_': '/tools/buildbot/bin/python'} 03:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:27:49 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 03:27:49 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 03:27:49 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 03:27:49 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 03:27:49 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 03:27:49 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 03:27:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:27:51 INFO - Installing collected packages: mozsystemmonitor 03:27:51 INFO - Running setup.py install for mozsystemmonitor 03:27:51 INFO - Successfully installed mozsystemmonitor 03:27:51 INFO - Cleaning up... 03:27:51 INFO - Return code: 0 03:27:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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', '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 0x7f72e2d41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf255a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb4410>, '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 0xfb5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb57a0>, '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': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', '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 03:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:27: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 blobuploader==1.2.4 03:27:51 INFO - Using env: {'DISPLAY': ':0', 03:27:51 INFO - 'HOME': '/home/cltbld', 03:27:51 INFO - 'LANG': 'en_US.UTF-8', 03:27:51 INFO - 'LANGUAGE': 'en_US:en', 03:27:51 INFO - 'LOGNAME': 'cltbld', 03:27:51 INFO - 'MAIL': '/var/mail/cltbld', 03:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:51 INFO - 'MOZ_NO_REMOTE': '1', 03:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:51 INFO - 'NO_EM_RESTART': '1', 03:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:51 INFO - 'PWD': '/builds/slave/test', 03:27:51 INFO - 'SHELL': '/bin/bash', 03:27:51 INFO - 'SHLVL': '1', 03:27:51 INFO - 'TERM': 'linux', 03:27:51 INFO - 'TMOUT': '86400', 03:27:51 INFO - 'USER': 'cltbld', 03:27:51 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', 03:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:51 INFO - '_': '/tools/buildbot/bin/python'} 03:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:54 INFO - Downloading docopt-0.6.1.tar.gz 03:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:54 INFO - Running setup.py install for blobuploader 03:27:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:54 INFO - Running setup.py install for requests 03:27:54 INFO - Running setup.py install for docopt 03:27:54 INFO - Successfully installed blobuploader requests docopt 03:27:54 INFO - Cleaning up... 03:27:54 INFO - Return code: 0 03:27:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:54 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 0x7f72e2d41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf255a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb4410>, '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 0xfb5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb57a0>, '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': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', '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 03:27:54 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 03:27:54 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 03:27:54 INFO - Using env: {'DISPLAY': ':0', 03:27:54 INFO - 'HOME': '/home/cltbld', 03:27:54 INFO - 'LANG': 'en_US.UTF-8', 03:27:54 INFO - 'LANGUAGE': 'en_US:en', 03:27:54 INFO - 'LOGNAME': 'cltbld', 03:27:54 INFO - 'MAIL': '/var/mail/cltbld', 03:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:54 INFO - 'MOZ_NO_REMOTE': '1', 03:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:54 INFO - 'NO_EM_RESTART': '1', 03:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:54 INFO - 'PWD': '/builds/slave/test', 03:27:54 INFO - 'SHELL': '/bin/bash', 03:27:54 INFO - 'SHLVL': '1', 03:27:54 INFO - 'TERM': 'linux', 03:27:54 INFO - 'TMOUT': '86400', 03:27:54 INFO - 'USER': 'cltbld', 03:27:54 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', 03:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:54 INFO - '_': '/tools/buildbot/bin/python'} 03:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:54 INFO - Running setup.py (path:/tmp/pip-s8dBEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:54 INFO - Running setup.py (path:/tmp/pip-Es_QAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:55 INFO - Running setup.py (path:/tmp/pip-jb6JKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:55 INFO - Running setup.py (path:/tmp/pip-s46Xg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:55 INFO - Running setup.py (path:/tmp/pip-J03IHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:55 INFO - Running setup.py (path:/tmp/pip-z6Nkek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:55 INFO - Running setup.py (path:/tmp/pip-nl2XXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:55 INFO - Running setup.py (path:/tmp/pip-lQr7Gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:55 INFO - Running setup.py (path:/tmp/pip-4lXGGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:55 INFO - Running setup.py (path:/tmp/pip-yQium4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:55 INFO - Running setup.py (path:/tmp/pip-GazRT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:55 INFO - Running setup.py (path:/tmp/pip-_tl9ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:55 INFO - Running setup.py (path:/tmp/pip-RONuob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:55 INFO - Running setup.py (path:/tmp/pip-OMqQsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:55 INFO - Running setup.py (path:/tmp/pip-MEWEGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:56 INFO - Running setup.py (path:/tmp/pip-ECCPmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:56 INFO - Running setup.py (path:/tmp/pip-GPz8LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:56 INFO - Running setup.py install for manifestparser 03:27:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:56 INFO - Running setup.py install for mozcrash 03:27:56 INFO - Running setup.py install for mozdebug 03:27:56 INFO - Running setup.py install for mozdevice 03:27:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:27:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:56 INFO - Running setup.py install for mozfile 03:27:56 INFO - Running setup.py install for mozhttpd 03:27:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:56 INFO - Running setup.py install for mozinfo 03:27:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:56 INFO - Running setup.py install for mozInstall 03:27:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:56 INFO - Running setup.py install for mozleak 03:27:57 INFO - Running setup.py install for mozlog 03:27:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for moznetwork 03:27:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozprocess 03:27:57 INFO - Running setup.py install for mozprofile 03:27:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozrunner 03:27:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozscreenshot 03:27:57 INFO - Running setup.py install for moztest 03:27:57 INFO - Running setup.py install for mozversion 03:27:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:57 INFO - Cleaning up... 03:27:57 INFO - Return code: 0 03:27:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:57 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 0x7f72e2d41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf255a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb4410>, '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 0xfb5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb57a0>, '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': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', '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 03:27:57 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 03:27:57 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 03:27:57 INFO - Using env: {'DISPLAY': ':0', 03:27:57 INFO - 'HOME': '/home/cltbld', 03:27:57 INFO - 'LANG': 'en_US.UTF-8', 03:27:57 INFO - 'LANGUAGE': 'en_US:en', 03:27:57 INFO - 'LOGNAME': 'cltbld', 03:27:57 INFO - 'MAIL': '/var/mail/cltbld', 03:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:57 INFO - 'MOZ_NO_REMOTE': '1', 03:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:57 INFO - 'NO_EM_RESTART': '1', 03:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:57 INFO - 'PWD': '/builds/slave/test', 03:27:57 INFO - 'SHELL': '/bin/bash', 03:27:57 INFO - 'SHLVL': '1', 03:27:57 INFO - 'TERM': 'linux', 03:27:57 INFO - 'TMOUT': '86400', 03:27:57 INFO - 'USER': 'cltbld', 03:27:57 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', 03:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:57 INFO - '_': '/tools/buildbot/bin/python'} 03:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:58 INFO - Running setup.py (path:/tmp/pip-4ipGK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:58 INFO - Running setup.py (path:/tmp/pip-Bt_GPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:58 INFO - Running setup.py (path:/tmp/pip-IAAbbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:58 INFO - Running setup.py (path:/tmp/pip-OaXcK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:58 INFO - Running setup.py (path:/tmp/pip-9gWDIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:58 INFO - Running setup.py (path:/tmp/pip-f41xeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:58 INFO - Running setup.py (path:/tmp/pip-oC0zvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:58 INFO - Running setup.py (path:/tmp/pip-x5Ldyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:58 INFO - Running setup.py (path:/tmp/pip-rUbr2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:58 INFO - Running setup.py (path:/tmp/pip-e0vfmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:58 INFO - Running setup.py (path:/tmp/pip-scyFwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:58 INFO - Running setup.py (path:/tmp/pip-3HdLuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:59 INFO - Running setup.py (path:/tmp/pip-m6j7zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:59 INFO - Running setup.py (path:/tmp/pip-EzWsQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:59 INFO - Running setup.py (path:/tmp/pip-Zv216w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:59 INFO - Running setup.py (path:/tmp/pip-fJPOjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:59 INFO - Running setup.py (path:/tmp/pip-Eysi36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:59 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)) 03:27:59 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)) 03:27:59 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)) 03:27:59 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)) 03:27:59 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)) 03:27:59 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)) 03:27:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:59 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 03:27:59 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 03:27:59 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 03:27:59 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 03:27:59 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 03:27:59 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 03:28:01 INFO - Downloading blessings-1.6.tar.gz 03:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:01 INFO - Installing collected packages: blessings 03:28:01 INFO - Running setup.py install for blessings 03:28:01 INFO - Successfully installed blessings 03:28:01 INFO - Cleaning up... 03:28:01 INFO - Return code: 0 03:28:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:01 INFO - Reading from file tmpfile_stdout 03:28:01 INFO - Current package versions: 03:28:01 INFO - argparse == 1.2.1 03:28:01 INFO - blessings == 1.6 03:28:01 INFO - blobuploader == 1.2.4 03:28:01 INFO - docopt == 0.6.1 03:28:01 INFO - manifestparser == 1.1 03:28:01 INFO - mozInstall == 1.12 03:28:01 INFO - mozcrash == 0.17 03:28:01 INFO - mozdebug == 0.1 03:28:01 INFO - mozdevice == 0.48 03:28:01 INFO - mozfile == 1.2 03:28:01 INFO - mozhttpd == 0.7 03:28:01 INFO - mozinfo == 0.9 03:28:01 INFO - mozleak == 0.1 03:28:01 INFO - mozlog == 3.1 03:28:01 INFO - moznetwork == 0.27 03:28:01 INFO - mozprocess == 0.22 03:28:01 INFO - mozprofile == 0.28 03:28:01 INFO - mozrunner == 6.11 03:28:01 INFO - mozscreenshot == 0.1 03:28:01 INFO - mozsystemmonitor == 0.0 03:28:01 INFO - moztest == 0.7 03:28:01 INFO - mozversion == 1.4 03:28:01 INFO - psutil == 3.1.1 03:28:01 INFO - requests == 1.2.3 03:28:01 INFO - wsgiref == 0.1.2 03:28:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:01 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 0x7f72e2d41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf255a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb4410>, '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 0xfb5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb57a0>, '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': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', '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 03:28:01 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 03:28:01 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 03:28:01 INFO - Using env: {'DISPLAY': ':0', 03:28:01 INFO - 'HOME': '/home/cltbld', 03:28:01 INFO - 'LANG': 'en_US.UTF-8', 03:28:01 INFO - 'LANGUAGE': 'en_US:en', 03:28:01 INFO - 'LOGNAME': 'cltbld', 03:28:01 INFO - 'MAIL': '/var/mail/cltbld', 03:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:01 INFO - 'MOZ_NO_REMOTE': '1', 03:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:01 INFO - 'NO_EM_RESTART': '1', 03:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:01 INFO - 'PWD': '/builds/slave/test', 03:28:01 INFO - 'SHELL': '/bin/bash', 03:28:01 INFO - 'SHLVL': '1', 03:28:01 INFO - 'TERM': 'linux', 03:28:01 INFO - 'TMOUT': '86400', 03:28:01 INFO - 'USER': 'cltbld', 03:28:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', 03:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:01 INFO - '_': '/tools/buildbot/bin/python'} 03:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:01 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)) 03:28:01 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)) 03:28:01 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)) 03:28:01 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)) 03:28:01 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)) 03:28:01 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)) 03:28:01 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)) 03:28:01 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)) 03:28:01 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)) 03:28:01 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)) 03:28:01 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)) 03:28:01 INFO - Cleaning up... 03:28:01 INFO - Return code: 0 03:28:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:01 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 0x7f72e2d41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf255a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb4410>, '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 0xfb5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb57a0>, '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': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', '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 03:28:01 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 03:28:01 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 03:28:01 INFO - Using env: {'DISPLAY': ':0', 03:28:01 INFO - 'HOME': '/home/cltbld', 03:28:01 INFO - 'LANG': 'en_US.UTF-8', 03:28:01 INFO - 'LANGUAGE': 'en_US:en', 03:28:01 INFO - 'LOGNAME': 'cltbld', 03:28:01 INFO - 'MAIL': '/var/mail/cltbld', 03:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:01 INFO - 'MOZ_NO_REMOTE': '1', 03:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:01 INFO - 'NO_EM_RESTART': '1', 03:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:01 INFO - 'PWD': '/builds/slave/test', 03:28:01 INFO - 'SHELL': '/bin/bash', 03:28:01 INFO - 'SHLVL': '1', 03:28:01 INFO - 'TERM': 'linux', 03:28:01 INFO - 'TMOUT': '86400', 03:28:01 INFO - 'USER': 'cltbld', 03:28:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', 03:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:01 INFO - '_': '/tools/buildbot/bin/python'} 03:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:02 INFO - Downloading/unpacking jsonschema 03:28:02 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 03:28:02 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 03:28:02 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 03:28:02 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 03:28:02 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 03:28:02 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 03:28:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:04 INFO - Downloading/unpacking functools32 (from jsonschema) 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:04 INFO - warning: no files found matching '*.txt' 03:28:04 INFO - no previously-included directories found matching 'build' 03:28:04 INFO - no previously-included directories found matching 'dist' 03:28:04 INFO - no previously-included directories found matching '.git*' 03:28:04 INFO - Installing collected packages: jsonschema, functools32 03:28:04 INFO - Running setup.py install for functools32 03:28:04 INFO - warning: no files found matching '*.txt' 03:28:04 INFO - no previously-included directories found matching 'build' 03:28:04 INFO - no previously-included directories found matching 'dist' 03:28:04 INFO - no previously-included directories found matching '.git*' 03:28:04 INFO - Successfully installed jsonschema functools32 03:28:04 INFO - Cleaning up... 03:28:04 INFO - Return code: 0 03:28:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:04 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 0x7f72e2d41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf255a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb4410>, '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 0xfb5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb57a0>, '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': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', '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 03:28:04 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 03:28:04 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 03:28:04 INFO - Using env: {'DISPLAY': ':0', 03:28:04 INFO - 'HOME': '/home/cltbld', 03:28:04 INFO - 'LANG': 'en_US.UTF-8', 03:28:04 INFO - 'LANGUAGE': 'en_US:en', 03:28:04 INFO - 'LOGNAME': 'cltbld', 03:28:04 INFO - 'MAIL': '/var/mail/cltbld', 03:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:04 INFO - 'MOZ_NO_REMOTE': '1', 03:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:04 INFO - 'NO_EM_RESTART': '1', 03:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:04 INFO - 'PWD': '/builds/slave/test', 03:28:04 INFO - 'SHELL': '/bin/bash', 03:28:04 INFO - 'SHLVL': '1', 03:28:04 INFO - 'TERM': 'linux', 03:28:04 INFO - 'TMOUT': '86400', 03:28:04 INFO - 'USER': 'cltbld', 03:28:04 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', 03:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:04 INFO - '_': '/tools/buildbot/bin/python'} 03:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:04 INFO - Downloading/unpacking flake8 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 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 03:28:04 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 03:28:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:28:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:28:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:28:07 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 03:28:07 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 03:28:07 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 03:28:07 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 03:28:07 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 03:28:07 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 03:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:28:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:07 INFO - no previously-included directories found matching 'docs/_build' 03:28:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:28:07 INFO - Running setup.py install for pep8 03:28:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:07 INFO - no previously-included directories found matching 'docs/_build' 03:28:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:28:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:28:07 INFO - Cleaning up... 03:28:07 INFO - Return code: 0 03:28:07 INFO - Running post-action listener: _resource_record_post_action 03:28:07 INFO - Running post-action listener: _start_resource_monitoring 03:28:07 INFO - Starting resource monitoring. 03:28:07 INFO - ##### 03:28:07 INFO - ##### Running install step. 03:28:07 INFO - ##### 03:28:07 INFO - Running pre-action listener: _resource_record_pre_action 03:28:07 INFO - Running main action method: install 03:28:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:07 INFO - Reading from file tmpfile_stdout 03:28:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:07 INFO - Reading from file tmpfile_stdout 03:28:07 INFO - Output received: 03:28:07 INFO - Usage: mozinstall [options] installer 03:28:07 INFO - Options: 03:28:07 INFO - -h, --help show this help message and exit 03:28:07 INFO - -d DEST, --destination=DEST 03:28:07 INFO - Directory to install application into. [default: 03:28:07 INFO - "/builds/slave/test"] 03:28:07 INFO - --app=APP Application being installed. [default: firefox] 03:28:07 INFO - mkdir: /builds/slave/test/build/application 03:28:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:28:23 INFO - Reading from file tmpfile_stdout 03:28:23 INFO - Output received: 03:28:23 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:23 INFO - Running post-action listener: _resource_record_post_action 03:28:23 INFO - ##### 03:28:23 INFO - ##### Running run-tests step. 03:28:23 INFO - ##### 03:28:23 INFO - Running pre-action listener: _resource_record_pre_action 03:28:23 INFO - Running main action method: run_tests 03:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:23 INFO - Python 2.7.3 03:28:23 INFO - Return code: 0 03:28:23 INFO - grabbing minidump binary from tooltool 03:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:23 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 0xfb4410>, '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 0xfb5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:23 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 03:28:23 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 03:28:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:23 INFO - Return code: 0 03:28:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:28:24 INFO - Return code: 0 03:28:24 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/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 03:28:24 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/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 03:28:24 INFO - Using env: {'DISPLAY': ':0', 03:28:24 INFO - 'HOME': '/home/cltbld', 03:28:24 INFO - 'LANG': 'en_US.UTF-8', 03:28:24 INFO - 'LANGUAGE': 'en_US:en', 03:28:24 INFO - 'LOGNAME': 'cltbld', 03:28:24 INFO - 'MAIL': '/var/mail/cltbld', 03:28:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:24 INFO - 'MOZ_NO_REMOTE': '1', 03:28:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:24 INFO - 'NO_EM_RESTART': '1', 03:28:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:24 INFO - 'PWD': '/builds/slave/test', 03:28:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:24 INFO - 'SHELL': '/bin/bash', 03:28:24 INFO - 'SHLVL': '1', 03:28:24 INFO - 'TERM': 'linux', 03:28:24 INFO - 'TMOUT': '86400', 03:28:24 INFO - 'USER': 'cltbld', 03:28:24 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690', 03:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:24 INFO - '_': '/tools/buildbot/bin/python'} 03:28:24 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/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 03:28:24 INFO - mozversion application_buildid: 20160527004031 03:28:24 INFO - mozversion application_changeset: 9cbc4f2d34a30255c3a093f6005f87b453491a7a 03:28:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:28:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:24 INFO - mozversion application_name: Firefox 03:28:24 INFO - mozversion application_remotingname: firefox-dev 03:28:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:24 INFO - mozversion application_vendor: Mozilla 03:28:24 INFO - mozversion application_version: 48.0a2 03:28:24 INFO - mozversion platform_buildid: 20160527004031 03:28:24 INFO - mozversion platform_changeset: 9cbc4f2d34a30255c3a093f6005f87b453491a7a 03:28:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:24 INFO - mozversion platform_version: 48.0a2 03:28:24 INFO - using testdate: 1464344904 03:28:24 INFO - actual date: 1464344904 03:28:24 INFO - starting webserver on 'localhost:33376' 03:28:24 INFO - SUITE-START | Running 2 tests 03:28:24 INFO - TEST-START | dromaeo_css 03:28:24 INFO - operating with platform_type : linux_ 03:28:24 INFO - Initialising browser for dromaeo_css test... 03:28:24 INFO - TEST-INFO | started process 11373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2x6fba/profile http://localhost:33376/getInfo.html) 03:28:28 INFO - PROCESS | 11373 | 03:28:28 INFO - PROCESS | 11373 | (process:11451): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:28:29 INFO - PROCESS | 11373 | __metrics Screen width/height:1600/1200 03:28:29 INFO - PROCESS | 11373 | colorDepth:24 03:28:29 INFO - PROCESS | 11373 | Browser inner width/height: 1024/697 03:28:29 INFO - PROCESS | 11373 | __metrics 03:28:30 ERROR - PROCESS | 11373 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:28:31 INFO - TEST-INFO | 11373: exit 0 03:28:31 INFO - Browser initialized. 03:28:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:31 INFO - TEST-INFO | started process 11502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2x6fba/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:32 INFO - PROCESS | 11502 | 03:28:32 INFO - PROCESS | 11502 | (process:11571): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:28:42 INFO - PROCESS | 11502 | RSS: Main: 151838720 03:28:42 INFO - PROCESS | 11502 | 03:29:32 INFO - PROCESS | 11502 | 1464344972411 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] 03:31:40 INFO - PROCESS | 11502 | Cycle 1(1): loaded http://localhost:33376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33376/tests/dromaeo/cssquery-ext.html) 03:31:41 INFO - PROCESS | 11502 | RSS: Main: 155471872 03:31:41 INFO - PROCESS | 11502 | 03:34:43 INFO - PROCESS | 11502 | Cycle 1(1): loaded http://localhost:33376/tests/dromaeo/cssquery-ext.html (next: http://localhost:33376/tests/dromaeo/cssquery-jquery.html) 03:34:43 INFO - PROCESS | 11502 | RSS: Main: 152887296 03:34:43 INFO - PROCESS | 11502 | 03:37:45 INFO - PROCESS | 11502 | Cycle 1(1): loaded http://localhost:33376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33376/tests/dromaeo/cssquery-mootools.html) 03:37:46 INFO - PROCESS | 11502 | RSS: Main: 152940544 03:37:46 INFO - PROCESS | 11502 | 03:40:47 INFO - PROCESS | 11502 | Cycle 1(1): loaded http://localhost:33376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33376/tests/dromaeo/cssquery-prototype.html) 03:40:48 INFO - PROCESS | 11502 | RSS: Main: 152727552 03:40:48 INFO - PROCESS | 11502 | 03:43:50 INFO - PROCESS | 11502 | Cycle 1(1): loaded http://localhost:33376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33376/tests/dromaeo/cssquery-yui.html) 03:43:51 INFO - PROCESS | 11502 | RSS: Main: 154464256 03:43:51 INFO - PROCESS | 11502 | 03:46:53 INFO - PROCESS | 11502 | Cycle 1(1): loaded http://localhost:33376/tests/dromaeo/cssquery-yui.html (next: http://localhost:33376/tests/dromaeo/cssquery-dojo.html) 03:46:53 INFO - PROCESS | 11502 | RSS: Main: 155795456 03:46:53 INFO - PROCESS | 11502 | 03:46:53 INFO - PROCESS | 11502 | __start_tp_report 03:46:53 INFO - PROCESS | 11502 | _x_x_mozilla_page_load 03:46:53 INFO - PROCESS | 11502 | _x_x_mozilla_page_load_details 03:46:53 INFO - PROCESS | 11502 | |i|pagename|runs| 03:46:53 INFO - PROCESS | 11502 | |0;dojo.html;3384.2047118927053;3461.10011397037;3463.982680086599;3499.5100685903963;3513.051476101453;5714.457126572979;5730.713464326783;5739.417262231997;5745.683987380692;5754.539636829054;5667.688277144755;5747.281589801275;5747.885042299152;5752.453516915886;5756.7409466574;5052.065367906949;5177.068127737006;5200.843974680747;5232.215167724834;5272.657277276984;5032.396112466509;5157.4068982067165;5280.392754833186;5318.069337865877;5331.493508116722;5109.156989096795;5118.462561431052;5198.610104242178;5202.609804264676;5204.375474942994;5218.739063046833;5223.138182199932;5260.868478288055;5266.710330931797;5304.496072873071;5012.949870501321;5116.411612664517;5184.040952423776;5202.2456743771945;5247.134222853225;5622.91565626516;5629.774809007676;5635.3237611486475;5652.74562644682;5656.236408084897;6084.361142080106;6125.754969801247;6133.233345831771;6140.508759299245;6158.3841615838055;6075.02799552074;6097.146399504073;6183.103449999725;6190.195274614316;6208.286047104551;5799.4780469757925;5805.01314776489;5809.912851307234;5823.184754134425;5848.035074212749;6282.968585157045;6334.986402175629;6373.553851230369;6373.968130159412;6387.457066149336;5706.600537962303;5862.208601838697;5961.910571341434;6131.63210207389;6134.601250918676;5959.731812068468;5959.880802383928;5963.821085367446;5975.372585878507;5977.193078934288;5882.176495290662;5894.115882617556;5933.614315069593;5944.167816505693;5950.047992321208;5952.9107063394085;6110.725017374229;6121.204243448412;6138.296437970319;6154.476869466145;4551.431071116111;4555.453345598549;4561.498235194126;4574.4968053514085;4575.3823233863;4048.736832105904;4073.6333729963853;4091.5499295077516;4097.242010228118;4105.97947010263;5570.721463926788;5794.1308803679785;5814.156947242626;5860.8534786629825;5873.676947767914;5994.1608174855555;6045.758169673251;6068.271807383142;6076.665783381956;6116.755329786759;5604.6917419541505;5788.565857560699;5794.275715535558;5795;5802.361740208574;4967.552920237196;5001.274815151783;5004.974975125101;5009.524095210949;5032.220005899091;6228.657423841732;6231.22109736283;6249;6252.062190671436;6270.7491700331475;6055.969720151371;6082.695865206811;6091.817245482643;6094.847628809315;6123.679189354688;6325.746970121144;6358.809235722936;6375.649339286384;6376;6423.293437721753;6037.879242415215;6065.54508411862;6067.150598916243;6073.635581865102;6084.39156084388;5969;6045.848853778691;6116.602420842631;6154.446099851035;6199.56603037783;5956.493698035715;5973.5519836013345;5992.64044157352;6004.759809607567;6023.096535519707;5911.113332999912;5948.078047902582;5963.9105413417965;5976.701164941648;5980.401959804159;5778.306603207642;5829.038208695687;5834.912476312944;5859.853503662443;5867.031939729897;5895.380984996514;5943.257092863392;5955.702214889325;5977.3126090500145;5992.460678538952;5782.768689252551;5793.478586927196;5809.128630705259;5815.534757219328;5843.2403787507355 03:46:53 INFO - PROCESS | 11502 | |1;ext.html;663.0154220981841;671.986560268795;680.2585182151454;724.4023680463619;740.1968863782795;38505.22989540211;40043;40207.79896100519;40225.7988710056;40307.19385612286;42702.35946460805;43245.56754432455;43325.78337108318;43424.78287608566;43508;8635.395522313425;8776.297896168291;8842.115788421139;8842.690505832297;8873.378863479558;8724.040355560883;8821.294296456268;8850.336224783136;8862.24670902974;8868.37921345506;9084.454932704026;9126;9156.542172891362;9204.539773011356;9238.907610923872;9062.048484909088;9081.364304498687;9118.042605526423;9144.588493517775;9162.816743665157;8956.596953137125;9045.185933265971;9075.500847453388;9103;9107.59015844282;41958.37062444066;42224.57775422268;42707;42735.35896961548;42756.358654620206;3862.517185351831;3878.398848178537;3930.960690393088;4165.500139983222;4571.2000399929875;32333;32351.51472727911;32483.67516324854;32573.511397329057;33323.500147497805;4602.263637817967;4633.559811817906;4680.578747912704;4740.478547359788;4750.406199225097;303561;303896;305258;305483;305547;38925.80537097353;39495.21009579792;39564.60435395667;39569.40645890314;62605.68697156576;37659;37856.810715946245;37914.43128353077;37973;38033.42949855755;17730.91134544319;17889.37387191442;17938.641227175645;17978.64042719138;18033.909830450764;14932.552023439097;15124;15175.696486070217;15220;15355.232238388036;9330.113639204264;9377.718668439958;9399.34204605671;9450.57472413743;9468.57391417388;3610.9277814443562;3622.6558476944647;3644.362236608583;3654.4518322251342;3686.5760437550025;1113.8440618313443;1148.190525679394;1165.4231155578043;1166.0904494494307;1214.6173955204083;33147.834260829026;33384.49923251153;33436.331273374395;33767.662323376455;34368.82815585956;1214.520264495537;1255.8681338459512;1287.4528325461642;1298.688314804459;1368.4115830192914;17293.78545191024;17366.39217627377;17409.564760880825;17463.56341091483;17483.300667973137;472872;558131;570607;873308;884456;62571.687141564;62862.685686571276;62895.68552157302;63623;63739;1543.1821134798574;1548.4270819796523;1557.929893154788;1561.3832536148159;1563.6950794595173;32646;32778.83610581932;33029.834850825595;33328.166795829326;34002;54414.727926360116;54830.725846370515;55345.723271384995;55446.72276638591;55448.168277475066;432336;434891;436658;436994;437992;30801.691983079883;30888.845555772077;30937.226569335948;30967.225819354695;31118.84440577873;49148;49546.752266238436;50354.244686329;50415.24377134273;50427.49572504228;41295.58704412918;41536.37695434631;41985.37021944612;42866.357004644335;43007.78496107499;41544.376834346906;42381.788091059345;42464.57535424606;42814.78592607017;42862.35706464343;43403.348949765146;43721.344179837964;43989.560104399825;44400.77799610981;44478.332825007004;36141.63858361488;36194.819025904704;36296;36548.81725591355;37192.44211336886;29109.416283331975;29410.264743381587;29600.703992959796;29657.406851863274;30149.69850301469 03:46:53 INFO - PROCESS | 11502 | |2;jquery.html;429.7958469726879;436.4675096382412;438.85896668661485;441.4129208153156;450.83769842856543;18216.180271887763;18413.355532556365;18838.34065807697;18886;18899.716504252447;18356.908215458938;18497.35259265926;18681.626367472643;19123.521911952208;19208.903955480204;5363.088274993261;5383.865403364927;5501.862453438656;5916.940830591682;5942.078977758454;5791.276090488689;5843.18195452637;5849.356570777232;5871.618344807595;5884.588078834483;5382.407935127133;5400.513953744162;5545.390007099216;5820.38885916979;5864.941350586482;5358.410574836765;5386.1920711893135;5390.272313237702;5412.648177868466;5422.728863556826;5140.254663073833;5159.664621799571;5302.734863256822;5319.2287118368;5335.733213339357;13141.408636611375;13394.397252123677;13421.932890335584;13446.663833404145;13489.932550337186;2342.5900467418132;2418.830681852271;2444.4377793107683;2504.336350867022;2616.175904590048;10803.621873234477;10920.726981825439;10926.890731092746;10995.175361847894;11138.944305278503;1963.391348681899;2089.1956596710224;2106.799854013866;2115.545157791082;2163.329367895957;75373;76948.61525692335;79112.60443697745;79920;80721;11630.825537616942;11693.532258709556;11841;11857.288562686093;11949.522019119138;17027.48917532476;17036.659266814593;17054.74417883733;17189.82810171907;17190.31238750436;8849.867251991225;9184.678536251198;9218.124278193562;9225.815483690423;9306.86039709405;8914.86627700585;9020.14308640678;9036.8644470333;9051.81896362069;9151.816963660689;5022.6233032522705;5077.416097148801;5100.1074811907765;5105.055564720538;5112.182050871843;2079.2826474866147;2087.979120208809;2114.3868278199457;2125.5217576045266;2146.84972051958;1020.3265844542566;1047.4291511126303;1090.5801266512449;1109.1958330210532;1119.7592517608591;18701.532461688294;19148.712769308473;19399.515012124808;19470.513237169183;19592;1092.4869056357002;1094.5731164845718;1099.8295264234057;1107.5514416661265;1158.1024705852863;10528.842067368996;10885.619003334845;10928.945355273332;10956.28784129029;10996.725081873017;510363;516789;533924;544124;548667;73971;88504;92529.53735231416;92611.07388926159;94048.52975735214;1119.647311097018;1154.8729639739454;1171.6485054483621;1176.7705297466912;1194.6714653470192;17318.785805219566;17776;17815.376461823773;17833.554161145556;17992.730109048112;38914.416283756334;40083.398749018204;40303.39544906888;41263.1747365057;42373.36439953341;60138;60625;60925.39074609197;61002.69498652478;61668.691656543226;9168.299944643171;9248.352615316864;9259.67591134307;9356;9366.484843333683;12554;12756;12879.227246365248;13326.666833328856;13506.729865402833;11360.602378917029;11422.714432139262;11607;11671.88328116708;11862.822057669315;11239.494222760159;11275.718107047389;11459.885401146215;11573.710657233636;11697.2981621103;11638.70903227426;11792.174547781917;11950.163488555718;12124.090693198223;12260.38698065111;8999.235065019286;9044.276457883221;9101.40840845343;9158.084191580789;9297.488638124969;11661.35862527569;11762.823557646814;11777.352245626573;11966.341851198267;12022.699432514257 03:46:53 INFO - PROCESS | 11502 | |3;mootools.html;1608.5094046315874;1608.8793340499458;1805.5215367927494;1900.2399040383852;1908.2843933524928;8413.705520306783;8557.101504342048;8643.654253829847;8658.783530411743;8720.8691869622;8656.610452529636;8671.523066231355;8683.826323473526;8736.082711315315;8742.606582703778;2441.2798224523717;2468.123816045305;2487.092211342865;2492.9002839886384;2497.163450244161;2465.778079972802;2520.974790252092;2539.7968162547045;2542.529632018083;2543.682039745032;2471.270975062352;2479.913203037894;2486.8010559155314;2487.8507289562594;2508.272600945733;2462.741412151725;2463.59350707134;2483.937901552458;2488.8880000400027;2489.9253022409175;2505.887235074426;2507.1601013660447;2513.6857892763405;2527.862461892156;2533.936651583707;8732.563371831384;8751.693690720795;8752.606132724042;8780.956095219546;8811.339149563808;5501.752421141058;5588.552915766729;5622.859428514279;5623.044082505984;5625.5218306444;3346.7991920484606;3357.1103657530775;3389.610194827602;3460.3944309745943;3491.8428670709877;1027.5222021759917;1031.9690409287734;1051.5373235776235;1066.7546464313252;1096.4353358020626;12063.396830158457;12177.33024683642;12186.695332616668;12224.388780561025;12236.388180590935;4811.879703007453;4816.979728751659;4837.782299796518;4890.315355850184;4931.309616653672;10487.790244195074;10497.47512624381;10515.106215971575;10548;10644.201684873666;5532.5573954083575;5555.527780138734;5557.833265002057;5570.053090974463;5571.832845014656;4462.799174037176;4858.5384388483035;4913.533214344631;4955.256711493233;5083.339165908408;4179.582041795857;4184.079502509443;4242.53332133465;4264.594863487963;4310.52584215736;1299.9025073119553;1304.4390911907972;1330.602866989657;1352.1954437109903;1365.378752667534;893.2898345815092;987.4519641598981;1034.3690348887174;1036.5957276662107;1057.7408534908996;5867.20792692981;5939.524838012949;5963.850903727442;6013.759449622054;6054.485368743706;469.96945198561986;470.80226304952004;478.18469509486243;485.06382681425185;488.8680056384756;4239.173361194599;4281.293586558245;4291.54938731435;4301.3117901135665;4322.222000040023;10296.691099267035;10644.095251903675;10657.573697052187;10662.786744265071;10782.35305881634;9835.262355323379;9892.703218903445;10008.349457285252;10023.498825058718;10389.116925061304;8113.553754543556;8124.2688158064875;8186.631601577943;8241;8259.504429734236;5793.246877905845;5914.615549989237;6053.3946605339115;6054.8183554493435;6191.25704915395;9249.398789078688;9254.444733316022;9296.488693121673;9502.287328450531;9555.713328600154;9536.952315238379;9541.47521886303;9598.18415434668;9613.711588652352;9948.403095813985;6721.831954200989;7220.855582888208;7384.113906331275;7445.10658720957;7490.925090749023;8164.510129392255;8185.4270201085355;8195;8199.139090395423;8211.794705132419;7340.265973402617;7543;7606.847863042819;7622.31399174077;7657.425693072931;7442.813929651802;7555.848883022199;7563.924360756322;7565.470417070972;7606.429517786078;6174.567780255518;6213.161223234805;6259.248890133031;6286.119943207863;6287.779927702692;4838.975805120952;4951.158303088411;5051.87370315745;5054.368203974504;5168.741562921914;4764.213904705824;4764.809407623795;4820.30105634674;4850.53919877611;4871.9269210962575 03:46:53 INFO - PROCESS | 11502 | |4;prototype.html;336.94608862581987;340.93692666856634;344.68289173959954;356.8126733464932;361.50834864584175;6670.099536562562;6715.630640314781;6725.9327406725915;6762.628055456948;6779.999999999994;6583.37457941496;6609;6621.039949207362;6641.203055633318;6651.933480665192;4754.3106249593875;4891.413030436335;5004.249362595603;5016.322796422491;5028.094942910275;4971.130052240844;4984.526469985363;5009.073321435528;5009.724465154415;5030;4914.385701787277;4924.80300787968;4947.381577302837;4962.057209130272;4969.2049272116465;4944.134776414131;4947.975260123694;4966.130927087764;4967.602591792648;4975;4308.763018034007;4339.609435150852;4340.761258130801;4343.174796788631;4346.043870348518;6287.9685601572155;6388.840278993016;6402.711877965503;6432.9678351607945;6443;5781.653100813965;5808.59339846211;5813.273340832396;5823.505002074829;5847;6962.825929351756;6980.16238051432;7001.36987671112;7007.404370628503;7026;4804.20730579454;4809.278608208797;4817.470078291385;4819.1325561398935;4832.081904438145;7187.496875218737;7265.4187664986675;7324.487285889936;7335.376492998102;7337.3029562191505;4850.75746212688;4885.291632713237;4923.876903077452;4931.926021109686;4933.0627180836245;4945.208766597327;4977.104121258136;4979.053979743837;4983.426905905795;4986.401631804207;5770.047942089508;5774.88450230993;5785.768569257182;5791;5805.593608447452;7028.121484814398;7048.154221493351;7081.185663648746;7088.936659501116;7090.503664743418;1760.7182850744075;1776.191832716111;1776.7601373814628;1777.8222177782118;1781.056040298644;1088.4992903264588;1106.4025426269884;1121.7363919478917;1125.1111621818673;1155.4915837031679;6764.323567643196;6798;6808.5914845109455;6810.455163586901;6824.41992430639;7145.714171433188;7249.492535522463;7276.272372762787;7284.307990740871;7289.817754556072;6800.115984922028;6880.346367095118;6895.172579290517;6900.102986611809;6907.965460172667;3943.960560394359;3972.245273398045;4003.619656132663;4005.138895137501;4009.659178969762;7656.808579785438;7664.195259497784;7667.578283194478;7689.692412303557;7706.614669266514;7306.159791623925;7394.667239974214;7435.1821299656995;7460.253974602496;7461.141968673672;7616.961915190389;7631.847363052708;7642.923570764332;7643.121041080236;7667.079950405987;7324.121105467378;7333.1200255969625;7346.228645992094;7353.374963128194;7360.411167106511;7192;7212.3148300911325;7251.8187045324285;7262.419006479363;7266.67299971492;7441.851162976818;7588.354989825927;7595.5822429764685;7634.122075961113;7657.2725591070985;4725.29120631908;4749.35883655702;4768.356271903249;4771.66598338113;4786.425628924551;7345.118585769742;7352.11774587053;7357;7368.3736882363455;7383.07711536058;7023.894641580278;7033.402160816183;7081.716731330689;7100.680469378994;7113.790655588459;6888.346796768839;7079.575225486487;7086.751963681247;7101.502894797314;7123.465740069619;6862.656867156722;6897.2757860423935;6949.478789090939;6959.26927672587;6967.54710943787;7140.107486564179;7155.42756579462;7158.3915367192285;7158.606276654834;7185.497015208885;6970.477214209056;6983.895241571482;6984.860302794017;6985.895211571728;6988.965055174692 03:46:53 INFO - PROCESS | 11502 | |5;yui.html;787.8345547435039;788.8106854354957;804.1315379390255;861.3668953319309;919.9724008279752;14663.340149693262;14818.184999825018;14888.702225955489;15262.389504419838;15748.370065197407;14997.10017398957;15017.32422041008;15021.774673379881;15043.247837608104;15098;875;883.6421249394006;891.3448615267773;896.2023798819056;898.5192921786845;902.1564836877508;905.6467977488785;905.950172740499;908.0374802709149;909.895362033368;943.9008904065078;956.8421210500259;957.5738796235678;957.6648173139415;957.952102394881;952.3666761603525;952.8284908716394;952.9047095290484;953.2564599612244;953.3183773601874;697.7767114523355;698.5040621158984;700.0724040646164;701.1516065560678;702.6276073680957;14923.328450219658;15001.624959375993;15097.094174349575;15131.773023404548;15157;14312.713745725026;14564.781528277084;14567.635809104751;14607.123572585679;14678.633034174125;11708.297502149899;11739.823902641467;11981.221220620631;12052;12175;4625.514320996281;4713.057388522309;4768.5946694531;4866.78099485524;4884.534639608139;50616.98766024696;50702.49297507015;50760.49239507595;50980.49019509795;51134.488655113346;10878.238523303451;11008.724781880517;11089.944550277198;11199.60801371948;11240.875912408694;19839.404817855488;19965.101570429364;20003.59992800136;20072;20137.798622013594;8794.60424280909;9157.542122893828;9168.35821492489;9224.631014759469;9273.72178834636;4855.271709243641;4947.752612369367;4953.72754498506;4979.029089327546;5028.145215313405;3261.62491313502;3297.1427428868665;3310.3875782980226;3317.4360358739073;3318.8340582970754;659.1990731261444;675.6824292582478;676.6650507998473;681.4344094401634;683.4839696029466;833.9291160251447;838.6852287685908;841.9452735572169;853.4537895746727;853.7737499562621;9184.081591840762;9187.540622968825;9250.629974801068;9540.761480963032;9577.856332155023;823.7487566292218;823.8887750153773;828.7803732011022;834.4117397234935;850.6257246811383;4553.977230113828;4657.534246575383;4677.415323084614;4743.383360163157;4745.264484004984;66220.66889665618;68104;68195;68354.3164568348;68478.31521684819;58069.12896306559;58094.41905580975;58183;58830.70584647135;59032;51828.22257666138;52379.73810131001;52694;53124.73437632787;53827.46172538303;9191.448513088968;9212;9229.49237791928;9331.393459425115;9428;39280;39686.60313396829;39758.2048359037;39915.80042099771;40114.598854012256;46810.531894680615;46841.53158468508;49992.50007499878;50176.749116254185;50865.491345087554;10936.835947460953;11086.722831928944;11295.887041129483;11348.262362946381;11411.771764564828;12083.39583020863;12137.332446715516;12250.571230006906;12788.232706037668;12963.15739476931;11990.100742444525;11994.520219191134;12017.4592143352;12033.939830300793;12624.3687815607;11541.307521548733;11773.117016223989;11846.763064738485;11966.282023078644;12208.572699955459;11357.261777984404;11508.712282193012;11555.2489088209;11585.536578536765;11857.11071669611;9696.466694331879;9699.272554558578;9752.46361450127;9974.20206383502;10147.137493313152;9843.310968232156;9883.430020856626;9924.1068303853;9986.650467233612;9989.750256243651 03:46:53 INFO - PROCESS | 11502 | __end_tp_report 03:46:53 INFO - PROCESS | 11502 | __start_cc_report 03:46:53 INFO - PROCESS | 11502 | _x_x_mozilla_cycle_collect,341 03:46:53 INFO - PROCESS | 11502 | __end_cc_report 03:46:53 INFO - PROCESS | 11502 | __startTimestamp1464346013726__endTimestamp 03:46:53 INFO - PROCESS | 11502 | 03:46:53 INFO - PROCESS | 11502 | ------- Summary: start ------- 03:46:53 INFO - PROCESS | 11502 | Number of tests: 6 03:46:53 INFO - PROCESS | 11502 | 03:46:53 INFO - PROCESS | 11502 | [#0] dojo.html Cycles:165 Average:5654.93 Median:5859.85 stddev:640.27 (10.9%) stddev-sans-first:616.96 03:46:53 INFO - PROCESS | 11502 | Values: 3384.2 3461.1 3464.0 3499.5 3513.1 5714.5 5730.7 5739.4 5745.7 5754.5 5667.7 5747.3 5747.9 5752.5 5756.7 5052.1 5177.1 5200.8 5232.2 5272.7 5032.4 5157.4 5280.4 5318.1 5331.5 5109.2 5118.5 5198.6 5202.6 5204.4 5218.7 5223.1 5260.9 5266.7 5304.5 5012.9 5116.4 5184.0 5202.2 5247.1 5622.9 5629.8 5635.3 5652.7 5656.2 6084.4 6125.8 6133.2 6140.5 6158.4 6075.0 6097.1 6183.1 6190.2 6208.3 5799.5 5805.0 5809.9 5823.2 5848.0 6283.0 6335.0 6373.6 6374.0 6387.5 5706.6 5862.2 5961.9 6131.6 6134.6 5959.7 5959.9 5963.8 5975.4 5977.2 5882.2 5894.1 5933.6 5944.2 5950.0 5952.9 6110.7 6121.2 6138.3 6154.5 4551.4 4555.5 4561.5 4574.5 4575.4 4048.7 4073.6 4091.5 4097.2 4106.0 5570.7 5794.1 5814.2 5860.9 5873.7 5994.2 6045.8 6068.3 6076.7 6116.8 5604.7 5788.6 5794.3 5795.0 5802.4 4967.6 5001.3 5005.0 5009.5 5032.2 6228.7 6231.2 6249.0 6252.1 6270.7 6056.0 6082.7 6091.8 6094.8 6123.7 6325.7 6358.8 6375.6 6376.0 6423.3 6037.9 6065.5 6067.2 6073.6 6084.4 5969.0 6045.8 6116.6 6154.4 6199.6 5956.5 5973.6 5992.6 6004.8 6023.1 5911.1 5948.1 5963.9 5976.7 5980.4 5778.3 5829.0 5834.9 5859.9 5867.0 5895.4 5943.3 5955.7 5977.3 5992.5 5782.8 5793.5 5809.1 5815.5 5843.2 03:46:53 INFO - PROCESS | 11502 | 03:46:53 INFO - PROCESS | 11502 | [#1] ext.html Cycles:180 Average:62083.14 Median:23061.94 stddev:135445.25 (587.3%) stddev-sans-first:135746.71 03:46:53 INFO - PROCESS | 11502 | Values: 663.0 672.0 680.3 724.4 740.2 38505.2 40043.0 40207.8 40225.8 40307.2 42702.4 43245.6 43325.8 43424.8 43508.0 8635.4 8776.3 8842.1 8842.7 8873.4 8724.0 8821.3 8850.3 8862.2 8868.4 9084.5 9126.0 9156.5 9204.5 9238.9 9062.0 9081.4 9118.0 9144.6 9162.8 8956.6 9045.2 9075.5 9103.0 9107.6 41958.4 42224.6 42707.0 42735.4 42756.4 3862.5 3878.4 3931.0 4165.5 4571.2 32333.0 32351.5 32483.7 32573.5 33323.5 4602.3 4633.6 4680.6 4740.5 4750.4 303561.0 303896.0 305258.0 305483.0 305547.0 38925.8 39495.2 39564.6 39569.4 62605.7 37659.0 37856.8 37914.4 37973.0 38033.4 17730.9 17889.4 17938.6 17978.6 18033.9 14932.6 15124.0 15175.7 15220.0 15355.2 9330.1 9377.7 9399.3 9450.6 9468.6 3610.9 3622.7 3644.4 3654.5 3686.6 1113.8 1148.2 1165.4 1166.1 1214.6 33147.8 33384.5 33436.3 33767.7 34368.8 1214.5 1255.9 1287.5 1298.7 1368.4 17293.8 17366.4 17409.6 17463.6 17483.3 472872.0 558131.0 570607.0 873308.0 884456.0 62571.7 62862.7 62895.7 63623.0 63739.0 1543.2 1548.4 1557.9 1561.4 1563.7 32646.0 32778.8 33029.8 33328.2 34002.0 54414.7 54830.7 55345.7 55446.7 55448.2 432336.0 434891.0 436658.0 436994.0 437992.0 30801.7 30888.8 30937.2 30967.2 31118.8 49148.0 49546.8 50354.2 50415.2 50427.5 41295.6 41536.4 41985.4 42866.4 43007.8 41544.4 42381.8 42464.6 42814.8 42862.4 43403.3 43721.3 43989.6 44400.8 44478.3 36141.6 36194.8 36296.0 36548.8 37192.4 29109.4 29410.3 29600.7 29657.4 30149.7 03:46:53 INFO - PROCESS | 11502 | 03:46:53 INFO - PROCESS | 11502 | [#2] jquery.html Cycles:180 Average:29921.73 Median:2114.97 stddev:87255.57 (4125.6%) stddev-sans-first:87472.25 03:46:53 INFO - PROCESS | 11502 | Values: 429.8 436.5 438.9 441.4 450.8 18216.2 18413.4 18838.3 18886.0 18899.7 18356.9 18497.4 18681.6 19123.5 19208.9 5363.1 5383.9 5501.9 5916.9 5942.1 5791.3 5843.2 5849.4 5871.6 5884.6 5382.4 5400.5 5545.4 5820.4 5864.9 5358.4 5386.2 5390.3 5412.6 5422.7 5140.3 5159.7 5302.7 5319.2 5335.7 13141.4 13394.4 13421.9 13446.7 13489.9 2342.6 2418.8 2444.4 2504.3 2616.2 10803.6 10920.7 10926.9 10995.2 11138.9 1963.4 2089.2 2106.8 2115.5 2163.3 75373.0 76948.6 79112.6 79920.0 80721.0 11630.8 11693.5 11841.0 11857.3 11949.5 17027.5 17036.7 17054.7 17189.8 17190.3 8849.9 9184.7 9218.1 9225.8 9306.9 8914.9 9020.1 9036.9 9051.8 9151.8 5022.6 5077.4 5100.1 5105.1 5112.2 2079.3 2088.0 2114.4 2125.5 2146.8 1020.3 1047.4 1090.6 1109.2 1119.8 18701.5 19148.7 19399.5 19470.5 19592.0 1092.5 1094.6 1099.8 1107.6 1158.1 10528.8 10885.6 10928.9 10956.3 10996.7 510363.0 516789.0 533924.0 544124.0 548667.0 73971.0 88504.0 92529.5 92611.1 94048.5 1119.6 1154.9 1171.6 1176.8 1194.7 17318.8 17776.0 17815.4 17833.6 17992.7 38914.4 40083.4 40303.4 41263.2 42373.4 60138.0 60625.0 60925.4 61002.7 61668.7 9168.3 9248.4 9259.7 9356.0 9366.5 12554.0 12756.0 12879.2 13326.7 13506.7 11360.6 11422.7 11607.0 11671.9 11862.8 11239.5 11275.7 11459.9 11573.7 11697.3 11638.7 11792.2 11950.2 12124.1 12260.4 8999.2 9044.3 9101.4 9158.1 9297.5 11661.4 11762.8 11777.4 11966.3 12022.7 03:46:53 INFO - PROCESS | 11502 | 03:46:53 INFO - PROCESS | 11502 | [#3] mootools.html Cycles:180 Average:5725.45 Median:2680.40 stddev:3150.69 (117.5%) stddev-sans-first:3144.34 03:46:53 INFO - PROCESS | 11502 | Values: 1608.5 1608.9 1805.5 1900.2 1908.3 8413.7 8557.1 8643.7 8658.8 8720.9 8656.6 8671.5 8683.8 8736.1 8742.6 2441.3 2468.1 2487.1 2492.9 2497.2 2465.8 2521.0 2539.8 2542.5 2543.7 2471.3 2479.9 2486.8 2487.9 2508.3 2462.7 2463.6 2483.9 2488.9 2489.9 2505.9 2507.2 2513.7 2527.9 2533.9 8732.6 8751.7 8752.6 8781.0 8811.3 5501.8 5588.6 5622.9 5623.0 5625.5 3346.8 3357.1 3389.6 3460.4 3491.8 1027.5 1032.0 1051.5 1066.8 1096.4 12063.4 12177.3 12186.7 12224.4 12236.4 4811.9 4817.0 4837.8 4890.3 4931.3 10487.8 10497.5 10515.1 10548.0 10644.2 5532.6 5555.5 5557.8 5570.1 5571.8 4462.8 4858.5 4913.5 4955.3 5083.3 4179.6 4184.1 4242.5 4264.6 4310.5 1299.9 1304.4 1330.6 1352.2 1365.4 893.3 987.5 1034.4 1036.6 1057.7 5867.2 5939.5 5963.9 6013.8 6054.5 470.0 470.8 478.2 485.1 488.9 4239.2 4281.3 4291.5 4301.3 4322.2 10296.7 10644.1 10657.6 10662.8 10782.4 9835.3 9892.7 10008.3 10023.5 10389.1 8113.6 8124.3 8186.6 8241.0 8259.5 5793.2 5914.6 6053.4 6054.8 6191.3 9249.4 9254.4 9296.5 9502.3 9555.7 9537.0 9541.5 9598.2 9613.7 9948.4 6721.8 7220.9 7384.1 7445.1 7490.9 8164.5 8185.4 8195.0 8199.1 8211.8 7340.3 7543.0 7606.8 7622.3 7657.4 7442.8 7555.8 7563.9 7565.5 7606.4 6174.6 6213.2 6259.2 6286.1 6287.8 4839.0 4951.2 5051.9 5054.4 5168.7 4764.2 4764.8 4820.3 4850.5 4871.9 03:46:53 INFO - PROCESS | 11502 | 03:46:53 INFO - PROCESS | 11502 | [#4] prototype.html Cycles:180 Average:5887.16 Median:6789.00 stddev:1816.17 (26.8%) stddev-sans-first:1772.84 03:46:53 INFO - PROCESS | 11502 | Values: 336.9 340.9 344.7 356.8 361.5 6670.1 6715.6 6725.9 6762.6 6780.0 6583.4 6609.0 6621.0 6641.2 6651.9 4754.3 4891.4 5004.2 5016.3 5028.1 4971.1 4984.5 5009.1 5009.7 5030.0 4914.4 4924.8 4947.4 4962.1 4969.2 4944.1 4948.0 4966.1 4967.6 4975.0 4308.8 4339.6 4340.8 4343.2 4346.0 6288.0 6388.8 6402.7 6433.0 6443.0 5781.7 5808.6 5813.3 5823.5 5847.0 6962.8 6980.2 7001.4 7007.4 7026.0 4804.2 4809.3 4817.5 4819.1 4832.1 7187.5 7265.4 7324.5 7335.4 7337.3 4850.8 4885.3 4923.9 4931.9 4933.1 4945.2 4977.1 4979.1 4983.4 4986.4 5770.0 5774.9 5785.8 5791.0 5805.6 7028.1 7048.2 7081.2 7088.9 7090.5 1760.7 1776.2 1776.8 1777.8 1781.1 1088.5 1106.4 1121.7 1125.1 1155.5 6764.3 6798.0 6808.6 6810.5 6824.4 7145.7 7249.5 7276.3 7284.3 7289.8 6800.1 6880.3 6895.2 6900.1 6908.0 3944.0 3972.2 4003.6 4005.1 4009.7 7656.8 7664.2 7667.6 7689.7 7706.6 7306.2 7394.7 7435.2 7460.3 7461.1 7617.0 7631.8 7642.9 7643.1 7667.1 7324.1 7333.1 7346.2 7353.4 7360.4 7192.0 7212.3 7251.8 7262.4 7266.7 7441.9 7588.4 7595.6 7634.1 7657.3 4725.3 4749.4 4768.4 4771.7 4786.4 7345.1 7352.1 7357.0 7368.4 7383.1 7023.9 7033.4 7081.7 7100.7 7113.8 6888.3 7079.6 7086.8 7101.5 7123.5 6862.7 6897.3 6949.5 6959.3 6967.5 7140.1 7155.4 7158.4 7158.6 7185.5 6970.5 6983.9 6984.9 6985.9 6989.0 03:46:53 INFO - PROCESS | 11502 | 03:46:53 INFO - PROCESS | 11502 | [#5] yui.html Cycles:180 Average:15372.21 Median:50659.74 stddev:18049.46 (35.6%) stddev-sans-first:18066.86 03:46:53 INFO - PROCESS | 11502 | Values: 787.8 788.8 804.1 861.4 920.0 14663.3 14818.2 14888.7 15262.4 15748.4 14997.1 15017.3 15021.8 15043.2 15098.0 875.0 883.6 891.3 896.2 898.5 902.2 905.6 906.0 908.0 909.9 943.9 956.8 957.6 957.7 958.0 952.4 952.8 952.9 953.3 953.3 697.8 698.5 700.1 701.2 702.6 14923.3 15001.6 15097.1 15131.8 15157.0 14312.7 14564.8 14567.6 14607.1 14678.6 11708.3 11739.8 11981.2 12052.0 12175.0 4625.5 4713.1 4768.6 4866.8 4884.5 50617.0 50702.5 50760.5 50980.5 51134.5 10878.2 11008.7 11089.9 11199.6 11240.9 19839.4 19965.1 20003.6 20072.0 20137.8 8794.6 9157.5 9168.4 9224.6 9273.7 4855.3 4947.8 4953.7 4979.0 5028.1 3261.6 3297.1 3310.4 3317.4 3318.8 659.2 675.7 676.7 681.4 683.5 833.9 838.7 841.9 853.5 853.8 9184.1 9187.5 9250.6 9540.8 9577.9 823.7 823.9 828.8 834.4 850.6 4554.0 4657.5 4677.4 4743.4 4745.3 66220.7 68104.0 68195.0 68354.3 68478.3 58069.1 58094.4 58183.0 58830.7 59032.0 51828.2 52379.7 52694.0 53124.7 53827.5 9191.4 9212.0 9229.5 9331.4 9428.0 39280.0 39686.6 39758.2 39915.8 40114.6 46810.5 46841.5 49992.5 50176.7 50865.5 10936.8 11086.7 11295.9 11348.3 11411.8 12083.4 12137.3 12250.6 12788.2 12963.2 11990.1 11994.5 12017.5 12033.9 12624.4 11541.3 11773.1 11846.8 11966.3 12208.6 11357.3 11508.7 11555.2 11585.5 11857.1 9696.5 9699.3 9752.5 9974.2 10147.1 9843.3 9883.4 9924.1 9986.7 9989.8 03:46:53 INFO - PROCESS | 11502 | -------- Summary: end -------- 03:46:53 INFO - PROCESS | 11502 | 03:46:54 INFO - TEST-INFO | 11502: exit 0 03:46:54 INFO - TEST-OK | dromaeo_css | took 1109690ms 03:46:54 INFO - TEST-START | kraken 03:46:54 INFO - operating with platform_type : linux_ 03:46:54 INFO - Initialising browser for kraken test... 03:46:54 INFO - TEST-INFO | started process 11740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSAzfU/profile http://localhost:33376/getInfo.html) 03:46:58 INFO - PROCESS | 11740 | 03:46:58 INFO - PROCESS | 11740 | (process:11817): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:46:58 INFO - PROCESS | 11740 | __metrics Screen width/height:1600/1200 03:46:58 INFO - PROCESS | 11740 | colorDepth:24 03:46:58 INFO - PROCESS | 11740 | Browser inner width/height: 1024/697 03:46:58 INFO - PROCESS | 11740 | __metrics 03:46:59 ERROR - PROCESS | 11740 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:47:00 INFO - TEST-INFO | 11740: exit 0 03:47:00 INFO - Browser initialized. 03:47:00 INFO - Running cycle 1/1 for kraken test... 03:47:00 INFO - TEST-INFO | started process 11868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSAzfU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:02 INFO - PROCESS | 11868 | 03:47:02 INFO - PROCESS | 11868 | (process:11937): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:47:12 INFO - PROCESS | 11868 | RSS: Main: 152150016 03:47:12 INFO - PROCESS | 11868 | 03:47:14 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33376/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:15 INFO - PROCESS | 11868 | RSS: Main: 157032448 03:47:15 INFO - PROCESS | 11868 | 03:47:18 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33376/tests/kraken/driver.html?testName=audio-dft) 03:47:18 INFO - PROCESS | 11868 | RSS: Main: 157163520 03:47:18 INFO - PROCESS | 11868 | 03:47:21 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33376/tests/kraken/driver.html?testName=audio-fft) 03:47:22 INFO - PROCESS | 11868 | RSS: Main: 156872704 03:47:22 INFO - PROCESS | 11868 | 03:47:24 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33376/tests/kraken/driver.html?testName=audio-oscillator) 03:47:25 INFO - PROCESS | 11868 | RSS: Main: 157442048 03:47:25 INFO - PROCESS | 11868 | 03:47:27 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:27 INFO - PROCESS | 11868 | RSS: Main: 157659136 03:47:27 INFO - PROCESS | 11868 | 03:47:30 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33376/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:31 INFO - PROCESS | 11868 | RSS: Main: 157478912 03:47:31 INFO - PROCESS | 11868 | 03:47:34 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33376/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:35 INFO - PROCESS | 11868 | RSS: Main: 157024256 03:47:35 INFO - PROCESS | 11868 | 03:47:38 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33376/tests/kraken/driver.html?testName=json-parse-financial) 03:47:38 INFO - PROCESS | 11868 | RSS: Main: 157134848 03:47:38 INFO - PROCESS | 11868 | 03:47:40 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:41 INFO - PROCESS | 11868 | RSS: Main: 157151232 03:47:41 INFO - PROCESS | 11868 | 03:47:42 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33376/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:43 INFO - PROCESS | 11868 | RSS: Main: 157249536 03:47:43 INFO - PROCESS | 11868 | 03:47:45 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:46 INFO - PROCESS | 11868 | RSS: Main: 157048832 03:47:46 INFO - PROCESS | 11868 | 03:47:48 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:49 INFO - PROCESS | 11868 | RSS: Main: 157876224 03:47:49 INFO - PROCESS | 11868 | 03:47:51 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:52 INFO - PROCESS | 11868 | RSS: Main: 157483008 03:47:52 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:33376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33376/tests/kraken/driver.html?testName=ai-astar) 03:47:54 INFO - PROCESS | 11868 | RSS: Main: 159162368 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | __start_tp_report 03:47:54 INFO - PROCESS | 11868 | _x_x_mozilla_page_load 03:47:54 INFO - PROCESS | 11868 | _x_x_mozilla_page_load_details 03:47:54 INFO - PROCESS | 11868 | |i|pagename|runs| 03:47:54 INFO - PROCESS | 11868 | |0;ai-astar;118;111;103;112;113;111;101;110;110;110 03:47:54 INFO - PROCESS | 11868 | |1;audio-beat-detection;165;127;155;168;130;166;157;134;179;130 03:47:54 INFO - PROCESS | 11868 | |2;audio-dft;163;162;162;163;161;163;162;164;163;161 03:47:54 INFO - PROCESS | 11868 | |3;audio-fft;75;79;76;187;74;76;75;74;170;77 03:47:54 INFO - PROCESS | 11868 | |4;audio-oscillator;92;92;155;92;93;93;145;93;92;147 03:47:54 INFO - PROCESS | 11868 | |5;imaging-gaussian-blur;117;118;117;118;118;118;117;117;118;123 03:47:54 INFO - PROCESS | 11868 | |6;imaging-darkroom;148;147;147;146;146;149;146;146;147;149 03:47:54 INFO - PROCESS | 11868 | |7;imaging-desaturate;96;97;95;96;96;95;95;95;95;95 03:47:54 INFO - PROCESS | 11868 | |8;json-parse-financial;59;59;60;65;69;62;61;82;59;58 03:47:54 INFO - PROCESS | 11868 | |9;json-stringify-tinderbox;60;61;57;57;58;58;57;56;58;58 03:47:54 INFO - PROCESS | 11868 | |10;stanford-crypto-aes;73;74;72;72;73;74;74;73;75;76 03:47:54 INFO - PROCESS | 11868 | |11;stanford-crypto-ccm;126;114;115;117;111;126;121;117;131;128 03:47:54 INFO - PROCESS | 11868 | |12;stanford-crypto-pbkdf2;168;167;170;160;157;166;157;158;161;161 03:47:54 INFO - PROCESS | 11868 | |13;stanford-crypto-sha256-iterative;69;69;67;66;65;68;67;65;67;66 03:47:54 INFO - PROCESS | 11868 | __end_tp_report 03:47:54 INFO - PROCESS | 11868 | __start_cc_report 03:47:54 INFO - PROCESS | 11868 | _x_x_mozilla_cycle_collect,865 03:47:54 INFO - PROCESS | 11868 | __end_cc_report 03:47:54 INFO - PROCESS | 11868 | __startTimestamp1464346074423__endTimestamp 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | ------- Summary: start ------- 03:47:54 INFO - PROCESS | 11868 | Number of tests: 14 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:4.82 (4.3%) stddev-sans-first:4.12 03:47:54 INFO - PROCESS | 11868 | Values: 118.0 111.0 103.0 112.0 113.0 111.0 101.0 110.0 110.0 110.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:161.00 stddev:19.13 (11.9%) stddev-sans-first:19.62 03:47:54 INFO - PROCESS | 11868 | Values: 165.0 127.0 155.0 168.0 130.0 166.0 157.0 134.0 179.0 130.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 03:47:54 INFO - PROCESS | 11868 | Values: 163.0 162.0 162.0 163.0 161.0 163.0 162.0 164.0 163.0 161.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#3] audio-fft Cycles:10 Average:96.30 Median:75.50 stddev:43.53 (57.7%) stddev-sans-first:45.49 03:47:54 INFO - PROCESS | 11868 | Values: 75.0 79.0 76.0 187.0 74.0 76.0 75.0 74.0 170.0 77.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.00 stddev:27.44 (29.8%) stddev-sans-first:28.38 03:47:54 INFO - PROCESS | 11868 | Values: 92.0 92.0 155.0 92.0 93.0 93.0 145.0 93.0 92.0 147.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.79 (1.5%) stddev-sans-first:1.86 03:47:54 INFO - PROCESS | 11868 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 123.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 03:47:54 INFO - PROCESS | 11868 | Values: 148.0 147.0 147.0 146.0 146.0 149.0 146.0 146.0 147.0 149.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 03:47:54 INFO - PROCESS | 11868 | Values: 96.0 97.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:61.50 stddev:7.35 (12.0%) stddev-sans-first:7.62 03:47:54 INFO - PROCESS | 11868 | Values: 59.0 59.0 60.0 65.0 69.0 62.0 61.0 82.0 59.0 58.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:1.49 (2.6%) stddev-sans-first:1.39 03:47:54 INFO - PROCESS | 11868 | Values: 60.0 61.0 57.0 57.0 58.0 58.0 57.0 56.0 58.0 58.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:74.00 stddev:1.26 (1.7%) stddev-sans-first:1.32 03:47:54 INFO - PROCESS | 11868 | Values: 73.0 74.0 72.0 72.0 73.0 74.0 74.0 73.0 75.0 76.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:123.50 stddev:6.79 (5.5%) stddev-sans-first:6.91 03:47:54 INFO - PROCESS | 11868 | Values: 126.0 114.0 115.0 117.0 111.0 126.0 121.0 117.0 131.0 128.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.50 stddev:4.84 (3.0%) stddev-sans-first:4.70 03:47:54 INFO - PROCESS | 11868 | Values: 168.0 167.0 170.0 160.0 157.0 166.0 157.0 158.0 161.0 161.0 03:47:54 INFO - PROCESS | 11868 | 03:47:54 INFO - PROCESS | 11868 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:1.32 03:47:54 INFO - PROCESS | 11868 | Values: 69.0 69.0 67.0 66.0 65.0 68.0 67.0 65.0 67.0 66.0 03:47:54 INFO - PROCESS | 11868 | -------- Summary: end -------- 03:47:54 INFO - PROCESS | 11868 | 03:47:55 INFO - TEST-INFO | 11868: exit 0 03:47:55 INFO - TEST-OK | kraken | took 60970ms 03:47:55 INFO - SUITE-END | took 1170s 03:47:55 INFO - Completed test suite (00:19:30) 03:47:55 INFO - javascript benchmark 03:47:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3384.2047118927053, 3461.10011397037, 3463.982680086599, 3499.5100685903963, 3513.051476101453, 5714.457126572979, 5730.713464326783, 5739.417262231997, 5745.683987380692, 5754.539636829054, 5667.688277144755, 5747.281589801275, 5747.885042299152, 5752.453516915886, 5756.7409466574, 5052.065367906949, 5177.068127737006, 5200.843974680747, 5232.215167724834, 5272.657277276984, 5032.396112466509, 5157.4068982067165, 5280.392754833186, 5318.069337865877, 5331.493508116722, 5109.156989096795, 5118.462561431052, 5198.610104242178, 5202.609804264676, 5204.375474942994, 5218.739063046833, 5223.138182199932, 5260.868478288055, 5266.710330931797, 5304.496072873071, 5012.949870501321, 5116.411612664517, 5184.040952423776, 5202.2456743771945, 5247.134222853225, 5622.91565626516, 5629.774809007676, 5635.3237611486475, 5652.74562644682, 5656.236408084897, 6084.361142080106, 6125.754969801247, 6133.233345831771, 6140.508759299245, 6158.3841615838055, 6075.02799552074, 6097.146399504073, 6183.103449999725, 6190.195274614316, 6208.286047104551, 5799.4780469757925, 5805.01314776489, 5809.912851307234, 5823.184754134425, 5848.035074212749, 6282.968585157045, 6334.986402175629, 6373.553851230369, 6373.968130159412, 6387.457066149336, 5706.600537962303, 5862.208601838697, 5961.910571341434, 6131.63210207389, 6134.601250918676, 5959.731812068468, 5959.880802383928, 5963.821085367446, 5975.372585878507, 5977.193078934288, 5882.176495290662, 5894.115882617556, 5933.614315069593, 5944.167816505693, 5950.047992321208, 5952.9107063394085, 6110.725017374229, 6121.204243448412, 6138.296437970319, 6154.476869466145, 4551.431071116111, 4555.453345598549, 4561.498235194126, 4574.4968053514085, 4575.3823233863, 4048.736832105904, 4073.6333729963853, 4091.5499295077516, 4097.242010228118, 4105.97947010263, 5570.721463926788, 5794.1308803679785, 5814.156947242626, 5860.8534786629825, 5873.676947767914, 5994.1608174855555, 6045.758169673251, 6068.271807383142, 6076.665783381956, 6116.755329786759, 5604.6917419541505, 5788.565857560699, 5794.275715535558, 5795.0, 5802.361740208574, 4967.552920237196, 5001.274815151783, 5004.974975125101, 5009.524095210949, 5032.220005899091, 6228.657423841732, 6231.22109736283, 6249.0, 6252.062190671436, 6270.7491700331475, 6055.969720151371, 6082.695865206811, 6091.817245482643, 6094.847628809315, 6123.679189354688, 6325.746970121144, 6358.809235722936, 6375.649339286384, 6376.0, 6423.293437721753, 6037.879242415215, 6065.54508411862, 6067.150598916243, 6073.635581865102, 6084.39156084388, 5969.0, 6045.848853778691, 6116.602420842631, 6154.446099851035, 6199.56603037783, 5956.493698035715, 5973.5519836013345, 5992.64044157352, 6004.759809607567, 6023.096535519707, 5911.113332999912, 5948.078047902582, 5963.9105413417965, 5976.701164941648, 5980.401959804159, 5778.306603207642, 5829.038208695687, 5834.912476312944, 5859.853503662443, 5867.031939729897, 5895.380984996514, 5943.257092863392, 5955.702214889325, 5977.3126090500145, 5992.460678538952, 5782.768689252551, 5793.478586927196, 5809.128630705259, 5815.534757219328, 5843.2403787507355], "value": 5612.819845128029, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.0154220981841, 671.986560268795, 680.2585182151454, 724.4023680463619, 740.1968863782795, 38505.22989540211, 40043.0, 40207.79896100519, 40225.7988710056, 40307.19385612286, 42702.35946460805, 43245.56754432455, 43325.78337108318, 43424.78287608566, 43508.0, 8635.395522313425, 8776.297896168291, 8842.115788421139, 8842.690505832297, 8873.378863479558, 8724.040355560883, 8821.294296456268, 8850.336224783136, 8862.24670902974, 8868.37921345506, 9084.454932704026, 9126.0, 9156.542172891362, 9204.539773011356, 9238.907610923872, 9062.048484909088, 9081.364304498687, 9118.042605526423, 9144.588493517775, 9162.816743665157, 8956.596953137125, 9045.185933265971, 9075.500847453388, 9103.0, 9107.59015844282, 41958.37062444066, 42224.57775422268, 42707.0, 42735.35896961548, 42756.358654620206, 3862.517185351831, 3878.398848178537, 3930.960690393088, 4165.500139983222, 4571.2000399929875, 32333.0, 32351.51472727911, 32483.67516324854, 32573.511397329057, 33323.500147497805, 4602.263637817967, 4633.559811817906, 4680.578747912704, 4740.478547359788, 4750.406199225097, 303561.0, 303896.0, 305258.0, 305483.0, 305547.0, 38925.80537097353, 39495.21009579792, 39564.60435395667, 39569.40645890314, 62605.68697156576, 37659.0, 37856.810715946245, 37914.43128353077, 37973.0, 38033.42949855755, 17730.91134544319, 17889.37387191442, 17938.641227175645, 17978.64042719138, 18033.909830450764, 14932.552023439097, 15124.0, 15175.696486070217, 15220.0, 15355.232238388036, 9330.113639204264, 9377.718668439958, 9399.34204605671, 9450.57472413743, 9468.57391417388, 3610.9277814443562, 3622.6558476944647, 3644.362236608583, 3654.4518322251342, 3686.5760437550025, 1113.8440618313443, 1148.190525679394, 1165.4231155578043, 1166.0904494494307, 1214.6173955204083, 33147.834260829026, 33384.49923251153, 33436.331273374395, 33767.662323376455, 34368.82815585956, 1214.520264495537, 1255.8681338459512, 1287.4528325461642, 1298.688314804459, 1368.4115830192914, 17293.78545191024, 17366.39217627377, 17409.564760880825, 17463.56341091483, 17483.300667973137, 472872.0, 558131.0, 570607.0, 873308.0, 884456.0, 62571.687141564, 62862.685686571276, 62895.68552157302, 63623.0, 63739.0, 1543.1821134798574, 1548.4270819796523, 1557.929893154788, 1561.3832536148159, 1563.6950794595173, 32646.0, 32778.83610581932, 33029.834850825595, 33328.166795829326, 34002.0, 54414.727926360116, 54830.725846370515, 55345.723271384995, 55446.72276638591, 55448.168277475066, 432336.0, 434891.0, 436658.0, 436994.0, 437992.0, 30801.691983079883, 30888.845555772077, 30937.226569335948, 30967.225819354695, 31118.84440577873, 49148.0, 49546.752266238436, 50354.244686329, 50415.24377134273, 50427.49572504228, 41295.58704412918, 41536.37695434631, 41985.37021944612, 42866.357004644335, 43007.78496107499, 41544.376834346906, 42381.788091059345, 42464.57535424606, 42814.78592607017, 42862.35706464343, 43403.348949765146, 43721.344179837964, 43989.560104399825, 44400.77799610981, 44478.332825007004, 36141.63858361488, 36194.819025904704, 36296.0, 36548.81725591355, 37192.44211336886, 29109.416283331975, 29410.264743381587, 29600.703992959796, 29657.406851863274, 30149.69850301469], "value": 19859.24496766753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.7958469726879, 436.4675096382412, 438.85896668661485, 441.4129208153156, 450.83769842856543, 18216.180271887763, 18413.355532556365, 18838.34065807697, 18886.0, 18899.716504252447, 18356.908215458938, 18497.35259265926, 18681.626367472643, 19123.521911952208, 19208.903955480204, 5363.088274993261, 5383.865403364927, 5501.862453438656, 5916.940830591682, 5942.078977758454, 5791.276090488689, 5843.18195452637, 5849.356570777232, 5871.618344807595, 5884.588078834483, 5382.407935127133, 5400.513953744162, 5545.390007099216, 5820.38885916979, 5864.941350586482, 5358.410574836765, 5386.1920711893135, 5390.272313237702, 5412.648177868466, 5422.728863556826, 5140.254663073833, 5159.664621799571, 5302.734863256822, 5319.2287118368, 5335.733213339357, 13141.408636611375, 13394.397252123677, 13421.932890335584, 13446.663833404145, 13489.932550337186, 2342.5900467418132, 2418.830681852271, 2444.4377793107683, 2504.336350867022, 2616.175904590048, 10803.621873234477, 10920.726981825439, 10926.890731092746, 10995.175361847894, 11138.944305278503, 1963.391348681899, 2089.1956596710224, 2106.799854013866, 2115.545157791082, 2163.329367895957, 75373.0, 76948.61525692335, 79112.60443697745, 79920.0, 80721.0, 11630.825537616942, 11693.532258709556, 11841.0, 11857.288562686093, 11949.522019119138, 17027.48917532476, 17036.659266814593, 17054.74417883733, 17189.82810171907, 17190.31238750436, 8849.867251991225, 9184.678536251198, 9218.124278193562, 9225.815483690423, 9306.86039709405, 8914.86627700585, 9020.14308640678, 9036.8644470333, 9051.81896362069, 9151.816963660689, 5022.6233032522705, 5077.416097148801, 5100.1074811907765, 5105.055564720538, 5112.182050871843, 2079.2826474866147, 2087.979120208809, 2114.3868278199457, 2125.5217576045266, 2146.84972051958, 1020.3265844542566, 1047.4291511126303, 1090.5801266512449, 1109.1958330210532, 1119.7592517608591, 18701.532461688294, 19148.712769308473, 19399.515012124808, 19470.513237169183, 19592.0, 1092.4869056357002, 1094.5731164845718, 1099.8295264234057, 1107.5514416661265, 1158.1024705852863, 10528.842067368996, 10885.619003334845, 10928.945355273332, 10956.28784129029, 10996.725081873017, 510363.0, 516789.0, 533924.0, 544124.0, 548667.0, 73971.0, 88504.0, 92529.53735231416, 92611.07388926159, 94048.52975735214, 1119.647311097018, 1154.8729639739454, 1171.6485054483621, 1176.7705297466912, 1194.6714653470192, 17318.785805219566, 17776.0, 17815.376461823773, 17833.554161145556, 17992.730109048112, 38914.416283756334, 40083.398749018204, 40303.39544906888, 41263.1747365057, 42373.36439953341, 60138.0, 60625.0, 60925.39074609197, 61002.69498652478, 61668.691656543226, 9168.299944643171, 9248.352615316864, 9259.67591134307, 9356.0, 9366.484843333683, 12554.0, 12756.0, 12879.227246365248, 13326.666833328856, 13506.729865402833, 11360.602378917029, 11422.714432139262, 11607.0, 11671.88328116708, 11862.822057669315, 11239.494222760159, 11275.718107047389, 11459.885401146215, 11573.710657233636, 11697.2981621103, 11638.70903227426, 11792.174547781917, 11950.163488555718, 12124.090693198223, 12260.38698065111, 8999.235065019286, 9044.276457883221, 9101.40840845343, 9158.084191580789, 9297.488638124969, 11661.35862527569, 11762.823557646814, 11777.352245626573, 11966.341851198267, 12022.699432514257], "value": 9394.90253799203, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1608.5094046315874, 1608.8793340499458, 1805.5215367927494, 1900.2399040383852, 1908.2843933524928, 8413.705520306783, 8557.101504342048, 8643.654253829847, 8658.783530411743, 8720.8691869622, 8656.610452529636, 8671.523066231355, 8683.826323473526, 8736.082711315315, 8742.606582703778, 2441.2798224523717, 2468.123816045305, 2487.092211342865, 2492.9002839886384, 2497.163450244161, 2465.778079972802, 2520.974790252092, 2539.7968162547045, 2542.529632018083, 2543.682039745032, 2471.270975062352, 2479.913203037894, 2486.8010559155314, 2487.8507289562594, 2508.272600945733, 2462.741412151725, 2463.59350707134, 2483.937901552458, 2488.8880000400027, 2489.9253022409175, 2505.887235074426, 2507.1601013660447, 2513.6857892763405, 2527.862461892156, 2533.936651583707, 8732.563371831384, 8751.693690720795, 8752.606132724042, 8780.956095219546, 8811.339149563808, 5501.752421141058, 5588.552915766729, 5622.859428514279, 5623.044082505984, 5625.5218306444, 3346.7991920484606, 3357.1103657530775, 3389.610194827602, 3460.3944309745943, 3491.8428670709877, 1027.5222021759917, 1031.9690409287734, 1051.5373235776235, 1066.7546464313252, 1096.4353358020626, 12063.396830158457, 12177.33024683642, 12186.695332616668, 12224.388780561025, 12236.388180590935, 4811.879703007453, 4816.979728751659, 4837.782299796518, 4890.315355850184, 4931.309616653672, 10487.790244195074, 10497.47512624381, 10515.106215971575, 10548.0, 10644.201684873666, 5532.5573954083575, 5555.527780138734, 5557.833265002057, 5570.053090974463, 5571.832845014656, 4462.799174037176, 4858.5384388483035, 4913.533214344631, 4955.256711493233, 5083.339165908408, 4179.582041795857, 4184.079502509443, 4242.53332133465, 4264.594863487963, 4310.52584215736, 1299.9025073119553, 1304.4390911907972, 1330.602866989657, 1352.1954437109903, 1365.378752667534, 893.2898345815092, 987.4519641598981, 1034.3690348887174, 1036.5957276662107, 1057.7408534908996, 5867.20792692981, 5939.524838012949, 5963.850903727442, 6013.759449622054, 6054.485368743706, 469.96945198561986, 470.80226304952004, 478.18469509486243, 485.06382681425185, 488.8680056384756, 4239.173361194599, 4281.293586558245, 4291.54938731435, 4301.3117901135665, 4322.222000040023, 10296.691099267035, 10644.095251903675, 10657.573697052187, 10662.786744265071, 10782.35305881634, 9835.262355323379, 9892.703218903445, 10008.349457285252, 10023.498825058718, 10389.116925061304, 8113.553754543556, 8124.2688158064875, 8186.631601577943, 8241.0, 8259.504429734236, 5793.246877905845, 5914.615549989237, 6053.3946605339115, 6054.8183554493435, 6191.25704915395, 9249.398789078688, 9254.444733316022, 9296.488693121673, 9502.287328450531, 9555.713328600154, 9536.952315238379, 9541.47521886303, 9598.18415434668, 9613.711588652352, 9948.403095813985, 6721.831954200989, 7220.855582888208, 7384.113906331275, 7445.10658720957, 7490.925090749023, 8164.510129392255, 8185.4270201085355, 8195.0, 8199.139090395423, 8211.794705132419, 7340.265973402617, 7543.0, 7606.847863042819, 7622.31399174077, 7657.425693072931, 7442.813929651802, 7555.848883022199, 7563.924360756322, 7565.470417070972, 7606.429517786078, 6174.567780255518, 6213.161223234805, 6259.248890133031, 6286.119943207863, 6287.779927702692, 4838.975805120952, 4951.158303088411, 5051.87370315745, 5054.368203974504, 5168.741562921914, 4764.213904705824, 4764.809407623795, 4820.30105634674, 4850.53919877611, 4871.9269210962575], "value": 4583.511716275416, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.94608862581987, 340.93692666856634, 344.68289173959954, 356.8126733464932, 361.50834864584175, 6670.099536562562, 6715.630640314781, 6725.9327406725915, 6762.628055456948, 6779.999999999994, 6583.37457941496, 6609.0, 6621.039949207362, 6641.203055633318, 6651.933480665192, 4754.3106249593875, 4891.413030436335, 5004.249362595603, 5016.322796422491, 5028.094942910275, 4971.130052240844, 4984.526469985363, 5009.073321435528, 5009.724465154415, 5030.0, 4914.385701787277, 4924.80300787968, 4947.381577302837, 4962.057209130272, 4969.2049272116465, 4944.134776414131, 4947.975260123694, 4966.130927087764, 4967.602591792648, 4975.0, 4308.763018034007, 4339.609435150852, 4340.761258130801, 4343.174796788631, 4346.043870348518, 6287.9685601572155, 6388.840278993016, 6402.711877965503, 6432.9678351607945, 6443.0, 5781.653100813965, 5808.59339846211, 5813.273340832396, 5823.505002074829, 5847.0, 6962.825929351756, 6980.16238051432, 7001.36987671112, 7007.404370628503, 7026.0, 4804.20730579454, 4809.278608208797, 4817.470078291385, 4819.1325561398935, 4832.081904438145, 7187.496875218737, 7265.4187664986675, 7324.487285889936, 7335.376492998102, 7337.3029562191505, 4850.75746212688, 4885.291632713237, 4923.876903077452, 4931.926021109686, 4933.0627180836245, 4945.208766597327, 4977.104121258136, 4979.053979743837, 4983.426905905795, 4986.401631804207, 5770.047942089508, 5774.88450230993, 5785.768569257182, 5791.0, 5805.593608447452, 7028.121484814398, 7048.154221493351, 7081.185663648746, 7088.936659501116, 7090.503664743418, 1760.7182850744075, 1776.191832716111, 1776.7601373814628, 1777.8222177782118, 1781.056040298644, 1088.4992903264588, 1106.4025426269884, 1121.7363919478917, 1125.1111621818673, 1155.4915837031679, 6764.323567643196, 6798.0, 6808.5914845109455, 6810.455163586901, 6824.41992430639, 7145.714171433188, 7249.492535522463, 7276.272372762787, 7284.307990740871, 7289.817754556072, 6800.115984922028, 6880.346367095118, 6895.172579290517, 6900.102986611809, 6907.965460172667, 3943.960560394359, 3972.245273398045, 4003.619656132663, 4005.138895137501, 4009.659178969762, 7656.808579785438, 7664.195259497784, 7667.578283194478, 7689.692412303557, 7706.614669266514, 7306.159791623925, 7394.667239974214, 7435.1821299656995, 7460.253974602496, 7461.141968673672, 7616.961915190389, 7631.847363052708, 7642.923570764332, 7643.121041080236, 7667.079950405987, 7324.121105467378, 7333.1200255969625, 7346.228645992094, 7353.374963128194, 7360.411167106511, 7192.0, 7212.3148300911325, 7251.8187045324285, 7262.419006479363, 7266.67299971492, 7441.851162976818, 7588.354989825927, 7595.5822429764685, 7634.122075961113, 7657.2725591070985, 4725.29120631908, 4749.35883655702, 4768.356271903249, 4771.66598338113, 4786.425628924551, 7345.118585769742, 7352.11774587053, 7357.0, 7368.3736882363455, 7383.07711536058, 7023.894641580278, 7033.402160816183, 7081.716731330689, 7100.680469378994, 7113.790655588459, 6888.346796768839, 7079.575225486487, 7086.751963681247, 7101.502894797314, 7123.465740069619, 6862.656867156722, 6897.2757860423935, 6949.478789090939, 6959.26927672587, 6967.54710943787, 7140.107486564179, 7155.42756579462, 7158.3915367192285, 7158.606276654834, 7185.497015208885, 6970.477214209056, 6983.895241571482, 6984.860302794017, 6985.895211571728, 6988.965055174692], "value": 5283.5327178880925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.8345547435039, 788.8106854354957, 804.1315379390255, 861.3668953319309, 919.9724008279752, 14663.340149693262, 14818.184999825018, 14888.702225955489, 15262.389504419838, 15748.370065197407, 14997.10017398957, 15017.32422041008, 15021.774673379881, 15043.247837608104, 15098.0, 875.0, 883.6421249394006, 891.3448615267773, 896.2023798819056, 898.5192921786845, 902.1564836877508, 905.6467977488785, 905.950172740499, 908.0374802709149, 909.895362033368, 943.9008904065078, 956.8421210500259, 957.5738796235678, 957.6648173139415, 957.952102394881, 952.3666761603525, 952.8284908716394, 952.9047095290484, 953.2564599612244, 953.3183773601874, 697.7767114523355, 698.5040621158984, 700.0724040646164, 701.1516065560678, 702.6276073680957, 14923.328450219658, 15001.624959375993, 15097.094174349575, 15131.773023404548, 15157.0, 14312.713745725026, 14564.781528277084, 14567.635809104751, 14607.123572585679, 14678.633034174125, 11708.297502149899, 11739.823902641467, 11981.221220620631, 12052.0, 12175.0, 4625.514320996281, 4713.057388522309, 4768.5946694531, 4866.78099485524, 4884.534639608139, 50616.98766024696, 50702.49297507015, 50760.49239507595, 50980.49019509795, 51134.488655113346, 10878.238523303451, 11008.724781880517, 11089.944550277198, 11199.60801371948, 11240.875912408694, 19839.404817855488, 19965.101570429364, 20003.59992800136, 20072.0, 20137.798622013594, 8794.60424280909, 9157.542122893828, 9168.35821492489, 9224.631014759469, 9273.72178834636, 4855.271709243641, 4947.752612369367, 4953.72754498506, 4979.029089327546, 5028.145215313405, 3261.62491313502, 3297.1427428868665, 3310.3875782980226, 3317.4360358739073, 3318.8340582970754, 659.1990731261444, 675.6824292582478, 676.6650507998473, 681.4344094401634, 683.4839696029466, 833.9291160251447, 838.6852287685908, 841.9452735572169, 853.4537895746727, 853.7737499562621, 9184.081591840762, 9187.540622968825, 9250.629974801068, 9540.761480963032, 9577.856332155023, 823.7487566292218, 823.8887750153773, 828.7803732011022, 834.4117397234935, 850.6257246811383, 4553.977230113828, 4657.534246575383, 4677.415323084614, 4743.383360163157, 4745.264484004984, 66220.66889665618, 68104.0, 68195.0, 68354.3164568348, 68478.31521684819, 58069.12896306559, 58094.41905580975, 58183.0, 58830.70584647135, 59032.0, 51828.22257666138, 52379.73810131001, 52694.0, 53124.73437632787, 53827.46172538303, 9191.448513088968, 9212.0, 9229.49237791928, 9331.393459425115, 9428.0, 39280.0, 39686.60313396829, 39758.2048359037, 39915.80042099771, 40114.598854012256, 46810.531894680615, 46841.53158468508, 49992.50007499878, 50176.749116254185, 50865.491345087554, 10936.835947460953, 11086.722831928944, 11295.887041129483, 11348.262362946381, 11411.771764564828, 12083.39583020863, 12137.332446715516, 12250.571230006906, 12788.232706037668, 12963.15739476931, 11990.100742444525, 11994.520219191134, 12017.4592143352, 12033.939830300793, 12624.3687815607, 11541.307521548733, 11773.117016223989, 11846.763064738485, 11966.282023078644, 12208.572699955459, 11357.261777984404, 11508.712282193012, 11555.2489088209, 11585.536578536765, 11857.11071669611, 9696.466694331879, 9699.272554558578, 9752.46361450127, 9974.20206383502, 10147.137493313152, 9843.310968232156, 9883.430020856626, 9924.1068303853, 9986.650467233612, 9989.750256243651], "value": 7062.37468205965, "unit": "score"}], "name": "dromaeo_css", "value": 7508.002513254476, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 111.0, 103.0, 112.0, 113.0, 111.0, 101.0, 110.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 127.0, 155.0, 168.0, 130.0, 166.0, 157.0, 134.0, 179.0, 130.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 161.0, 163.0, 162.0, 164.0, 163.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 76.0, 187.0, 74.0, 76.0, 75.0, 74.0, 170.0, 77.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 155.0, 92.0, 93.0, 93.0, 145.0, 93.0, 92.0, 147.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 123.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 146.0, 149.0, 146.0, 146.0, 147.0, 149.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 65.0, 69.0, 62.0, 61.0, 82.0, 59.0, 58.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 57.0, 57.0, 58.0, 58.0, 57.0, 56.0, 58.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 72.0, 72.0, 73.0, 74.0, 74.0, 73.0, 75.0, 76.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 114.0, 115.0, 117.0, 111.0, 126.0, 121.0, 117.0, 131.0, 128.0], "value": 120.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 170.0, 160.0, 157.0, 166.0, 157.0, 158.0, 161.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 66.0, 65.0, 68.0, 67.0, 65.0, 67.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1534.8, "alertThreshold": 2.0}]} 03:47:55 INFO - Return code: 0 03:47:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:47:55 ERROR - # TBPL SUCCESS # 03:47:55 INFO - Running post-action listener: _resource_record_post_action 03:47:55 INFO - Running post-run listener: _resource_record_post_run 03:47:56 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 499548160; Read time: 12; Write time: 461136 03:47:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248918016; Read time: 0; Write time: 289140 03:47:56 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250458112; Read time: 12; Write time: 171980 03:47:56 INFO - Running post-run listener: _upload_blobber_files 03:47:56 INFO - Blob upload gear active. 03:47:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:56 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 03:47:56 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'] 03:47:56 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 03:47:57 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:47:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:47:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:57 INFO - (blobuploader) - INFO - Done attempting. 03:47:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:47:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:47:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:58 INFO - (blobuploader) - INFO - Done attempting. 03:47:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:58 INFO - Return code: 0 03:47:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74e6730fe1b82f5766a29392d02d42ae2be071605acf684dd01cb7f8cd04602c3da47af3eff0c4e5d1ac70d34d9449c573a6a61c2af709bc93dff72d90580445", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3bc6d614e7555d6a2caa5fae21e7dfdc11b2e35953c7427dadb58430e9496571fd5ed71672065504ac1c75f401fc957c15afaf178cd16bc991a572bcc7b7c41"} 03:47:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:58 INFO - Contents: 03:47:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74e6730fe1b82f5766a29392d02d42ae2be071605acf684dd01cb7f8cd04602c3da47af3eff0c4e5d1ac70d34d9449c573a6a61c2af709bc93dff72d90580445", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3bc6d614e7555d6a2caa5fae21e7dfdc11b2e35953c7427dadb58430e9496571fd5ed71672065504ac1c75f401fc957c15afaf178cd16bc991a572bcc7b7c41"} 03:47:58 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:58 INFO - Copying logs to upload dir... 03:47:58 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.861220 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-27 03:47:58.721887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 03:47:58.724915) ========= 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=574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690 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/74e6730fe1b82f5766a29392d02d42ae2be071605acf684dd01cb7f8cd04602c3da47af3eff0c4e5d1ac70d34d9449c573a6a61c2af709bc93dff72d90580445", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3bc6d614e7555d6a2caa5fae21e7dfdc11b2e35953c7427dadb58430e9496571fd5ed71672065504ac1c75f401fc957c15afaf178cd16bc991a572bcc7b7c41"} build_url:https://queue.taskcluster.net/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/Y7tYu8WlQ9mE-Mh1P3f--Q/artifacts/public/build/firefox-48.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/74e6730fe1b82f5766a29392d02d42ae2be071605acf684dd01cb7f8cd04602c3da47af3eff0c4e5d1ac70d34d9449c573a6a61c2af709bc93dff72d90580445", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3bc6d614e7555d6a2caa5fae21e7dfdc11b2e35953c7427dadb58430e9496571fd5ed71672065504ac1c75f401fc957c15afaf178cd16bc991a572bcc7b7c41"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 03:47:58.750458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 03:47:58.750793) ========= 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=574dc5aafe09851ec43d388c000001b6-1464343047.978906-691091690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 03:47:58.833452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 03:47:58.836919) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 03:47:58.837294) ========= ========= Total master_lag: 0.18 =========