builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1460876789.64 results: success (0) buildid: 20160416212120 builduid: 5254d865fc4b4285b97906f56f3257ee revision: 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:29.637970) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:29.638534) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:29.638849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:29.729766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:29.730129) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-17 00:06:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.7M=0s 2016-04-17 00:06:30 (88.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095058 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:29.845694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:29.846043) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017147 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:29.896566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:29.897035) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 --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 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 --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=9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-17 00:06:30,507 truncating revision to first 12 chars 2016-04-17 00:06:30,507 Setting DEBUG logging. 2016-04-17 00:06:30,507 attempt 1/10 2016-04-17 00:06:30,507 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/02b8dc35ec80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-17 00:06:30,859 unpacking tar archive at: mozilla-aurora-02b8dc35ec80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662792 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:30.573654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:30.573984) ========= script_repo_revision: 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:30.574451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:30.574762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 00:06:30.589065) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-17 00:06:30.589403) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:06:31 INFO - MultiFileLogger online at 20160417 00:06:31 in /builds/slave/test 00:06:31 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 00:06:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:06:31 INFO - {'append_to_log': False, 00:06:31 INFO - 'base_work_dir': '/builds/slave/test', 00:06:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:06:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:06:31 INFO - 'branch': 'Mozilla-Aurora', 00:06:31 INFO - 'buildbot_json_path': 'buildprops.json', 00:06:31 INFO - 'config_files': ('talos/linux_config.py',), 00:06:31 INFO - 'default_actions': ('clobber', 00:06:31 INFO - 'read-buildbot-config', 00:06:31 INFO - 'download-and-extract', 00:06:31 INFO - 'populate-webroot', 00:06:31 INFO - 'create-virtualenv', 00:06:31 INFO - 'install', 00:06:31 INFO - 'run-tests'), 00:06:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:06:31 INFO - 'download_minidump_stackwalk': True, 00:06:31 INFO - 'download_symbols': 'ondemand', 00:06:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:06:31 INFO - 'tooltool.py': '/tools/tooltool.py', 00:06:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:06:31 INFO - '/tools/misc-python/virtualenv.py')}, 00:06:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:06:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:06:31 INFO - 'installer_path': 'installer.exe', 00:06:31 INFO - 'log_level': 'info', 00:06:31 INFO - 'log_name': 'talos', 00:06:31 INFO - 'log_to_console': True, 00:06:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:06:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:06:31 INFO - 'opt_config_files': (), 00:06:31 INFO - 'pip_index': False, 00:06:31 INFO - 'sps_profile': False, 00:06:31 INFO - 'sps_profile_interval': 0, 00:06:31 INFO - 'suite': 'dromaeojs-e10s', 00:06:31 INFO - 'system_bits': '32', 00:06:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:06:31 INFO - 'title': 'talos-linux64-ix-040', 00:06:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:06:31 INFO - 'use_talos_json': True, 00:06:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:06:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:06:31 INFO - 'work_dir': 'build'} 00:06:31 INFO - ##### 00:06:31 INFO - ##### Running clobber step. 00:06:31 INFO - ##### 00:06:31 INFO - Running pre-action listener: _resource_record_pre_action 00:06:31 INFO - Running main action method: clobber 00:06:31 INFO - rmtree: /builds/slave/test/build 00:06:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:06:31 INFO - Running post-action listener: _resource_record_post_action 00:06:31 INFO - ##### 00:06:31 INFO - ##### Running read-buildbot-config step. 00:06:31 INFO - ##### 00:06:31 INFO - Running pre-action listener: _resource_record_pre_action 00:06:31 INFO - Running main action method: read_buildbot_config 00:06:31 INFO - Using buildbot properties: 00:06:31 INFO - { 00:06:31 INFO - "project": "", 00:06:31 INFO - "product": "firefox", 00:06:31 INFO - "script_repo_revision": "production", 00:06:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 00:06:31 INFO - "repository": "", 00:06:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 00:06:31 INFO - "buildid": "20160416212120", 00:06:31 INFO - "pgo_build": "True", 00:06:31 INFO - "basedir": "/builds/slave/test", 00:06:31 INFO - "buildnumber": 301, 00:06:31 INFO - "slavename": "talos-linux64-ix-040", 00:06:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:06:31 INFO - "platform": "ubuntu64_hw", 00:06:31 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 00:06:31 INFO - "branch": "mozilla-aurora", 00:06:31 INFO - "repo_path": "releases/mozilla-aurora", 00:06:31 INFO - "revision": "02b8dc35ec80a95dd4f1cdd5a4075718aed233f2", 00:06:31 INFO - "stage_platform": "linux64-pgo", 00:06:31 INFO - "builduid": "5254d865fc4b4285b97906f56f3257ee", 00:06:31 INFO - "slavebuilddir": "test" 00:06:31 INFO - } 00:06:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 00:06:31 INFO - Running post-action listener: _resource_record_post_action 00:06:31 INFO - ##### 00:06:31 INFO - ##### Running download-and-extract step. 00:06:31 INFO - ##### 00:06:31 INFO - Running pre-action listener: _resource_record_pre_action 00:06:31 INFO - Running main action method: download_and_extract 00:06:31 INFO - mkdir: /builds/slave/test/build/tests 00:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:31 INFO - https://queue.taskcluster.net/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:06:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 00:06:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 00:06:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 00:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:06:46 INFO - Downloaded 1448 bytes. 00:06:46 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 00:06:46 INFO - Using the following test package requirements: 00:06:46 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 00:06:46 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:06:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 00:06:46 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:06:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 00:06:46 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:06:46 INFO - u'jsshell-linux-x86_64.zip'], 00:06:46 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:06:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 00:06:46 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 00:06:46 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:06:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 00:06:46 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:06:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 00:06:46 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:06:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 00:06:46 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 00:06:46 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:06:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 00:06:46 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:06: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')]} 00:06:46 INFO - https://queue.taskcluster.net/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:06:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:06:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:06:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:06:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:06:47 INFO - Downloaded 23352307 bytes. 00:06:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:06:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:06:48 INFO - Return code: 0 00:06:48 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:06: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')]} 00:06:48 INFO - https://queue.taskcluster.net/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:06:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:06:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:06:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:06:54 INFO - Downloaded 23352307 bytes. 00:06:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:06:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:06:56 INFO - Return code: 0 00:06:56 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')]} 00:06:56 INFO - https://queue.taskcluster.net/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:06:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 00:06:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 00:06:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 00:06:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:06:57 INFO - Downloaded 10845168 bytes. 00:06:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:06:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:06:57 INFO - Return code: 0 00:06: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')]} 00:06:57 INFO - https://queue.taskcluster.net/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:06:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 00:06:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 00:06:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 00:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:06:58 INFO - Downloaded 60596026 bytes. 00:06:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 00:06:58 INFO - mkdir: /builds/slave/test/properties 00:06:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:06:58 INFO - Writing to file /builds/slave/test/properties/build_url 00:06:58 INFO - Contents: 00:06:58 INFO - build_url:https://queue.taskcluster.net/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 00:06:59 INFO - Running post-action listener: _resource_record_post_action 00:06:59 INFO - Running post-action listener: set_extra_try_arguments 00:06:59 INFO - ##### 00:06:59 INFO - ##### Running populate-webroot step. 00:06:59 INFO - ##### 00:06:59 INFO - Running pre-action listener: _resource_record_pre_action 00:06:59 INFO - Running main action method: populate_webroot 00:06:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:06:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:06:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:06:59 INFO - '--tppagecycles', 00:06:59 INFO - '7'], 00:06:59 INFO - 'tests': ['tsvgm']}}, 00:06:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:06:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:06:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:06:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 00:06:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:06:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:06:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:06:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:59 INFO - 'talos_options': ['--e10s'], 00:06:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:06:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:59 INFO - 'tests': ['damp', 'tps']}, 00:06:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:59 INFO - 'talos_options': ['--e10s'], 00:06:59 INFO - 'tests': ['damp', 'tps']}, 00:06:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:06:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:06:59 INFO - 'other': {'tests': ['a11yr', 00:06:59 INFO - 'ts_paint', 00:06:59 INFO - 'tpaint', 00:06:59 INFO - 'sessionrestore', 00:06:59 INFO - 'sessionrestore_no_auto_restore', 00:06:59 INFO - 'tabpaint']}, 00:06:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:06:59 INFO - 'tests': ['a11yr', 00:06:59 INFO - 'ts_paint', 00:06:59 INFO - 'tpaint', 00:06:59 INFO - 'sessionrestore', 00:06:59 INFO - 'sessionrestore_no_auto_restore', 00:06:59 INFO - 'tabpaint']}, 00:06:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:06:59 INFO - 'tests': ['a11yr', 00:06:59 INFO - 'ts_paint', 00:06:59 INFO - 'tpaint', 00:06:59 INFO - 'sessionrestore', 00:06:59 INFO - 'sessionrestore_no_auto_restore', 00:06:59 INFO - 'tabpaint']}, 00:06:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:06:59 INFO - 'tests': ['a11yr', 00:06:59 INFO - 'ts_paint', 00:06:59 INFO - 'tpaint', 00:06:59 INFO - 'sessionrestore', 00:06:59 INFO - 'sessionrestore_no_auto_restore', 00:06:59 INFO - 'tabpaint']}, 00:06:59 INFO - 'other_l64': {'tests': ['a11yr', 00:06:59 INFO - 'ts_paint', 00:06:59 INFO - 'tpaint', 00:06:59 INFO - 'sessionrestore', 00:06:59 INFO - 'sessionrestore_no_auto_restore', 00:06:59 INFO - 'tabpaint']}, 00:06:59 INFO - 'other_nol64': {'tests': ['a11yr', 00:06:59 INFO - 'ts_paint', 00:06:59 INFO - 'tpaint', 00:06:59 INFO - 'sessionrestore', 00:06:59 INFO - 'sessionrestore_no_auto_restore', 00:06:59 INFO - 'tabpaint']}, 00:06:59 INFO - 'svgr': {'tests': ['tsvgx', 00:06:59 INFO - 'tsvgr_opacity', 00:06:59 INFO - 'tart', 00:06:59 INFO - 'tscrollx', 00:06:59 INFO - 'cart']}, 00:06:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:06:59 INFO - 'tests': ['tsvgx', 00:06:59 INFO - 'tsvgr_opacity', 00:06:59 INFO - 'tart', 00:06:59 INFO - 'tscrollx', 00:06:59 INFO - 'cart']}, 00:06:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:59 INFO - 'tests': ['tp5o']}, 00:06:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:59 INFO - 'talos_options': ['--e10s'], 00:06:59 INFO - 'tests': ['tp5o']}, 00:06:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:59 INFO - 'talos_options': ['--xperf_path', 00:06:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:06:59 INFO - 'tests': ['tp5n']}, 00:06:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:06:59 INFO - 'talos_options': ['--e10s', 00:06:59 INFO - '--xperf_path', 00:06:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:06:59 INFO - 'tests': ['tp5n']}}, 00:06:59 INFO - 'talos.zip': {'path': '', 00:06:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:06:59 INFO - Running post-action listener: _resource_record_post_action 00:06:59 INFO - ##### 00:06:59 INFO - ##### Running create-virtualenv step. 00:06:59 INFO - ##### 00:06:59 INFO - Running pre-action listener: _resource_record_pre_action 00:06:59 INFO - Running main action method: create_virtualenv 00:06:59 INFO - Creating virtualenv /builds/slave/test/build/venv 00:06:59 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 00:06:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:06:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:06:59 INFO - Using real prefix '/usr' 00:06:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:07:00 INFO - Installing distribute.............................................................................................................................................................................................done. 00:07:02 INFO - Installing pip.................done. 00:07:02 INFO - Return code: 0 00:07:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:02 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 0x7f81178daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e160>, '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 0x162f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162f4f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', '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 00:07:02 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 00:07:02 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 00:07:02 INFO - Using env: {'DISPLAY': ':0', 00:07:02 INFO - 'HOME': '/home/cltbld', 00:07:02 INFO - 'LANG': 'en_US.UTF-8', 00:07:02 INFO - 'LANGUAGE': 'en_US:en', 00:07:02 INFO - 'LOGNAME': 'cltbld', 00:07:02 INFO - 'MAIL': '/var/mail/cltbld', 00:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:02 INFO - 'MOZ_NO_REMOTE': '1', 00:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:02 INFO - 'NO_EM_RESTART': '1', 00:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:02 INFO - 'PWD': '/builds/slave/test', 00:07:02 INFO - 'SHELL': '/bin/bash', 00:07:02 INFO - 'SHLVL': '1', 00:07:02 INFO - 'TERM': 'linux', 00:07:02 INFO - 'TMOUT': '86400', 00:07:02 INFO - 'USER': 'cltbld', 00:07:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', 00:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:02 INFO - '_': '/tools/buildbot/bin/python'} 00:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:02 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 00:07:02 INFO - Cleaning up... 00:07:02 INFO - Return code: 0 00:07:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:02 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 0x7f81178daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e160>, '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 0x162f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162f4f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', '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 00:07:02 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 00:07:02 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 00:07:02 INFO - Using env: {'DISPLAY': ':0', 00:07:02 INFO - 'HOME': '/home/cltbld', 00:07:02 INFO - 'LANG': 'en_US.UTF-8', 00:07:02 INFO - 'LANGUAGE': 'en_US:en', 00:07:02 INFO - 'LOGNAME': 'cltbld', 00:07:02 INFO - 'MAIL': '/var/mail/cltbld', 00:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:02 INFO - 'MOZ_NO_REMOTE': '1', 00:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:02 INFO - 'NO_EM_RESTART': '1', 00:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:02 INFO - 'PWD': '/builds/slave/test', 00:07:02 INFO - 'SHELL': '/bin/bash', 00:07:02 INFO - 'SHLVL': '1', 00:07:02 INFO - 'TERM': 'linux', 00:07:02 INFO - 'TMOUT': '86400', 00:07:02 INFO - 'USER': 'cltbld', 00:07:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', 00:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:02 INFO - '_': '/tools/buildbot/bin/python'} 00:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:02 INFO - Downloading/unpacking psutil>=0.7.1 00:07: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 00:07: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 00:07: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 00:07: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 00:07: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 00:07: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 00:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:07:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:07:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:07:04 INFO - Installing collected packages: psutil 00:07:04 INFO - Running setup.py install for psutil 00:07:04 INFO - building 'psutil._psutil_linux' extension 00:07:04 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 00:07:04 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 00:07:04 INFO - building 'psutil._psutil_posix' extension 00:07:04 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 00:07:04 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 00:07:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:07:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:07:04 INFO - Successfully installed psutil 00:07:04 INFO - Cleaning up... 00:07:05 INFO - Return code: 0 00:07:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:07:05 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')]} 00:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:05 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')]} 00:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:05 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 0x7f81178daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e160>, '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 0x162f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162f4f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', '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 00:07:05 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 00:07:05 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 00:07:05 INFO - Using env: {'DISPLAY': ':0', 00:07:05 INFO - 'HOME': '/home/cltbld', 00:07:05 INFO - 'LANG': 'en_US.UTF-8', 00:07:05 INFO - 'LANGUAGE': 'en_US:en', 00:07:05 INFO - 'LOGNAME': 'cltbld', 00:07:05 INFO - 'MAIL': '/var/mail/cltbld', 00:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:05 INFO - 'MOZ_NO_REMOTE': '1', 00:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:05 INFO - 'NO_EM_RESTART': '1', 00:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:05 INFO - 'PWD': '/builds/slave/test', 00:07:05 INFO - 'SHELL': '/bin/bash', 00:07:05 INFO - 'SHLVL': '1', 00:07:05 INFO - 'TERM': 'linux', 00:07:05 INFO - 'TMOUT': '86400', 00:07:05 INFO - 'USER': 'cltbld', 00:07:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', 00:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:05 INFO - '_': '/tools/buildbot/bin/python'} 00:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:07:05 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 00:07:05 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 00:07:05 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 00:07:05 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 00:07:05 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 00:07:05 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 00:07:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:07:07 INFO - Installing collected packages: mozsystemmonitor 00:07:07 INFO - Running setup.py install for mozsystemmonitor 00:07:07 INFO - Successfully installed mozsystemmonitor 00:07:07 INFO - Cleaning up... 00:07:07 INFO - Return code: 0 00:07:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:07:07 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')]} 00:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:07 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')]} 00:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:07 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 0x7f81178daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e160>, '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 0x162f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162f4f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', '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 00:07:07 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 00:07:07 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 00:07:07 INFO - Using env: {'DISPLAY': ':0', 00:07:07 INFO - 'HOME': '/home/cltbld', 00:07:07 INFO - 'LANG': 'en_US.UTF-8', 00:07:07 INFO - 'LANGUAGE': 'en_US:en', 00:07:07 INFO - 'LOGNAME': 'cltbld', 00:07:07 INFO - 'MAIL': '/var/mail/cltbld', 00:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:07 INFO - 'MOZ_NO_REMOTE': '1', 00:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:07 INFO - 'NO_EM_RESTART': '1', 00:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:07 INFO - 'PWD': '/builds/slave/test', 00:07:07 INFO - 'SHELL': '/bin/bash', 00:07:07 INFO - 'SHLVL': '1', 00:07:07 INFO - 'TERM': 'linux', 00:07:07 INFO - 'TMOUT': '86400', 00:07:07 INFO - 'USER': 'cltbld', 00:07:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', 00:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:07 INFO - '_': '/tools/buildbot/bin/python'} 00:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:07 INFO - Downloading/unpacking blobuploader==1.2.4 00:07: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 00:07: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 00:07: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 00:07: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 00:07: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 00:07: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 00:07:09 INFO - Downloading blobuploader-1.2.4.tar.gz 00:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:07:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:07:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:10 INFO - Downloading docopt-0.6.1.tar.gz 00:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:07:10 INFO - Installing collected packages: blobuploader, requests, docopt 00:07:10 INFO - Running setup.py install for blobuploader 00:07:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:07:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:07:10 INFO - Running setup.py install for requests 00:07:10 INFO - Running setup.py install for docopt 00:07:10 INFO - Successfully installed blobuploader requests docopt 00:07:10 INFO - Cleaning up... 00:07:10 INFO - Return code: 0 00:07:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:10 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 0x7f81178daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e160>, '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 0x162f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162f4f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', '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 00:07:10 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 00:07:10 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 00:07:10 INFO - Using env: {'DISPLAY': ':0', 00:07:10 INFO - 'HOME': '/home/cltbld', 00:07:10 INFO - 'LANG': 'en_US.UTF-8', 00:07:10 INFO - 'LANGUAGE': 'en_US:en', 00:07:10 INFO - 'LOGNAME': 'cltbld', 00:07:10 INFO - 'MAIL': '/var/mail/cltbld', 00:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:10 INFO - 'MOZ_NO_REMOTE': '1', 00:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:10 INFO - 'NO_EM_RESTART': '1', 00:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:10 INFO - 'PWD': '/builds/slave/test', 00:07:10 INFO - 'SHELL': '/bin/bash', 00:07:10 INFO - 'SHLVL': '1', 00:07:10 INFO - 'TERM': 'linux', 00:07:10 INFO - 'TMOUT': '86400', 00:07:10 INFO - 'USER': 'cltbld', 00:07:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', 00:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:10 INFO - '_': '/tools/buildbot/bin/python'} 00:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:07:11 INFO - Running setup.py (path:/tmp/pip-8p_daQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:07:11 INFO - Running setup.py (path:/tmp/pip-w0sd_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:07:11 INFO - Running setup.py (path:/tmp/pip-3LIaia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:07:11 INFO - Running setup.py (path:/tmp/pip-jahMyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:07:11 INFO - Running setup.py (path:/tmp/pip-mngqTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:07:11 INFO - Running setup.py (path:/tmp/pip-sf55Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:07:11 INFO - Running setup.py (path:/tmp/pip-PfXpH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:07:11 INFO - Running setup.py (path:/tmp/pip-nOLJjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:07:11 INFO - Running setup.py (path:/tmp/pip-Xk8grn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:07:11 INFO - Running setup.py (path:/tmp/pip-qgIweM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:07:11 INFO - Running setup.py (path:/tmp/pip-AzQd8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:07:11 INFO - Running setup.py (path:/tmp/pip-VXjvWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:07:11 INFO - Running setup.py (path:/tmp/pip-O9kj8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:07:11 INFO - Running setup.py (path:/tmp/pip-5niQlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:07:12 INFO - Running setup.py (path:/tmp/pip-ZsbKDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:07:12 INFO - Running setup.py (path:/tmp/pip-GJQ1y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:07:12 INFO - Running setup.py (path:/tmp/pip-alhlPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:07:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:07:12 INFO - Running setup.py install for manifestparser 00:07:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:07:12 INFO - Running setup.py install for mozcrash 00:07:12 INFO - Running setup.py install for mozdebug 00:07:12 INFO - Running setup.py install for mozdevice 00:07:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:07:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:07:12 INFO - Running setup.py install for mozfile 00:07:12 INFO - Running setup.py install for mozhttpd 00:07:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:07:12 INFO - Running setup.py install for mozinfo 00:07:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:07:12 INFO - Running setup.py install for mozInstall 00:07:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Running setup.py install for mozleak 00:07:13 INFO - Running setup.py install for mozlog 00:07:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Running setup.py install for moznetwork 00:07:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Running setup.py install for mozprocess 00:07:13 INFO - Running setup.py install for mozprofile 00:07:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Running setup.py install for mozrunner 00:07:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Running setup.py install for mozscreenshot 00:07:13 INFO - Running setup.py install for moztest 00:07:13 INFO - Running setup.py install for mozversion 00:07:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:07:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:07:13 INFO - Cleaning up... 00:07:14 INFO - Return code: 0 00:07:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:07:14 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')]} 00:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:14 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')]} 00:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:14 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 0x7f81178daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e160>, '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 0x162f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162f4f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', '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 00:07:14 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 00:07:14 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 00:07:14 INFO - Using env: {'DISPLAY': ':0', 00:07:14 INFO - 'HOME': '/home/cltbld', 00:07:14 INFO - 'LANG': 'en_US.UTF-8', 00:07:14 INFO - 'LANGUAGE': 'en_US:en', 00:07:14 INFO - 'LOGNAME': 'cltbld', 00:07:14 INFO - 'MAIL': '/var/mail/cltbld', 00:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:14 INFO - 'MOZ_NO_REMOTE': '1', 00:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:14 INFO - 'NO_EM_RESTART': '1', 00:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:14 INFO - 'PWD': '/builds/slave/test', 00:07:14 INFO - 'SHELL': '/bin/bash', 00:07:14 INFO - 'SHLVL': '1', 00:07:14 INFO - 'TERM': 'linux', 00:07:14 INFO - 'TMOUT': '86400', 00:07:14 INFO - 'USER': 'cltbld', 00:07:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', 00:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:14 INFO - '_': '/tools/buildbot/bin/python'} 00:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:07:14 INFO - Running setup.py (path:/tmp/pip-uhJtZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:07:14 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)) 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:07:14 INFO - Running setup.py (path:/tmp/pip-1PwJSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:07:14 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)) 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:07:14 INFO - Running setup.py (path:/tmp/pip-jZlGmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:07:14 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)) 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:07:14 INFO - Running setup.py (path:/tmp/pip-QUWt6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:07:14 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)) 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:07:14 INFO - Running setup.py (path:/tmp/pip-LmOxHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:07:14 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)) 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:07:14 INFO - Running setup.py (path:/tmp/pip-oZfnMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:07:14 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)) 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:07:14 INFO - Running setup.py (path:/tmp/pip-y14DKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:07:14 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)) 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:07:14 INFO - Running setup.py (path:/tmp/pip-pdkVLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:07:14 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)) 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:07:14 INFO - Running setup.py (path:/tmp/pip-xE3CiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:07:14 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)) 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:07:14 INFO - Running setup.py (path:/tmp/pip-hf9eq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:07:14 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)) 00:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:07:14 INFO - Running setup.py (path:/tmp/pip-fUPuak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:07:15 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)) 00:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:07:15 INFO - Running setup.py (path:/tmp/pip-7iRZhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:07:15 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)) 00:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:07:15 INFO - Running setup.py (path:/tmp/pip-a58ZIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:07:15 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)) 00:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:07:15 INFO - Running setup.py (path:/tmp/pip-92KSz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:07:15 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)) 00:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:07:15 INFO - Running setup.py (path:/tmp/pip-C5SIux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:07:15 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)) 00:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:07:15 INFO - Running setup.py (path:/tmp/pip-YM0spu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:07:15 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)) 00:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:07:15 INFO - Running setup.py (path:/tmp/pip-Fpp0GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:07:15 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)) 00:07:15 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)) 00:07:15 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)) 00:07:15 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)) 00:07:15 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)) 00:07:15 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)) 00:07:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:17 INFO - Downloading blessings-1.6.tar.gz 00:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:07:17 INFO - Installing collected packages: blessings 00:07:17 INFO - Running setup.py install for blessings 00:07:17 INFO - Successfully installed blessings 00:07:17 INFO - Cleaning up... 00:07:17 INFO - Return code: 0 00:07:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:07:17 INFO - Reading from file tmpfile_stdout 00:07:17 INFO - Current package versions: 00:07:17 INFO - argparse == 1.2.1 00:07:17 INFO - blessings == 1.6 00:07:17 INFO - blobuploader == 1.2.4 00:07:17 INFO - docopt == 0.6.1 00:07:17 INFO - manifestparser == 1.1 00:07:17 INFO - mozInstall == 1.12 00:07:17 INFO - mozcrash == 0.17 00:07:17 INFO - mozdebug == 0.1 00:07:17 INFO - mozdevice == 0.48 00:07:17 INFO - mozfile == 1.2 00:07:17 INFO - mozhttpd == 0.7 00:07:17 INFO - mozinfo == 0.9 00:07:17 INFO - mozleak == 0.1 00:07:17 INFO - mozlog == 3.1 00:07:17 INFO - moznetwork == 0.27 00:07:17 INFO - mozprocess == 0.22 00:07:17 INFO - mozprofile == 0.28 00:07:17 INFO - mozrunner == 6.11 00:07:17 INFO - mozscreenshot == 0.1 00:07:17 INFO - mozsystemmonitor == 0.0 00:07:17 INFO - moztest == 0.7 00:07:17 INFO - mozversion == 1.4 00:07:17 INFO - psutil == 3.1.1 00:07:17 INFO - requests == 1.2.3 00:07:17 INFO - wsgiref == 0.1.2 00:07:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:17 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 0x7f81178daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e160>, '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 0x162f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162f4f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', '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 00:07:17 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 00:07:17 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 00:07:17 INFO - Using env: {'DISPLAY': ':0', 00:07:17 INFO - 'HOME': '/home/cltbld', 00:07:17 INFO - 'LANG': 'en_US.UTF-8', 00:07:17 INFO - 'LANGUAGE': 'en_US:en', 00:07:17 INFO - 'LOGNAME': 'cltbld', 00:07:17 INFO - 'MAIL': '/var/mail/cltbld', 00:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:17 INFO - 'MOZ_NO_REMOTE': '1', 00:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:17 INFO - 'NO_EM_RESTART': '1', 00:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:17 INFO - 'PWD': '/builds/slave/test', 00:07:17 INFO - 'SHELL': '/bin/bash', 00:07:17 INFO - 'SHLVL': '1', 00:07:17 INFO - 'TERM': 'linux', 00:07:17 INFO - 'TMOUT': '86400', 00:07:17 INFO - 'USER': 'cltbld', 00:07:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', 00:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:17 INFO - '_': '/tools/buildbot/bin/python'} 00:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:17 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)) 00:07:17 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)) 00:07:17 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)) 00:07:17 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)) 00:07:17 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)) 00:07:17 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)) 00:07:17 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)) 00:07:17 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)) 00:07:17 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)) 00:07:17 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)) 00:07:17 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)) 00:07:17 INFO - Cleaning up... 00:07:17 INFO - Return code: 0 00:07:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:17 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 0x7f81178daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e160>, '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 0x162f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162f4f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', '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 00:07:17 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 00:07:17 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 00:07:17 INFO - Using env: {'DISPLAY': ':0', 00:07:17 INFO - 'HOME': '/home/cltbld', 00:07:17 INFO - 'LANG': 'en_US.UTF-8', 00:07:17 INFO - 'LANGUAGE': 'en_US:en', 00:07:17 INFO - 'LOGNAME': 'cltbld', 00:07:17 INFO - 'MAIL': '/var/mail/cltbld', 00:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:17 INFO - 'MOZ_NO_REMOTE': '1', 00:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:17 INFO - 'NO_EM_RESTART': '1', 00:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:17 INFO - 'PWD': '/builds/slave/test', 00:07:17 INFO - 'SHELL': '/bin/bash', 00:07:17 INFO - 'SHLVL': '1', 00:07:17 INFO - 'TERM': 'linux', 00:07:17 INFO - 'TMOUT': '86400', 00:07:17 INFO - 'USER': 'cltbld', 00:07:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', 00:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:17 INFO - '_': '/tools/buildbot/bin/python'} 00:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:18 INFO - Downloading/unpacking jsonschema 00:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:07:20 INFO - Downloading/unpacking functools32 (from jsonschema) 00:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:20 INFO - Downloading functools32-3.2.3-2.tar.gz 00:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:07:20 INFO - warning: no files found matching '*.txt' 00:07:20 INFO - no previously-included directories found matching 'build' 00:07:20 INFO - no previously-included directories found matching 'dist' 00:07:20 INFO - no previously-included directories found matching '.git*' 00:07:20 INFO - Installing collected packages: jsonschema, functools32 00:07:20 INFO - Running setup.py install for functools32 00:07:20 INFO - warning: no files found matching '*.txt' 00:07:20 INFO - no previously-included directories found matching 'build' 00:07:20 INFO - no previously-included directories found matching 'dist' 00:07:20 INFO - no previously-included directories found matching '.git*' 00:07:20 INFO - Successfully installed jsonschema functools32 00:07:20 INFO - Cleaning up... 00:07:20 INFO - Return code: 0 00:07:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:07:20 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')]} 00:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:20 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')]} 00:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:20 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 0x7f81178daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162e160>, '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 0x162f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162f4f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', '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 00:07:20 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 00:07:20 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 00:07:20 INFO - Using env: {'DISPLAY': ':0', 00:07:20 INFO - 'HOME': '/home/cltbld', 00:07:20 INFO - 'LANG': 'en_US.UTF-8', 00:07:20 INFO - 'LANGUAGE': 'en_US:en', 00:07:20 INFO - 'LOGNAME': 'cltbld', 00:07:20 INFO - 'MAIL': '/var/mail/cltbld', 00:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:20 INFO - 'MOZ_NO_REMOTE': '1', 00:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:20 INFO - 'NO_EM_RESTART': '1', 00:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:20 INFO - 'PWD': '/builds/slave/test', 00:07:20 INFO - 'SHELL': '/bin/bash', 00:07:20 INFO - 'SHLVL': '1', 00:07:20 INFO - 'TERM': 'linux', 00:07:20 INFO - 'TMOUT': '86400', 00:07:20 INFO - 'USER': 'cltbld', 00:07:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', 00:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:20 INFO - '_': '/tools/buildbot/bin/python'} 00:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:20 INFO - Downloading/unpacking flake8 00:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:07:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:07:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:07:22 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 00:07:22 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 00:07:22 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 00:07:22 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 00:07:22 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 00:07:22 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 00:07:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:07:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:07:22 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 00:07:22 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 00:07:22 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 00:07:22 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 00:07:22 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 00:07:22 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 00:07:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:07:23 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 00:07:23 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 00:07:23 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 00:07:23 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 00:07:23 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 00:07:23 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 00:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:07:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:07:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:07:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:07:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:07:23 INFO - no previously-included directories found matching 'docs/_build' 00:07:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:07:23 INFO - Running setup.py install for pep8 00:07:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:07:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:07:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:07:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:07:23 INFO - no previously-included directories found matching 'docs/_build' 00:07:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:07:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:07:23 INFO - Cleaning up... 00:07:23 INFO - Return code: 0 00:07:23 INFO - Running post-action listener: _resource_record_post_action 00:07:23 INFO - Running post-action listener: _start_resource_monitoring 00:07:23 INFO - Starting resource monitoring. 00:07:23 INFO - ##### 00:07:23 INFO - ##### Running install step. 00:07:23 INFO - ##### 00:07:23 INFO - Running pre-action listener: _resource_record_pre_action 00:07:23 INFO - Running main action method: install 00:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:07:23 INFO - Reading from file tmpfile_stdout 00:07:23 INFO - Detecting whether we're running mozinstall >=1.0... 00:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:07:23 INFO - Reading from file tmpfile_stdout 00:07:23 INFO - Output received: 00:07:23 INFO - Usage: mozinstall [options] installer 00:07:23 INFO - Options: 00:07:23 INFO - -h, --help show this help message and exit 00:07:23 INFO - -d DEST, --destination=DEST 00:07:23 INFO - Directory to install application into. [default: 00:07:23 INFO - "/builds/slave/test"] 00:07:23 INFO - --app=APP Application being installed. [default: firefox] 00:07:23 INFO - mkdir: /builds/slave/test/build/application 00:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:07:39 INFO - Reading from file tmpfile_stdout 00:07:39 INFO - Output received: 00:07:39 INFO - /builds/slave/test/build/application/firefox/firefox 00:07:39 INFO - Running post-action listener: _resource_record_post_action 00:07:39 INFO - ##### 00:07:39 INFO - ##### Running run-tests step. 00:07:39 INFO - ##### 00:07:39 INFO - Running pre-action listener: _resource_record_pre_action 00:07:39 INFO - Running main action method: run_tests 00:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:07:39 INFO - Python 2.7.3 00:07:39 INFO - Return code: 0 00:07:39 INFO - grabbing minidump binary from tooltool 00:07: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')]} 00:07:39 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 0x162e160>, '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 0x162f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162f4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:07:39 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 00:07:39 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 00:07:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:07:39 INFO - Return code: 0 00:07:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:07:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:07:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:07:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:07:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:07:40 INFO - Return code: 0 00:07:40 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/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 00:07:40 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/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 00:07:40 INFO - Using env: {'DISPLAY': ':0', 00:07:40 INFO - 'HOME': '/home/cltbld', 00:07:40 INFO - 'LANG': 'en_US.UTF-8', 00:07:40 INFO - 'LANGUAGE': 'en_US:en', 00:07:40 INFO - 'LOGNAME': 'cltbld', 00:07:40 INFO - 'MAIL': '/var/mail/cltbld', 00:07:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:07:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:40 INFO - 'MOZ_NO_REMOTE': '1', 00:07:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:40 INFO - 'NO_EM_RESTART': '1', 00:07:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:40 INFO - 'PWD': '/builds/slave/test', 00:07:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:07:40 INFO - 'SHELL': '/bin/bash', 00:07:40 INFO - 'SHLVL': '1', 00:07:40 INFO - 'TERM': 'linux', 00:07:40 INFO - 'TMOUT': '86400', 00:07:40 INFO - 'USER': 'cltbld', 00:07:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766', 00:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:40 INFO - '_': '/tools/buildbot/bin/python'} 00:07:40 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/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 00:07:40 INFO - mozversion application_buildid: 20160416212120 00:07:40 INFO - mozversion application_changeset: 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 00:07:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:07:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:07:40 INFO - mozversion application_name: Firefox 00:07:40 INFO - mozversion application_remotingname: firefox-dev 00:07:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:07:40 INFO - mozversion application_vendor: Mozilla 00:07:40 INFO - mozversion application_version: 47.0a2 00:07:40 INFO - mozversion platform_buildid: 20160416212120 00:07:40 INFO - mozversion platform_changeset: 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 00:07:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:07:40 INFO - mozversion platform_version: 47.0a2 00:07:40 INFO - using testdate: 1460876860 00:07:40 INFO - actual date: 1460876860 00:07:40 INFO - starting webserver on 'localhost:48460' 00:07:40 INFO - SUITE-START | Running 2 tests 00:07:40 INFO - TEST-START | dromaeo_css 00:07:40 INFO - operating with platform_type : linux_ 00:07:40 INFO - Initialising browser for dromaeo_css test... 00:07:40 INFO - TEST-INFO | started process 16771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIMTv1O/profile http://localhost:48460/getInfo.html) 00:07:44 INFO - PROCESS | 16771 | 00:07:44 INFO - PROCESS | 16771 | (process:16848): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:07:45 INFO - PROCESS | 16771 | __metrics Screen width/height:1600/1200 00:07:45 INFO - PROCESS | 16771 | colorDepth:24 00:07:45 INFO - PROCESS | 16771 | Browser inner width/height: 1024/697 00:07:45 INFO - PROCESS | 16771 | __metrics 00:07:45 ERROR - PROCESS | 16771 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 00:07:46 INFO - TEST-INFO | 16771: exit 0 00:07:46 INFO - Browser initialized. 00:07:46 INFO - Running cycle 1/1 for dromaeo_css test... 00:07:46 INFO - TEST-INFO | started process 16899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIMTv1O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:07:48 INFO - PROCESS | 16899 | 00:07:48 INFO - PROCESS | 16899 | (process:16967): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:07:58 INFO - PROCESS | 16899 | RSS: Main: 151605248 00:07:58 INFO - PROCESS | 16899 | 00:08:48 INFO - PROCESS | 16899 | 1460876928139 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] 00:10:56 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:48460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48460/tests/dromaeo/cssquery-ext.html) 00:10:57 INFO - PROCESS | 16899 | RSS: Main: 153407488 00:10:57 INFO - PROCESS | 16899 | 00:13:59 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:48460/tests/dromaeo/cssquery-ext.html (next: http://localhost:48460/tests/dromaeo/cssquery-jquery.html) 00:13:59 INFO - PROCESS | 16899 | RSS: Main: 152752128 00:13:59 INFO - PROCESS | 16899 | 00:17:01 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:48460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48460/tests/dromaeo/cssquery-mootools.html) 00:17:01 INFO - PROCESS | 16899 | RSS: Main: 151703552 00:17:01 INFO - PROCESS | 16899 | 00:20:03 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:48460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48460/tests/dromaeo/cssquery-prototype.html) 00:20:04 INFO - PROCESS | 16899 | RSS: Main: 153632768 00:20:04 INFO - PROCESS | 16899 | 00:23:06 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:48460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48460/tests/dromaeo/cssquery-yui.html) 00:23:07 INFO - PROCESS | 16899 | RSS: Main: 152993792 00:23:07 INFO - PROCESS | 16899 | 00:26:09 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:48460/tests/dromaeo/cssquery-yui.html (next: http://localhost:48460/tests/dromaeo/cssquery-dojo.html) 00:26:09 INFO - PROCESS | 16899 | RSS: Main: 156995584 00:26:09 INFO - PROCESS | 16899 | 00:26:09 INFO - PROCESS | 16899 | __start_tp_report 00:26:09 INFO - PROCESS | 16899 | _x_x_mozilla_page_load 00:26:09 INFO - PROCESS | 16899 | _x_x_mozilla_page_load_details 00:26:09 INFO - PROCESS | 16899 | |i|pagename|runs| 00:26:09 INFO - PROCESS | 16899 | |0;dojo.html;3303.289792694571;3379.341028499443;3396.8641254349827;3436.6047904490993;3437.982810085951;5587.022271102556;5603.831885043455;5616.494515493605;5639.7180140993;5653.038983372826;5570.470805273492;5589.916151257735;5593.356763972144;5630.915536266959;5644.774209031644;5076.390833100033;5161.793528258865;5170.482951704818;5192.402873669538;5193.480651934814;4973.726445045521;5121.564667003309;5233.712145831978;5234;5251.238570407308;5126.512981266774;5172.172452407615;5196.662216955886;5220.973895130538;5239.79040838366;5120.8975820483565;5148.330717006803;5161.4322424533275;5185.948140518622;5201.141811601119;4928.704277743347;5003.324551185616;5110.156824124015;5148.330717006803;5158.1746920492915;5448.264484294609;5449.482299181572;5461.344638643388;5492.286002819648;5493.642913210669;6030.758769649209;6039.305479869828;6063.848403789896;6086.026235802295;6093.786717464867;5888.411158884121;6010.819675409744;6052.455279024909;6066.302375226861;6092.939070609282;5577.69322687252;5595.132754423071;5620.859478513029;5645.040343141676;5647.463490968352;5944.7324870380935;6021.488173505213;6025.758969641165;6040.365761595057;6054.969725151346;5814.709264536841;5907.822765317047;5914.9112763308585;5926.081457374114;5946.4648181663;6059.575829691879;6066.969665151734;6068.514518838482;6088.391160883876;6093.6039157454625;5868.853278667982;5934.050551911673;6012.849678758066;6017.428344307284;6028.0355143176885;5949.8215053548465;5974.671393073336;5992.161097446361;6014.127951447016;6044.123602077674;4495.707778994355;4502.662300327489;4506.143832671782;4513;4513.909721805546;3984.561698213194;3992.1017771001293;4006.25884211416;4065.8576949806616;4103.302438585448;5527.944720552743;5677.290338707661;5722.656640601494;5753.769849205984;5792.9420705793245;6062.242219722535;6068.120122582201;6072.271327440735;6076.817695469143;6091.116788065706;5588.882223555305;5602.663840169522;5729.369769325454;5750.6837123958585;5757.740901659436;4967.801287948514;4975.402951645753;4975.527324904128;5004.099262132851;5036.345275114211;6193.256809182927;6211.378862113843;6213.689315534205;6239.719212635442;6245.656488893063;5907.438793314628;5983.850403739767;6047.274327080779;6074.362191969868;6086.452219300107;6146.723397447036;6169.6915154241215;6173.938260617337;6174.320824709368;6184.010558310649;5950.910736339045;5960.105984102419;5963.045912654128;5975.133605627247;6005.7297421617;5776.133579962871;6026.728797204224;6073.180120683651;6108.328083910855;6121.112438696453;5904.5866789326055;5908.527317814479;5913.881722365442;5916.585838991229;5962.403759624003;5921.61509501881;5935.673537955281;5940.821775346746;5944.019236825875;5957.3446920837805;5600.299962504687;5790.826275211751;5858.238429004202;5864.266966629171;5891.23413956183;5883.382244864228;5899.144624029577;5921.407859214217;5925.022371308858;5963.373845746134;5704.629199102045;5812.21535092757;5814.3604203538425;5823.854403639773;5843.386444423274 00:26:09 INFO - PROCESS | 16899 | |1;ext.html;512.2623422271928;555.7638003848364;559.8516393155813;581.20375086132;607.4745345276334;41420.58579414205;41593.37609935853;41595.58404415955;41787.79106104469;41808.79095604522;44871.77564112183;45425;45494.31758523625;45515.77242113793;45549.772251138784;8920.598573064228;9075.36472446929;9084;9132.863007054899;9142.222911052535;8900.955495222515;8979.95510022449;9023.548822558878;9040.547972601376;9057.637694492212;9196.448213107202;9226.077392260753;9256;9263.25893928484;9270.67552635658;9136.72589822303;9215.400998935047;9237.769055773591;9238.815223695523;9243.07569243077;8976.685815996409;9105.908940910573;9144.542772861398;9149.268058555299;9188.127127922837;44528.77735611301;44868.55131448709;45048.77475612601;45196.3220551692;45245;3452.4648679454726;3825.7895815730126;3838.596947320519;3842.615738426163;3854.7494412863075;31194;32676;32787.6721232787;32898.6710132898;33568.16079598005;4300.720453170534;4331;4355.5208927018;4364;4404.163208990281;250855.99999999817;252898;252913;253127;253237;46350;65589.67205164039;65842.34157658363;65998;66106.66946665235;46951.060978780915;47140.7642961783;47243.29135062977;47328;47553.5244647556;17195.312187512358;17388.91305543464;17504.474865754048;17523.824761752476;17632.20655070525;13813.51652692151;13971.441142354191;14002.649933751738;14004.159750415009;14022.298885055707;15484.612884677748;15487.457938972082;15506.457273995356;15511.301991410413;15524.456644017631;5913.142594323799;5991.7603295867675;6001.939980600138;6067.514598832083;6133.693315334215;1023.053675350298;1026.2867307221409;1065.0574241796066;1162.0587324267372;1168.4333098447246;30955.535666965014;31046.379072418877;31064.534031989537;31173.376532469225;31331.060068197992;1075.370908018802;1139.5555733264034;1144.948477318506;1162.4536467860091;1189.2507720136432;14216.00487965853;14277.214753188466;14453.421863125568;14595.197264150362;15207.391704331923;324905;500228;516514;522123;522237;58536;59819;59989.40010599838;59999.40000599938;60218.69890650519;1425.5723283015054;1462.2549825815297;1475.852414758537;1486.3460077565837;1520.6274462756917;32135;32305;32982;33385.499217512246;33784.66215337913;54182.729086355896;55251.723741382644;55458.72270638621;55485.72257138688;55589.722051389486;304956;307905;309191;309243;309616;47797.04405911793;48160.75919620379;48541.75729121332;48832.75583622059;49013.754931225114;52106;52687.47312526979;52928;53175;53416;43582;44282;44956.325655114546;45084.54915450935;45309.320360195285;42898.35652465278;43764.56235437605;44375;44570.554294457936;45184.09631807411;41862.37206441845;42328;42954.140917180855;43022.13955720805;43452.348214777434;38278.61721382862;38460.42309365418;38671.22657546777;38706;39461.2107757849;28795.28011799722;29191.416171676872;29464.08505920491;29605.555916660836;29656 00:26:09 INFO - PROCESS | 16899 | |2;jquery.html;374.32434455807265;385.57394079542115;386.8452618952419;387.82547853465945;393.16060211448564;17875;18990.43028709141;19099.331523396682;19834.206631734713;19862;17639.911800441012;18093.4571962841;18164.545886352847;18193.818061819376;18213.7267940981;4070.084231048005;5225.163973764198;5448.891022179554;5453.127499600065;5456.727163641822;5684.658920464785;5902.085176797603;5938.7624495020145;5945.4946329562035;5952.55355848311;5766.913496297559;5835.912461313083;5846;5887.411258874121;5893.852653683649;5828.591998560081;5875.823725288227;5884.823455296348;5904.291485021782;5916.201312822757;5681.971590142064;5761.020626493506;5765.711714414305;5766.971165144148;5778.335491418498;14202.431902723878;14475.348609312607;14523.20122393268;14564.49024284145;17275.74086388705;2266.3314322274805;2394.946223661601;2499.0878329409816;2842.4173044525824;3076.81539107652;9974.102330790263;10466.895331046744;10594.311369761019;10613.681589552325;10654.147668186526;1903.6002439487725;1924.1822225554224;1962.479942815141;1996.0718266006377;2003.1586733571935;65613;68524.3147568523;69299.99999999949;69904.6504767478;70463.94304085494;10618.840717389245;10804.945975270073;10823.458827058615;10962.342259464458;10980.847011063883;15260.008099473498;15536.766948495782;15613.063216207063;15641;15650.373985040698;7847.921520784833;8146.633401496947;8162.020557533134;8173.100958894517;8218.506889586644;7910.169432209535;7914.643841027168;7941.166177551389;7950.363970882316;7957.403194760416;4658.114958157939;4812.037592481448;4829.468758436569;4843.636727245471;4892.3884514435695;1841.1404481473808;1847.7782666080157;1978.9802101978796;1989.7512810898638;2005.5186755178652;971.4317124482116;996.1980605612551;997.1623835977814;1003.6236411345745;1112.9833052504218;17000.91499542519;17467.301307947793;17731.379401721137;17768.822311776974;18343.908280458512;1044.9216308776872;1074.8334008228737;1083.6478144603036;1108.8115020446544;1144.1361771862191;9771.21830253578;10254.025867542572;10272.897271027343;10284.845727314096;10401.27191096631;371027;371444;377703;479068;482172;71561.91103000585;72091.63954180195;74711;75528.62235688786;75895.24104758992;1075.714935542082;1084.4144162152506;1121.3103941076179;1125.431657013203;1125.9774804503863;15475.690486189987;15638;16305.918470407572;16336.836631634007;16855.494335169966;36082.27835443329;37872.24255514929;38677.419838703005;38874.222515548965;39968;47997.28004080011;48563.5143648559;49565.25652115149;49584.75207623939;49611;8613.69852055175;8799.736007919773;8914.153155450222;8932.86600700977;9032.683856065007;12120.21218620822;12562;13412.463501459832;13666.043376963516;14020.78968815489;10775.299605525615;11003.394813285346;11346.149038821955;11374.829377559508;11822.467988940347;11418.885811142114;11844.28934263947;11905.285682859056;11930.224535405518;11968.880311196777;11489.482973266391;11545.942270288595;11631.127665424958;11631.6510504685;12204.75590488203;8795.516246606498;8814;8819.426737262058;9000.414973026733;9068.637254509746;11944.522219111486;12067.456964436446;12078.335691536699;12167.878321216675;12306.692332691755 00:26:09 INFO - PROCESS | 16899 | |3;mootools.html;1598.097075152538;1602.1748799368327;1616.8302328255534;1899.9240030398785;1986.6225417170735;7708.383329333654;8457.78855528612;8566.400351975364;8817.294616430687;8826.91173088269;8580.442271252365;8607.053224145338;8642.783930401743;8723.520206388646;8743.650253989848;2422.164353298114;2445.8654773987423;2449.2407353720314;2451.8528888266674;2453.766892145243;2399.6760437341;2400.59189937711;2445.58425067738;2463.6058230683093;2465.2111324376206;2427.017058091476;2469.148143890364;2471.1721573272885;2494.638277449769;2500.0749722602663;2431.781139697427;2450.9754902451014;2451.521953219123;2458.815588830836;2462.064415522108;2415.45652228249;2416.3838221253645;2418.310781427285;2425.563398588253;2446.388402899275;8823.47059176445;8825.02924678285;8826.646934122627;8862.556872156367;8862.601182946783;5178.223266510054;5268.315119034501;5291.391489978625;5304.575633949275;5306.70813105279;3387.136280248521;3396.609389920166;3422.6748458896363;3448.103493091789;3478.58257009158;1087.9728006799814;1139.663799179244;1141.377949017779;1156.2657712352632;1169.2341516306833;12302.938485307606;12324.5070197192;12340.753184936251;12382.5666101686;12383;4597.655175861823;4625.259958406638;4673.275642275453;4680.836170734008;4689.906201875943;10422.322549034288;10432.217583681255;10434.843477347846;10445.791084178425;10453.9477302613;5274.657147285414;5299.629025968223;5312.73436328182;5329.094054010828;5332.253484512172;4742;4874.8050077997195;4881.633877459205;4905.975470122627;4934.728589927517;3747.6439738224826;3797.886063418102;3808.257389808961;3827.0432391902023;3890.708196885245;1136.4658610453073;1137.6575640744002;1156.2368836567825;1164.67971307891;1171.496256609649;1450.2386247220084;1454.2437932275159;1465.479754687092;1467.7504824179914;1502.211339047009;8423.705170319132;8429.072801991775;8462.942132233471;8466.365022623328;8484.787880303042;512.5054322578654;517.6919732759002;531.3570579598652;541.9539339156137;543.3452689509132;6337.873242535124;6357.237131544244;6357.777477788348;6403.135576697179;6415.743370265137;10576.62981795649;10755.085817705427;10819.729506762395;10838.729031774112;10888.40113793749;10507.369557826554;10694.89305106939;10714.571417143383;10801.891981080245;10802.297850639683;8347.874781878276;8393.790155246046;8404.957975210207;8494.362922780816;8513.2338089571;7890.171531989058;8016.1182269949095;8018.919810801817;8054.395920305883;8092.109867914643;9262.212711919563;9385.38994965325;9412.482313472825;9439.480828554495;9534.809303814023;9486.478243696387;9719.805603887742;9740.415575065519;9816.116549510578;9905.554250058909;6860.931390686029;7327.194008659149;7523.811904702427;7636.427267955037;7709.22907709247;8273.420860539705;8273.420860539705;8286.378521611025;8314.750557483285;8327.20891515305;7482.102147742088;7511.286427789351;7629.2370762923265;7727.11138219112;7833.295003449489;7421.666025028779;7452.180260171268;7455.254474552501;7537.54774713519;7629.732959346618;7844.411669124953;7867.685292588461;7909.802254943673;7926.445148839526;7942.722004729807;7012.474064445289;7058.682359293742;7076.0801095857205;7230.096237970254;7231.2768723127265;7366.6684999174095;7411.703531858665;7434.73978410753;7449.217832127765;7475.215102414386 00:26:09 INFO - PROCESS | 16899 | |4;prototype.html;339.8895359008323;353.58630402429156;363.1484169622237;370.64047873562646;380.1693300139196;6416.71124799384;6481.64350960697;6515.348465153488;6517.64152971587;6541.8364540886505;6405.519586031055;6427.967860160693;6433.2280126384785;6436.613803171813;6437.839054023651;4764.213904705719;4873.8781530461665;4896.265560165986;4941.234108713155;4956.826511072113;4930.383702037246;4946.530079642446;4947.03532811102;4964.106460837048;4969.229769385733;4900.705957642553;4901.65688401812;4917.237828136645;4919;4934.6299027572895;4918.458969513351;4929.334539837112;4931.852044438672;4932.309476673268;4933.531314525132;4286.549912259199;4316.784160791979;4335.56644335567;4338.1540599583095;4339.218940590692;5885.352611212763;6127.5404344674325;6141.201643786324;6141.355157708421;6143.938560614426;5720.942790572082;5753.683547404891;5757.107648314518;5757.568182386338;5759.1937128802;6778.186617605918;6831.795046148623;6839.521233513656;6855.143107111611;6863.691133898987;4730.763461826895;4738.739369334685;4747.572718455355;4755.857324280277;4764.2615394613895;6982;7066.0814094167945;7070.8939365909555;7072.328128827805;7080.973258877434;4744.905101897943;4761.904761904742;4802.471728109905;4814.614830813526;4849.587785038311;4834.323194752737;4845.345878306383;4856.902861942742;4877.926831097537;4879.243717223836;5625.8593535161945;5636.070048442043;5656.8868622627315;5659.320881494247;5677.205191273225;6785.355391237825;6849.48628852838;6850.212225594021;6853.485988550879;6857.588544687334;1739;1766.6555021770632;1767.6553072150807;1769.4868488138295;1770.1149425287356;1110.1063643766684;1144.147610030516;1145.112537783208;1145.1983611472003;1159.1596092832629;6534.411902928664;6539.967300163564;6560.311167327457;6564.081028655992;6564.934350656432;6977.441804655616;6981.905428371469;6995.915633076779;7013.403860671798;7028.418605813651;6453.677316134174;6600.768973085919;6653.301403352675;6667.56660817055;6685.866282674319;3819.751716138442;3835.827387767557;3836.3478208704587;3851.67260782831;3862.1310205203604;7340.9722638829535;7342.853142937218;7348.191698913115;7353.669084891193;7360.411167106618;7345.265473452719;7374.483786134919;7376.336129748348;7384.335409813142;7390.704371825174;7056.576605403692;7335.48651594394;7336.853262934711;7349.118105827335;7371.373433258126;7083.114610673666;7096.219415864148;7099.893501597377;7101.715931362688;7104.644767761694;6926.826829329106;7015.824604384931;7025.683844227125;7043.436525078084;7046.894296585453;7195.172555156224;7260;7336.119665640157;7343.41252699772;7349.228331025379;4838.250071238964;4890.608751299958;4895.143349913822;4899.240617704261;4907.60739140875;7082.893756593552;7093.361597456254;7107.786766397016;7122.786316410516;7137.036500072424;6814.114165158498;6895.931040689529;6901.378875901193;6905.239164013145;6910.274421185703;6791;6848.623325717133;6881.552699074544;6920.757773477904;6924.4114250287275;6773.05177275172;6780.220274668476;6785.59286442815;6793.898091528532;6796.694148763417;6901.516893817385;6925.89611155823;6927.618980956096;6927.757528486479;6930;6719.361660642231;6721.697523611351;6728.05807187004;6749.055132281583;6767.627780472121 00:26:09 INFO - PROCESS | 16899 | |5;yui.html;782.3897360059156;785.073613136499;797.1828875402715;909.4815954905704;916.285297467975;12513.812292815615;12585.433655485514;12623.305718185497;12634.989200863933;12641.431135598898;12065.819012714815;12111.878881211185;12125.818112728293;12138.757224855497;12144.3320617366;776.2974508070178;927.3230541704526;932.0912110692071;953.8330792111387;954.6754103604773;932.8787257656529;936.7049379445486;939.0562484702864;939.3847030195199;940.031767279703;998.8901220865699;999.9200063994863;1005.7334806276342;1007.8891321954616;1008.2085562833178;990.7077412163393;992.0971915556845;993.2947607198897;994.1500017485018;994.3039872089566;729.9817504562375;734.7612026091541;736.6942718771703;737.9520331178456;738.3428748413916;11814.527418903233;11874.643760687193;11901.107416943763;11991.64025079249;12027.639170824888;13191.340432978408;13264.071514993857;13304.268265245408;13438.059335846494;13580.320983950862;9797.412155270707;9951.502424878727;9978.70063898077;10044.698659040241;10173.08442240202;3692.7415080944343;3696.445533170019;3740.4763333133383;3749.062734316421;3759.079025638736;52150.47849521494;52963;54671;55275.723621381636;55338.16992745112;10330.121939635064;10710.143188544898;10744.14046876248;10819.78360432787;10824.242303038869;18178.36375726843;18307.54231144232;18339.816601833812;18402.723959140625;18472.81527184711;6260.217472815898;6639.834004149935;6661.966690166518;6723.899141512881;6874.312568743086;3830.885073447801;3853.672437842759;3875.476810630585;3891.747036442622;3948.0919388540224;3266.0365192268337;3284.3923874082893;3286.342731453719;3290.5064240364136;3291.6708329167373;576.8384852241379;578.2713780636428;582.2140110850319;586.7887560478224;590.8611476303065;558.1153871114249;560.8653923058437;618.8855061813579;621.0435928669798;624.9375062493714;7579.886301705479;7694.923050769421;7695.6536955836;7770;7896.842063158705;553.8172403106965;591.8609126855185;623.3797371615271;630.6878095342835;640.5708175522411;3532.1699400640828;3632.3472819866897;3718.888433347004;3816.503854498953;3852.3836186210074;60222.698886505284;60726.08910866341;61338.38661613416;61524.69237653783;61704.69147654233;51973.48026519762;53943.73028134834;54269.72865135649;54335.72832135814;54976.17535736967;49305;49393.012139757004;49660;50650.46747662602;50883.236751448756;7422.369098626677;7485.326320631169;7491;7567.545947242963;7594.430417718582;37058.444123337635;37974.810125949196;38068.04829879275;38071.809640951615;38263.80868095642;43254.56745432506;45001.54998449974;48554.514454855;48750.512494874594;49271;10609.522571484456;10713.839292410776;10752.516136773707;10826;10944.45277736094;12156.696082598006;12315.07636927252;12780.936095319836;12978.091533592935;13239.933800330937;10472.738181545523;10737.355758654505;10822;11131.55473781072;11536.59621913229;11506.424678765861;11547.422628868355;11601.651950441501;11643.767124657628;11701.941490292495;10216.233782466195;10836.241463097507;11013.229073964745;11288.153388496059;11444.484998175269;9691.418514889128;9741.9025809741;9746.610135594497;9750.171235445066;9844.458554779556;9129.315301352291;9677.612895484383;9798.559064841957;9813.264005199495;9845.803083938425 00:26:09 INFO - PROCESS | 16899 | __end_tp_report 00:26:09 INFO - PROCESS | 16899 | __start_cc_report 00:26:09 INFO - PROCESS | 16899 | _x_x_mozilla_cycle_collect,323 00:26:09 INFO - PROCESS | 16899 | __end_cc_report 00:26:09 INFO - PROCESS | 16899 | __startTimestamp1460877969438__endTimestamp 00:26:09 INFO - PROCESS | 16899 | 00:26:09 INFO - PROCESS | 16899 | ------- Summary: start ------- 00:26:09 INFO - PROCESS | 16899 | Number of tests: 6 00:26:09 INFO - PROCESS | 16899 | 00:26:09 INFO - PROCESS | 16899 | [#0] dojo.html Cycles:165 Average:5583.71 Median:5823.85 stddev:631.02 (10.8%) stddev-sans-first:607.07 00:26:09 INFO - PROCESS | 16899 | Values: 3303.3 3379.3 3396.9 3436.6 3438.0 5587.0 5603.8 5616.5 5639.7 5653.0 5570.5 5589.9 5593.4 5630.9 5644.8 5076.4 5161.8 5170.5 5192.4 5193.5 4973.7 5121.6 5233.7 5234.0 5251.2 5126.5 5172.2 5196.7 5221.0 5239.8 5120.9 5148.3 5161.4 5185.9 5201.1 4928.7 5003.3 5110.2 5148.3 5158.2 5448.3 5449.5 5461.3 5492.3 5493.6 6030.8 6039.3 6063.8 6086.0 6093.8 5888.4 6010.8 6052.5 6066.3 6092.9 5577.7 5595.1 5620.9 5645.0 5647.5 5944.7 6021.5 6025.8 6040.4 6055.0 5814.7 5907.8 5914.9 5926.1 5946.5 6059.6 6067.0 6068.5 6088.4 6093.6 5868.9 5934.1 6012.8 6017.4 6028.0 5949.8 5974.7 5992.2 6014.1 6044.1 4495.7 4502.7 4506.1 4513.0 4513.9 3984.6 3992.1 4006.3 4065.9 4103.3 5527.9 5677.3 5722.7 5753.8 5792.9 6062.2 6068.1 6072.3 6076.8 6091.1 5588.9 5602.7 5729.4 5750.7 5757.7 4967.8 4975.4 4975.5 5004.1 5036.3 6193.3 6211.4 6213.7 6239.7 6245.7 5907.4 5983.9 6047.3 6074.4 6086.5 6146.7 6169.7 6173.9 6174.3 6184.0 5950.9 5960.1 5963.0 5975.1 6005.7 5776.1 6026.7 6073.2 6108.3 6121.1 5904.6 5908.5 5913.9 5916.6 5962.4 5921.6 5935.7 5940.8 5944.0 5957.3 5600.3 5790.8 5858.2 5864.3 5891.2 5883.4 5899.1 5921.4 5925.0 5963.4 5704.6 5812.2 5814.4 5823.9 5843.4 00:26:09 INFO - PROCESS | 16899 | 00:26:09 INFO - PROCESS | 16899 | [#1] ext.html Cycles:180 Average:53255.25 Median:23973.00 stddev:95524.13 (398.5%) stddev-sans-first:95710.02 00:26:09 INFO - PROCESS | 16899 | Values: 512.3 555.8 559.9 581.2 607.5 41420.6 41593.4 41595.6 41787.8 41808.8 44871.8 45425.0 45494.3 45515.8 45549.8 8920.6 9075.4 9084.0 9132.9 9142.2 8901.0 8980.0 9023.5 9040.5 9057.6 9196.4 9226.1 9256.0 9263.3 9270.7 9136.7 9215.4 9237.8 9238.8 9243.1 8976.7 9105.9 9144.5 9149.3 9188.1 44528.8 44868.6 45048.8 45196.3 45245.0 3452.5 3825.8 3838.6 3842.6 3854.7 31194.0 32676.0 32787.7 32898.7 33568.2 4300.7 4331.0 4355.5 4364.0 4404.2 250856.0 252898.0 252913.0 253127.0 253237.0 46350.0 65589.7 65842.3 65998.0 66106.7 46951.1 47140.8 47243.3 47328.0 47553.5 17195.3 17388.9 17504.5 17523.8 17632.2 13813.5 13971.4 14002.6 14004.2 14022.3 15484.6 15487.5 15506.5 15511.3 15524.5 5913.1 5991.8 6001.9 6067.5 6133.7 1023.1 1026.3 1065.1 1162.1 1168.4 30955.5 31046.4 31064.5 31173.4 31331.1 1075.4 1139.6 1144.9 1162.5 1189.3 14216.0 14277.2 14453.4 14595.2 15207.4 324905.0 500228.0 516514.0 522123.0 522237.0 58536.0 59819.0 59989.4 59999.4 60218.7 1425.6 1462.3 1475.9 1486.3 1520.6 32135.0 32305.0 32982.0 33385.5 33784.7 54182.7 55251.7 55458.7 55485.7 55589.7 304956.0 307905.0 309191.0 309243.0 309616.0 47797.0 48160.8 48541.8 48832.8 49013.8 52106.0 52687.5 52928.0 53175.0 53416.0 43582.0 44282.0 44956.3 45084.5 45309.3 42898.4 43764.6 44375.0 44570.6 45184.1 41862.4 42328.0 42954.1 43022.1 43452.3 38278.6 38460.4 38671.2 38706.0 39461.2 28795.3 29191.4 29464.1 29605.6 29656.0 00:26:09 INFO - PROCESS | 16899 | 00:26:09 INFO - PROCESS | 16899 | [#2] jquery.html Cycles:180 Average:25462.25 Median:2330.64 stddev:68925.61 (2957.4%) stddev-sans-first:69093.22 00:26:09 INFO - PROCESS | 16899 | Values: 374.3 385.6 386.8 387.8 393.2 17875.0 18990.4 19099.3 19834.2 19862.0 17639.9 18093.5 18164.5 18193.8 18213.7 4070.1 5225.2 5448.9 5453.1 5456.7 5684.7 5902.1 5938.8 5945.5 5952.6 5766.9 5835.9 5846.0 5887.4 5893.9 5828.6 5875.8 5884.8 5904.3 5916.2 5682.0 5761.0 5765.7 5767.0 5778.3 14202.4 14475.3 14523.2 14564.5 17275.7 2266.3 2394.9 2499.1 2842.4 3076.8 9974.1 10466.9 10594.3 10613.7 10654.1 1903.6 1924.2 1962.5 1996.1 2003.2 65613.0 68524.3 69300.0 69904.7 70463.9 10618.8 10804.9 10823.5 10962.3 10980.8 15260.0 15536.8 15613.1 15641.0 15650.4 7847.9 8146.6 8162.0 8173.1 8218.5 7910.2 7914.6 7941.2 7950.4 7957.4 4658.1 4812.0 4829.5 4843.6 4892.4 1841.1 1847.8 1979.0 1989.8 2005.5 971.4 996.2 997.2 1003.6 1113.0 17000.9 17467.3 17731.4 17768.8 18343.9 1044.9 1074.8 1083.6 1108.8 1144.1 9771.2 10254.0 10272.9 10284.8 10401.3 371027.0 371444.0 377703.0 479068.0 482172.0 71561.9 72091.6 74711.0 75528.6 75895.2 1075.7 1084.4 1121.3 1125.4 1126.0 15475.7 15638.0 16305.9 16336.8 16855.5 36082.3 37872.2 38677.4 38874.2 39968.0 47997.3 48563.5 49565.3 49584.8 49611.0 8613.7 8799.7 8914.2 8932.9 9032.7 12120.2 12562.0 13412.5 13666.0 14020.8 10775.3 11003.4 11346.1 11374.8 11822.5 11418.9 11844.3 11905.3 11930.2 11968.9 11489.5 11545.9 11631.1 11631.7 12204.8 8795.5 8814.0 8819.4 9000.4 9068.6 11944.5 12067.5 12078.3 12167.9 12306.7 00:26:09 INFO - PROCESS | 16899 | 00:26:09 INFO - PROCESS | 16899 | [#3] mootools.html Cycles:180 Average:6098.39 Median:5295.51 stddev:3263.99 (61.6%) stddev-sans-first:3255.62 00:26:09 INFO - PROCESS | 16899 | Values: 1598.1 1602.2 1616.8 1899.9 1986.6 7708.4 8457.8 8566.4 8817.3 8826.9 8580.4 8607.1 8642.8 8723.5 8743.7 2422.2 2445.9 2449.2 2451.9 2453.8 2399.7 2400.6 2445.6 2463.6 2465.2 2427.0 2469.1 2471.2 2494.6 2500.1 2431.8 2451.0 2451.5 2458.8 2462.1 2415.5 2416.4 2418.3 2425.6 2446.4 8823.5 8825.0 8826.6 8862.6 8862.6 5178.2 5268.3 5291.4 5304.6 5306.7 3387.1 3396.6 3422.7 3448.1 3478.6 1088.0 1139.7 1141.4 1156.3 1169.2 12302.9 12324.5 12340.8 12382.6 12383.0 4597.7 4625.3 4673.3 4680.8 4689.9 10422.3 10432.2 10434.8 10445.8 10453.9 5274.7 5299.6 5312.7 5329.1 5332.3 4742.0 4874.8 4881.6 4906.0 4934.7 3747.6 3797.9 3808.3 3827.0 3890.7 1136.5 1137.7 1156.2 1164.7 1171.5 1450.2 1454.2 1465.5 1467.8 1502.2 8423.7 8429.1 8462.9 8466.4 8484.8 512.5 517.7 531.4 542.0 543.3 6337.9 6357.2 6357.8 6403.1 6415.7 10576.6 10755.1 10819.7 10838.7 10888.4 10507.4 10694.9 10714.6 10801.9 10802.3 8347.9 8393.8 8405.0 8494.4 8513.2 7890.2 8016.1 8018.9 8054.4 8092.1 9262.2 9385.4 9412.5 9439.5 9534.8 9486.5 9719.8 9740.4 9816.1 9905.6 6860.9 7327.2 7523.8 7636.4 7709.2 8273.4 8273.4 8286.4 8314.8 8327.2 7482.1 7511.3 7629.2 7727.1 7833.3 7421.7 7452.2 7455.3 7537.5 7629.7 7844.4 7867.7 7909.8 7926.4 7942.7 7012.5 7058.7 7076.1 7230.1 7231.3 7366.7 7411.7 7434.7 7449.2 7475.2 00:26:09 INFO - PROCESS | 16899 | 00:26:09 INFO - PROCESS | 16899 | [#4] prototype.html Cycles:180 Average:5734.26 Median:6537.19 stddev:1732.50 (26.5%) stddev-sans-first:1689.39 00:26:09 INFO - PROCESS | 16899 | Values: 339.9 353.6 363.1 370.6 380.2 6416.7 6481.6 6515.3 6517.6 6541.8 6405.5 6428.0 6433.2 6436.6 6437.8 4764.2 4873.9 4896.3 4941.2 4956.8 4930.4 4946.5 4947.0 4964.1 4969.2 4900.7 4901.7 4917.2 4919.0 4934.6 4918.5 4929.3 4931.9 4932.3 4933.5 4286.5 4316.8 4335.6 4338.2 4339.2 5885.4 6127.5 6141.2 6141.4 6143.9 5720.9 5753.7 5757.1 5757.6 5759.2 6778.2 6831.8 6839.5 6855.1 6863.7 4730.8 4738.7 4747.6 4755.9 4764.3 6982.0 7066.1 7070.9 7072.3 7081.0 4744.9 4761.9 4802.5 4814.6 4849.6 4834.3 4845.3 4856.9 4877.9 4879.2 5625.9 5636.1 5656.9 5659.3 5677.2 6785.4 6849.5 6850.2 6853.5 6857.6 1739.0 1766.7 1767.7 1769.5 1770.1 1110.1 1144.1 1145.1 1145.2 1159.2 6534.4 6540.0 6560.3 6564.1 6564.9 6977.4 6981.9 6995.9 7013.4 7028.4 6453.7 6600.8 6653.3 6667.6 6685.9 3819.8 3835.8 3836.3 3851.7 3862.1 7341.0 7342.9 7348.2 7353.7 7360.4 7345.3 7374.5 7376.3 7384.3 7390.7 7056.6 7335.5 7336.9 7349.1 7371.4 7083.1 7096.2 7099.9 7101.7 7104.6 6926.8 7015.8 7025.7 7043.4 7046.9 7195.2 7260.0 7336.1 7343.4 7349.2 4838.3 4890.6 4895.1 4899.2 4907.6 7082.9 7093.4 7107.8 7122.8 7137.0 6814.1 6895.9 6901.4 6905.2 6910.3 6791.0 6848.6 6881.6 6920.8 6924.4 6773.1 6780.2 6785.6 6793.9 6796.7 6901.5 6925.9 6927.6 6927.8 6930.0 6719.4 6721.7 6728.1 6749.1 6767.6 00:26:09 INFO - PROCESS | 16899 | 00:26:09 INFO - PROCESS | 16899 | [#5] yui.html Cycles:180 Average:14249.28 Median:49349.01 stddev:17238.88 (34.9%) stddev-sans-first:17257.57 00:26:09 INFO - PROCESS | 16899 | Values: 782.4 785.1 797.2 909.5 916.3 12513.8 12585.4 12623.3 12635.0 12641.4 12065.8 12111.9 12125.8 12138.8 12144.3 776.3 927.3 932.1 953.8 954.7 932.9 936.7 939.1 939.4 940.0 998.9 999.9 1005.7 1007.9 1008.2 990.7 992.1 993.3 994.2 994.3 730.0 734.8 736.7 738.0 738.3 11814.5 11874.6 11901.1 11991.6 12027.6 13191.3 13264.1 13304.3 13438.1 13580.3 9797.4 9951.5 9978.7 10044.7 10173.1 3692.7 3696.4 3740.5 3749.1 3759.1 52150.5 52963.0 54671.0 55275.7 55338.2 10330.1 10710.1 10744.1 10819.8 10824.2 18178.4 18307.5 18339.8 18402.7 18472.8 6260.2 6639.8 6662.0 6723.9 6874.3 3830.9 3853.7 3875.5 3891.7 3948.1 3266.0 3284.4 3286.3 3290.5 3291.7 576.8 578.3 582.2 586.8 590.9 558.1 560.9 618.9 621.0 624.9 7579.9 7694.9 7695.7 7770.0 7896.8 553.8 591.9 623.4 630.7 640.6 3532.2 3632.3 3718.9 3816.5 3852.4 60222.7 60726.1 61338.4 61524.7 61704.7 51973.5 53943.7 54269.7 54335.7 54976.2 49305.0 49393.0 49660.0 50650.5 50883.2 7422.4 7485.3 7491.0 7567.5 7594.4 37058.4 37974.8 38068.0 38071.8 38263.8 43254.6 45001.5 48554.5 48750.5 49271.0 10609.5 10713.8 10752.5 10826.0 10944.5 12156.7 12315.1 12780.9 12978.1 13239.9 10472.7 10737.4 10822.0 11131.6 11536.6 11506.4 11547.4 11601.7 11643.8 11701.9 10216.2 10836.2 11013.2 11288.2 11444.5 9691.4 9741.9 9746.6 9750.2 9844.5 9129.3 9677.6 9798.6 9813.3 9845.8 00:26:09 INFO - PROCESS | 16899 | -------- Summary: end -------- 00:26:09 INFO - PROCESS | 16899 | 00:26:10 INFO - TEST-INFO | 16899: exit 0 00:26:10 INFO - TEST-OK | dromaeo_css | took 1109725ms 00:26:10 INFO - TEST-START | kraken 00:26:10 INFO - operating with platform_type : linux_ 00:26:10 INFO - Initialising browser for kraken test... 00:26:10 INFO - TEST-INFO | started process 17145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCLQ8cC/profile http://localhost:48460/getInfo.html) 00:26:13 INFO - PROCESS | 17145 | 00:26:13 INFO - PROCESS | 17145 | (process:17225): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:26:14 INFO - PROCESS | 17145 | __metrics Screen width/height:1600/1200 00:26:14 INFO - PROCESS | 17145 | colorDepth:24 00:26:14 INFO - PROCESS | 17145 | Browser inner width/height: 1024/697 00:26:14 INFO - PROCESS | 17145 | __metrics 00:26:15 ERROR - PROCESS | 17145 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 00:26:16 INFO - TEST-INFO | 17145: exit 0 00:26:16 INFO - Browser initialized. 00:26:16 INFO - Running cycle 1/1 for kraken test... 00:26:16 INFO - TEST-INFO | started process 17276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCLQ8cC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:26:17 INFO - PROCESS | 17276 | 00:26:17 INFO - PROCESS | 17276 | (process:17345): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:26:27 INFO - PROCESS | 17276 | RSS: Main: 151785472 00:26:27 INFO - PROCESS | 17276 | 00:26:30 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48460/tests/kraken/driver.html?testName=audio-beat-detection) 00:26:31 INFO - PROCESS | 17276 | RSS: Main: 156037120 00:26:31 INFO - PROCESS | 17276 | 00:26:33 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48460/tests/kraken/driver.html?testName=audio-dft) 00:26:34 INFO - PROCESS | 17276 | RSS: Main: 155951104 00:26:34 INFO - PROCESS | 17276 | 00:26:37 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48460/tests/kraken/driver.html?testName=audio-fft) 00:26:37 INFO - PROCESS | 17276 | RSS: Main: 156528640 00:26:37 INFO - PROCESS | 17276 | 00:26:39 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48460/tests/kraken/driver.html?testName=audio-oscillator) 00:26:40 INFO - PROCESS | 17276 | RSS: Main: 156508160 00:26:40 INFO - PROCESS | 17276 | 00:26:42 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:26:43 INFO - PROCESS | 17276 | RSS: Main: 156573696 00:26:43 INFO - PROCESS | 17276 | 00:26:46 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48460/tests/kraken/driver.html?testName=imaging-darkroom) 00:26:46 INFO - PROCESS | 17276 | RSS: Main: 156360704 00:26:46 INFO - PROCESS | 17276 | 00:26:50 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48460/tests/kraken/driver.html?testName=imaging-desaturate) 00:26:50 INFO - PROCESS | 17276 | RSS: Main: 156725248 00:26:50 INFO - PROCESS | 17276 | 00:26:53 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48460/tests/kraken/driver.html?testName=json-parse-financial) 00:26:54 INFO - PROCESS | 17276 | RSS: Main: 156971008 00:26:54 INFO - PROCESS | 17276 | 00:26:55 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:26:56 INFO - PROCESS | 17276 | RSS: Main: 157028352 00:26:56 INFO - PROCESS | 17276 | 00:26:58 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48460/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:26:58 INFO - PROCESS | 17276 | RSS: Main: 157081600 00:26:58 INFO - PROCESS | 17276 | 00:27:00 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:27:01 INFO - PROCESS | 17276 | RSS: Main: 157151232 00:27:01 INFO - PROCESS | 17276 | 00:27:03 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:27:04 INFO - PROCESS | 17276 | RSS: Main: 156852224 00:27:04 INFO - PROCESS | 17276 | 00:27:06 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:27:07 INFO - PROCESS | 17276 | RSS: Main: 156880896 00:27:07 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | Cycle 1(1): loaded http://localhost:48460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48460/tests/kraken/driver.html?testName=ai-astar) 00:27:09 INFO - PROCESS | 17276 | RSS: Main: 158941184 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | __start_tp_report 00:27:09 INFO - PROCESS | 17276 | _x_x_mozilla_page_load 00:27:09 INFO - PROCESS | 17276 | _x_x_mozilla_page_load_details 00:27:09 INFO - PROCESS | 17276 | |i|pagename|runs| 00:27:09 INFO - PROCESS | 17276 | |0;ai-astar;110;104;109;108;109;120;109;110;108;110 00:27:09 INFO - PROCESS | 17276 | |1;audio-beat-detection;159;126;153;171;128;158;155;142;185;127 00:27:09 INFO - PROCESS | 17276 | |2;audio-dft;162;162;162;160;162;161;161;164;165;163 00:27:09 INFO - PROCESS | 17276 | |3;audio-fft;75;76;73;162;77;75;75;75;160;75 00:27:09 INFO - PROCESS | 17276 | |4;audio-oscillator;93;93;148;93;94;92;150;96;93;146 00:27:09 INFO - PROCESS | 17276 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;117;118;117 00:27:09 INFO - PROCESS | 17276 | |6;imaging-darkroom;146;146;147;146;147;147;147;146;151;146 00:27:09 INFO - PROCESS | 17276 | |7;imaging-desaturate;96;96;96;96;96;96;95;96;96;96 00:27:09 INFO - PROCESS | 17276 | |8;json-parse-financial;59;55;57;57;56;57;64;63;59;60 00:27:09 INFO - PROCESS | 17276 | |9;json-stringify-tinderbox;67;79;69;67;66;67;66;67;66;69 00:27:09 INFO - PROCESS | 17276 | |10;stanford-crypto-aes;78;79;86;80;79;78;80;77;78;79 00:27:09 INFO - PROCESS | 17276 | |11;stanford-crypto-ccm;115;111;119;118;111;118;111;114;113;122 00:27:09 INFO - PROCESS | 17276 | |12;stanford-crypto-pbkdf2;136;137;135;136;141;136;134;136;139;134 00:27:09 INFO - PROCESS | 17276 | |13;stanford-crypto-sha256-iterative;67;68;66;67;65;67;65;67;65;65 00:27:09 INFO - PROCESS | 17276 | __end_tp_report 00:27:09 INFO - PROCESS | 17276 | __start_cc_report 00:27:09 INFO - PROCESS | 17276 | _x_x_mozilla_cycle_collect,827 00:27:09 INFO - PROCESS | 17276 | __end_cc_report 00:27:09 INFO - PROCESS | 17276 | __startTimestamp1460878029433__endTimestamp 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | ------- Summary: start ------- 00:27:09 INFO - PROCESS | 17276 | Number of tests: 14 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#0] ai-astar Cycles:10 Average:109.70 Median:109.50 stddev:4.03 (3.7%) stddev-sans-first:4.27 00:27:09 INFO - PROCESS | 17276 | Values: 110.0 104.0 109.0 108.0 109.0 120.0 109.0 110.0 108.0 110.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:156.50 stddev:19.71 (12.6%) stddev-sans-first:20.66 00:27:09 INFO - PROCESS | 17276 | Values: 159.0 126.0 153.0 171.0 128.0 158.0 155.0 142.0 185.0 127.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 00:27:09 INFO - PROCESS | 17276 | Values: 162.0 162.0 162.0 160.0 162.0 161.0 161.0 164.0 165.0 163.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:36.22 (48.3%) stddev-sans-first:37.88 00:27:09 INFO - PROCESS | 17276 | Values: 75.0 76.0 73.0 162.0 77.0 75.0 75.0 75.0 160.0 75.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.00 stddev:26.40 (28.4%) stddev-sans-first:27.29 00:27:09 INFO - PROCESS | 17276 | Values: 93.0 93.0 148.0 93.0 94.0 92.0 150.0 96.0 93.0 146.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:27:09 INFO - PROCESS | 17276 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.52 (1.0%) stddev-sans-first:1.58 00:27:09 INFO - PROCESS | 17276 | Values: 146.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 151.0 146.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:27:09 INFO - PROCESS | 17276 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.00 stddev:2.95 (5.0%) stddev-sans-first:3.12 00:27:09 INFO - PROCESS | 17276 | Values: 59.0 55.0 57.0 57.0 56.0 57.0 64.0 63.0 59.0 60.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:67.00 stddev:3.92 (5.8%) stddev-sans-first:4.13 00:27:09 INFO - PROCESS | 17276 | Values: 67.0 79.0 69.0 67.0 66.0 67.0 66.0 67.0 66.0 69.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.50 (3.2%) stddev-sans-first:2.60 00:27:09 INFO - PROCESS | 17276 | Values: 78.0 79.0 86.0 80.0 79.0 78.0 80.0 77.0 78.0 79.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:116.50 stddev:3.88 (3.3%) stddev-sans-first:4.12 00:27:09 INFO - PROCESS | 17276 | Values: 115.0 111.0 119.0 118.0 111.0 118.0 111.0 114.0 113.0 122.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.40 Median:136.00 stddev:2.17 (1.6%) stddev-sans-first:2.30 00:27:09 INFO - PROCESS | 17276 | Values: 136.0 137.0 135.0 136.0 141.0 136.0 134.0 136.0 139.0 134.0 00:27:09 INFO - PROCESS | 17276 | 00:27:09 INFO - PROCESS | 17276 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.17 00:27:09 INFO - PROCESS | 17276 | Values: 67.0 68.0 66.0 67.0 65.0 67.0 65.0 67.0 65.0 65.0 00:27:09 INFO - PROCESS | 17276 | -------- Summary: end -------- 00:27:09 INFO - PROCESS | 17276 | 00:27:10 INFO - TEST-INFO | 17276: exit 0 00:27:10 INFO - TEST-OK | kraken | took 60227ms 00:27:10 INFO - SUITE-END | took 1169s 00:27:10 INFO - Completed test suite (00:19:30) 00:27:10 INFO - javascript benchmark 00:27:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3303.289792694571, 3379.341028499443, 3396.8641254349827, 3436.6047904490993, 3437.982810085951, 5587.022271102556, 5603.831885043455, 5616.494515493605, 5639.7180140993, 5653.038983372826, 5570.470805273492, 5589.916151257735, 5593.356763972144, 5630.915536266959, 5644.774209031644, 5076.390833100033, 5161.793528258865, 5170.482951704818, 5192.402873669538, 5193.480651934814, 4973.726445045521, 5121.564667003309, 5233.712145831978, 5234.0, 5251.238570407308, 5126.512981266774, 5172.172452407615, 5196.662216955886, 5220.973895130538, 5239.79040838366, 5120.8975820483565, 5148.330717006803, 5161.4322424533275, 5185.948140518622, 5201.141811601119, 4928.704277743347, 5003.324551185616, 5110.156824124015, 5148.330717006803, 5158.1746920492915, 5448.264484294609, 5449.482299181572, 5461.344638643388, 5492.286002819648, 5493.642913210669, 6030.758769649209, 6039.305479869828, 6063.848403789896, 6086.026235802295, 6093.786717464867, 5888.411158884121, 6010.819675409744, 6052.455279024909, 6066.302375226861, 6092.939070609282, 5577.69322687252, 5595.132754423071, 5620.859478513029, 5645.040343141676, 5647.463490968352, 5944.7324870380935, 6021.488173505213, 6025.758969641165, 6040.365761595057, 6054.969725151346, 5814.709264536841, 5907.822765317047, 5914.9112763308585, 5926.081457374114, 5946.4648181663, 6059.575829691879, 6066.969665151734, 6068.514518838482, 6088.391160883876, 6093.6039157454625, 5868.853278667982, 5934.050551911673, 6012.849678758066, 6017.428344307284, 6028.0355143176885, 5949.8215053548465, 5974.671393073336, 5992.161097446361, 6014.127951447016, 6044.123602077674, 4495.707778994355, 4502.662300327489, 4506.143832671782, 4513.0, 4513.909721805546, 3984.561698213194, 3992.1017771001293, 4006.25884211416, 4065.8576949806616, 4103.302438585448, 5527.944720552743, 5677.290338707661, 5722.656640601494, 5753.769849205984, 5792.9420705793245, 6062.242219722535, 6068.120122582201, 6072.271327440735, 6076.817695469143, 6091.116788065706, 5588.882223555305, 5602.663840169522, 5729.369769325454, 5750.6837123958585, 5757.740901659436, 4967.801287948514, 4975.402951645753, 4975.527324904128, 5004.099262132851, 5036.345275114211, 6193.256809182927, 6211.378862113843, 6213.689315534205, 6239.719212635442, 6245.656488893063, 5907.438793314628, 5983.850403739767, 6047.274327080779, 6074.362191969868, 6086.452219300107, 6146.723397447036, 6169.6915154241215, 6173.938260617337, 6174.320824709368, 6184.010558310649, 5950.910736339045, 5960.105984102419, 5963.045912654128, 5975.133605627247, 6005.7297421617, 5776.133579962871, 6026.728797204224, 6073.180120683651, 6108.328083910855, 6121.112438696453, 5904.5866789326055, 5908.527317814479, 5913.881722365442, 5916.585838991229, 5962.403759624003, 5921.61509501881, 5935.673537955281, 5940.821775346746, 5944.019236825875, 5957.3446920837805, 5600.299962504687, 5790.826275211751, 5858.238429004202, 5864.266966629171, 5891.23413956183, 5883.382244864228, 5899.144624029577, 5921.407859214217, 5925.022371308858, 5963.373845746134, 5704.629199102045, 5812.21535092757, 5814.3604203538425, 5823.854403639773, 5843.386444423274], "unit": "score", "name": "dojo.html", "value": 5542.019607168813}, {"lowerIsBetter": false, "replicates": [512.2623422271928, 555.7638003848364, 559.8516393155813, 581.20375086132, 607.4745345276334, 41420.58579414205, 41593.37609935853, 41595.58404415955, 41787.79106104469, 41808.79095604522, 44871.77564112183, 45425.0, 45494.31758523625, 45515.77242113793, 45549.772251138784, 8920.598573064228, 9075.36472446929, 9084.0, 9132.863007054899, 9142.222911052535, 8900.955495222515, 8979.95510022449, 9023.548822558878, 9040.547972601376, 9057.637694492212, 9196.448213107202, 9226.077392260753, 9256.0, 9263.25893928484, 9270.67552635658, 9136.72589822303, 9215.400998935047, 9237.769055773591, 9238.815223695523, 9243.07569243077, 8976.685815996409, 9105.908940910573, 9144.542772861398, 9149.268058555299, 9188.127127922837, 44528.77735611301, 44868.55131448709, 45048.77475612601, 45196.3220551692, 45245.0, 3452.4648679454726, 3825.7895815730126, 3838.596947320519, 3842.615738426163, 3854.7494412863075, 31194.0, 32676.0, 32787.6721232787, 32898.6710132898, 33568.16079598005, 4300.720453170534, 4331.0, 4355.5208927018, 4364.0, 4404.163208990281, 250855.99999999817, 252898.0, 252913.0, 253127.0, 253237.0, 46350.0, 65589.67205164039, 65842.34157658363, 65998.0, 66106.66946665235, 46951.060978780915, 47140.7642961783, 47243.29135062977, 47328.0, 47553.5244647556, 17195.312187512358, 17388.91305543464, 17504.474865754048, 17523.824761752476, 17632.20655070525, 13813.51652692151, 13971.441142354191, 14002.649933751738, 14004.159750415009, 14022.298885055707, 15484.612884677748, 15487.457938972082, 15506.457273995356, 15511.301991410413, 15524.456644017631, 5913.142594323799, 5991.7603295867675, 6001.939980600138, 6067.514598832083, 6133.693315334215, 1023.053675350298, 1026.2867307221409, 1065.0574241796066, 1162.0587324267372, 1168.4333098447246, 30955.535666965014, 31046.379072418877, 31064.534031989537, 31173.376532469225, 31331.060068197992, 1075.370908018802, 1139.5555733264034, 1144.948477318506, 1162.4536467860091, 1189.2507720136432, 14216.00487965853, 14277.214753188466, 14453.421863125568, 14595.197264150362, 15207.391704331923, 324905.0, 500228.0, 516514.0, 522123.0, 522237.0, 58536.0, 59819.0, 59989.40010599838, 59999.40000599938, 60218.69890650519, 1425.5723283015054, 1462.2549825815297, 1475.852414758537, 1486.3460077565837, 1520.6274462756917, 32135.0, 32305.0, 32982.0, 33385.499217512246, 33784.66215337913, 54182.729086355896, 55251.723741382644, 55458.72270638621, 55485.72257138688, 55589.722051389486, 304956.0, 307905.0, 309191.0, 309243.0, 309616.0, 47797.04405911793, 48160.75919620379, 48541.75729121332, 48832.75583622059, 49013.754931225114, 52106.0, 52687.47312526979, 52928.0, 53175.0, 53416.0, 43582.0, 44282.0, 44956.325655114546, 45084.54915450935, 45309.320360195285, 42898.35652465278, 43764.56235437605, 44375.0, 44570.554294457936, 45184.09631807411, 41862.37206441845, 42328.0, 42954.140917180855, 43022.13955720805, 43452.348214777434, 38278.61721382862, 38460.42309365418, 38671.22657546777, 38706.0, 39461.2107757849, 28795.28011799722, 29191.416171676872, 29464.08505920491, 29605.555916660836, 29656.0], "unit": "score", "name": "ext.html", "value": 20143.434896697097}, {"lowerIsBetter": false, "replicates": [374.32434455807265, 385.57394079542115, 386.8452618952419, 387.82547853465945, 393.16060211448564, 17875.0, 18990.43028709141, 19099.331523396682, 19834.206631734713, 19862.0, 17639.911800441012, 18093.4571962841, 18164.545886352847, 18193.818061819376, 18213.7267940981, 4070.084231048005, 5225.163973764198, 5448.891022179554, 5453.127499600065, 5456.727163641822, 5684.658920464785, 5902.085176797603, 5938.7624495020145, 5945.4946329562035, 5952.55355848311, 5766.913496297559, 5835.912461313083, 5846.0, 5887.411258874121, 5893.852653683649, 5828.591998560081, 5875.823725288227, 5884.823455296348, 5904.291485021782, 5916.201312822757, 5681.971590142064, 5761.020626493506, 5765.711714414305, 5766.971165144148, 5778.335491418498, 14202.431902723878, 14475.348609312607, 14523.20122393268, 14564.49024284145, 17275.74086388705, 2266.3314322274805, 2394.946223661601, 2499.0878329409816, 2842.4173044525824, 3076.81539107652, 9974.102330790263, 10466.895331046744, 10594.311369761019, 10613.681589552325, 10654.147668186526, 1903.6002439487725, 1924.1822225554224, 1962.479942815141, 1996.0718266006377, 2003.1586733571935, 65613.0, 68524.3147568523, 69299.99999999949, 69904.6504767478, 70463.94304085494, 10618.840717389245, 10804.945975270073, 10823.458827058615, 10962.342259464458, 10980.847011063883, 15260.008099473498, 15536.766948495782, 15613.063216207063, 15641.0, 15650.373985040698, 7847.921520784833, 8146.633401496947, 8162.020557533134, 8173.100958894517, 8218.506889586644, 7910.169432209535, 7914.643841027168, 7941.166177551389, 7950.363970882316, 7957.403194760416, 4658.114958157939, 4812.037592481448, 4829.468758436569, 4843.636727245471, 4892.3884514435695, 1841.1404481473808, 1847.7782666080157, 1978.9802101978796, 1989.7512810898638, 2005.5186755178652, 971.4317124482116, 996.1980605612551, 997.1623835977814, 1003.6236411345745, 1112.9833052504218, 17000.91499542519, 17467.301307947793, 17731.379401721137, 17768.822311776974, 18343.908280458512, 1044.9216308776872, 1074.8334008228737, 1083.6478144603036, 1108.8115020446544, 1144.1361771862191, 9771.21830253578, 10254.025867542572, 10272.897271027343, 10284.845727314096, 10401.27191096631, 371027.0, 371444.0, 377703.0, 479068.0, 482172.0, 71561.91103000585, 72091.63954180195, 74711.0, 75528.62235688786, 75895.24104758992, 1075.714935542082, 1084.4144162152506, 1121.3103941076179, 1125.431657013203, 1125.9774804503863, 15475.690486189987, 15638.0, 16305.918470407572, 16336.836631634007, 16855.494335169966, 36082.27835443329, 37872.24255514929, 38677.419838703005, 38874.222515548965, 39968.0, 47997.28004080011, 48563.5143648559, 49565.25652115149, 49584.75207623939, 49611.0, 8613.69852055175, 8799.736007919773, 8914.153155450222, 8932.86600700977, 9032.683856065007, 12120.21218620822, 12562.0, 13412.463501459832, 13666.043376963516, 14020.78968815489, 10775.299605525615, 11003.394813285346, 11346.149038821955, 11374.829377559508, 11822.467988940347, 11418.885811142114, 11844.28934263947, 11905.285682859056, 11930.224535405518, 11968.880311196777, 11489.482973266391, 11545.942270288595, 11631.127665424958, 11631.6510504685, 12204.75590488203, 8795.516246606498, 8814.0, 8819.426737262058, 9000.414973026733, 9068.637254509746, 11944.522219111486, 12067.456964436446, 12078.335691536699, 12167.878321216675, 12306.692332691755], "unit": "score", "name": "jquery.html", "value": 8943.446282865472}, {"lowerIsBetter": false, "replicates": [1598.097075152538, 1602.1748799368327, 1616.8302328255534, 1899.9240030398785, 1986.6225417170735, 7708.383329333654, 8457.78855528612, 8566.400351975364, 8817.294616430687, 8826.91173088269, 8580.442271252365, 8607.053224145338, 8642.783930401743, 8723.520206388646, 8743.650253989848, 2422.164353298114, 2445.8654773987423, 2449.2407353720314, 2451.8528888266674, 2453.766892145243, 2399.6760437341, 2400.59189937711, 2445.58425067738, 2463.6058230683093, 2465.2111324376206, 2427.017058091476, 2469.148143890364, 2471.1721573272885, 2494.638277449769, 2500.0749722602663, 2431.781139697427, 2450.9754902451014, 2451.521953219123, 2458.815588830836, 2462.064415522108, 2415.45652228249, 2416.3838221253645, 2418.310781427285, 2425.563398588253, 2446.388402899275, 8823.47059176445, 8825.02924678285, 8826.646934122627, 8862.556872156367, 8862.601182946783, 5178.223266510054, 5268.315119034501, 5291.391489978625, 5304.575633949275, 5306.70813105279, 3387.136280248521, 3396.609389920166, 3422.6748458896363, 3448.103493091789, 3478.58257009158, 1087.9728006799814, 1139.663799179244, 1141.377949017779, 1156.2657712352632, 1169.2341516306833, 12302.938485307606, 12324.5070197192, 12340.753184936251, 12382.5666101686, 12383.0, 4597.655175861823, 4625.259958406638, 4673.275642275453, 4680.836170734008, 4689.906201875943, 10422.322549034288, 10432.217583681255, 10434.843477347846, 10445.791084178425, 10453.9477302613, 5274.657147285414, 5299.629025968223, 5312.73436328182, 5329.094054010828, 5332.253484512172, 4742.0, 4874.8050077997195, 4881.633877459205, 4905.975470122627, 4934.728589927517, 3747.6439738224826, 3797.886063418102, 3808.257389808961, 3827.0432391902023, 3890.708196885245, 1136.4658610453073, 1137.6575640744002, 1156.2368836567825, 1164.67971307891, 1171.496256609649, 1450.2386247220084, 1454.2437932275159, 1465.479754687092, 1467.7504824179914, 1502.211339047009, 8423.705170319132, 8429.072801991775, 8462.942132233471, 8466.365022623328, 8484.787880303042, 512.5054322578654, 517.6919732759002, 531.3570579598652, 541.9539339156137, 543.3452689509132, 6337.873242535124, 6357.237131544244, 6357.777477788348, 6403.135576697179, 6415.743370265137, 10576.62981795649, 10755.085817705427, 10819.729506762395, 10838.729031774112, 10888.40113793749, 10507.369557826554, 10694.89305106939, 10714.571417143383, 10801.891981080245, 10802.297850639683, 8347.874781878276, 8393.790155246046, 8404.957975210207, 8494.362922780816, 8513.2338089571, 7890.171531989058, 8016.1182269949095, 8018.919810801817, 8054.395920305883, 8092.109867914643, 9262.212711919563, 9385.38994965325, 9412.482313472825, 9439.480828554495, 9534.809303814023, 9486.478243696387, 9719.805603887742, 9740.415575065519, 9816.116549510578, 9905.554250058909, 6860.931390686029, 7327.194008659149, 7523.811904702427, 7636.427267955037, 7709.22907709247, 8273.420860539705, 8273.420860539705, 8286.378521611025, 8314.750557483285, 8327.20891515305, 7482.102147742088, 7511.286427789351, 7629.2370762923265, 7727.11138219112, 7833.295003449489, 7421.666025028779, 7452.180260171268, 7455.254474552501, 7537.54774713519, 7629.732959346618, 7844.411669124953, 7867.685292588461, 7909.802254943673, 7926.445148839526, 7942.722004729807, 7012.474064445289, 7058.682359293742, 7076.0801095857205, 7230.096237970254, 7231.2768723127265, 7366.6684999174095, 7411.703531858665, 7434.73978410753, 7449.217832127765, 7475.215102414386], "unit": "score", "name": "mootools.html", "value": 4880.864193232128}, {"lowerIsBetter": false, "replicates": [339.8895359008323, 353.58630402429156, 363.1484169622237, 370.64047873562646, 380.1693300139196, 6416.71124799384, 6481.64350960697, 6515.348465153488, 6517.64152971587, 6541.8364540886505, 6405.519586031055, 6427.967860160693, 6433.2280126384785, 6436.613803171813, 6437.839054023651, 4764.213904705719, 4873.8781530461665, 4896.265560165986, 4941.234108713155, 4956.826511072113, 4930.383702037246, 4946.530079642446, 4947.03532811102, 4964.106460837048, 4969.229769385733, 4900.705957642553, 4901.65688401812, 4917.237828136645, 4919.0, 4934.6299027572895, 4918.458969513351, 4929.334539837112, 4931.852044438672, 4932.309476673268, 4933.531314525132, 4286.549912259199, 4316.784160791979, 4335.56644335567, 4338.1540599583095, 4339.218940590692, 5885.352611212763, 6127.5404344674325, 6141.201643786324, 6141.355157708421, 6143.938560614426, 5720.942790572082, 5753.683547404891, 5757.107648314518, 5757.568182386338, 5759.1937128802, 6778.186617605918, 6831.795046148623, 6839.521233513656, 6855.143107111611, 6863.691133898987, 4730.763461826895, 4738.739369334685, 4747.572718455355, 4755.857324280277, 4764.2615394613895, 6982.0, 7066.0814094167945, 7070.8939365909555, 7072.328128827805, 7080.973258877434, 4744.905101897943, 4761.904761904742, 4802.471728109905, 4814.614830813526, 4849.587785038311, 4834.323194752737, 4845.345878306383, 4856.902861942742, 4877.926831097537, 4879.243717223836, 5625.8593535161945, 5636.070048442043, 5656.8868622627315, 5659.320881494247, 5677.205191273225, 6785.355391237825, 6849.48628852838, 6850.212225594021, 6853.485988550879, 6857.588544687334, 1739.0, 1766.6555021770632, 1767.6553072150807, 1769.4868488138295, 1770.1149425287356, 1110.1063643766684, 1144.147610030516, 1145.112537783208, 1145.1983611472003, 1159.1596092832629, 6534.411902928664, 6539.967300163564, 6560.311167327457, 6564.081028655992, 6564.934350656432, 6977.441804655616, 6981.905428371469, 6995.915633076779, 7013.403860671798, 7028.418605813651, 6453.677316134174, 6600.768973085919, 6653.301403352675, 6667.56660817055, 6685.866282674319, 3819.751716138442, 3835.827387767557, 3836.3478208704587, 3851.67260782831, 3862.1310205203604, 7340.9722638829535, 7342.853142937218, 7348.191698913115, 7353.669084891193, 7360.411167106618, 7345.265473452719, 7374.483786134919, 7376.336129748348, 7384.335409813142, 7390.704371825174, 7056.576605403692, 7335.48651594394, 7336.853262934711, 7349.118105827335, 7371.373433258126, 7083.114610673666, 7096.219415864148, 7099.893501597377, 7101.715931362688, 7104.644767761694, 6926.826829329106, 7015.824604384931, 7025.683844227125, 7043.436525078084, 7046.894296585453, 7195.172555156224, 7260.0, 7336.119665640157, 7343.41252699772, 7349.228331025379, 4838.250071238964, 4890.608751299958, 4895.143349913822, 4899.240617704261, 4907.60739140875, 7082.893756593552, 7093.361597456254, 7107.786766397016, 7122.786316410516, 7137.036500072424, 6814.114165158498, 6895.931040689529, 6901.378875901193, 6905.239164013145, 6910.274421185703, 6791.0, 6848.623325717133, 6881.552699074544, 6920.757773477904, 6924.4114250287275, 6773.05177275172, 6780.220274668476, 6785.59286442815, 6793.898091528532, 6796.694148763417, 6901.516893817385, 6925.89611155823, 6927.618980956096, 6927.757528486479, 6930.0, 6719.361660642231, 6721.697523611351, 6728.05807187004, 6749.055132281583, 6767.627780472121], "unit": "score", "name": "prototype.html", "value": 5169.58781255995}, {"lowerIsBetter": false, "replicates": [782.3897360059156, 785.073613136499, 797.1828875402715, 909.4815954905704, 916.285297467975, 12513.812292815615, 12585.433655485514, 12623.305718185497, 12634.989200863933, 12641.431135598898, 12065.819012714815, 12111.878881211185, 12125.818112728293, 12138.757224855497, 12144.3320617366, 776.2974508070178, 927.3230541704526, 932.0912110692071, 953.8330792111387, 954.6754103604773, 932.8787257656529, 936.7049379445486, 939.0562484702864, 939.3847030195199, 940.031767279703, 998.8901220865699, 999.9200063994863, 1005.7334806276342, 1007.8891321954616, 1008.2085562833178, 990.7077412163393, 992.0971915556845, 993.2947607198897, 994.1500017485018, 994.3039872089566, 729.9817504562375, 734.7612026091541, 736.6942718771703, 737.9520331178456, 738.3428748413916, 11814.527418903233, 11874.643760687193, 11901.107416943763, 11991.64025079249, 12027.639170824888, 13191.340432978408, 13264.071514993857, 13304.268265245408, 13438.059335846494, 13580.320983950862, 9797.412155270707, 9951.502424878727, 9978.70063898077, 10044.698659040241, 10173.08442240202, 3692.7415080944343, 3696.445533170019, 3740.4763333133383, 3749.062734316421, 3759.079025638736, 52150.47849521494, 52963.0, 54671.0, 55275.723621381636, 55338.16992745112, 10330.121939635064, 10710.143188544898, 10744.14046876248, 10819.78360432787, 10824.242303038869, 18178.36375726843, 18307.54231144232, 18339.816601833812, 18402.723959140625, 18472.81527184711, 6260.217472815898, 6639.834004149935, 6661.966690166518, 6723.899141512881, 6874.312568743086, 3830.885073447801, 3853.672437842759, 3875.476810630585, 3891.747036442622, 3948.0919388540224, 3266.0365192268337, 3284.3923874082893, 3286.342731453719, 3290.5064240364136, 3291.6708329167373, 576.8384852241379, 578.2713780636428, 582.2140110850319, 586.7887560478224, 590.8611476303065, 558.1153871114249, 560.8653923058437, 618.8855061813579, 621.0435928669798, 624.9375062493714, 7579.886301705479, 7694.923050769421, 7695.6536955836, 7770.0, 7896.842063158705, 553.8172403106965, 591.8609126855185, 623.3797371615271, 630.6878095342835, 640.5708175522411, 3532.1699400640828, 3632.3472819866897, 3718.888433347004, 3816.503854498953, 3852.3836186210074, 60222.698886505284, 60726.08910866341, 61338.38661613416, 61524.69237653783, 61704.69147654233, 51973.48026519762, 53943.73028134834, 54269.72865135649, 54335.72832135814, 54976.17535736967, 49305.0, 49393.012139757004, 49660.0, 50650.46747662602, 50883.236751448756, 7422.369098626677, 7485.326320631169, 7491.0, 7567.545947242963, 7594.430417718582, 37058.444123337635, 37974.810125949196, 38068.04829879275, 38071.809640951615, 38263.80868095642, 43254.56745432506, 45001.54998449974, 48554.514454855, 48750.512494874594, 49271.0, 10609.522571484456, 10713.839292410776, 10752.516136773707, 10826.0, 10944.45277736094, 12156.696082598006, 12315.07636927252, 12780.936095319836, 12978.091533592935, 13239.933800330937, 10472.738181545523, 10737.355758654505, 10822.0, 11131.55473781072, 11536.59621913229, 11506.424678765861, 11547.422628868355, 11601.651950441501, 11643.767124657628, 11701.941490292495, 10216.233782466195, 10836.241463097507, 11013.229073964745, 11288.153388496059, 11444.484998175269, 9691.418514889128, 9741.9025809741, 9746.610135594497, 9750.171235445066, 9844.458554779556, 9129.315301352291, 9677.612895484383, 9798.559064841957, 9813.264005199495, 9845.803083938425], "unit": "score", "name": "yui.html", "value": 6394.953683312683}], "name": "dromaeo_css", "value": 7376.586570350472}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 104.0, 109.0, 108.0, 109.0, 120.0, 109.0, 110.0, 108.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [159.0, 126.0, 153.0, 171.0, 128.0, 158.0, 155.0, 142.0, 185.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 160.0, 162.0, 161.0, 161.0, 164.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 73.0, 162.0, 77.0, 75.0, 75.0, 75.0, 160.0, 75.0], "unit": "score", "name": "audio-fft", "value": 92.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 148.0, 93.0, 94.0, 92.0, 150.0, 96.0, 93.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 151.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 55.0, 57.0, 57.0, 56.0, 57.0, 64.0, 63.0, 59.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [67.0, 79.0, 69.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 86.0, 80.0, 79.0, 78.0, 80.0, 77.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [115.0, 111.0, 119.0, 118.0, 111.0, 118.0, 111.0, 114.0, 113.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.2}, {"lowerIsBetter": true, "replicates": [136.0, 137.0, 135.0, 136.0, 141.0, 136.0, 134.0, 136.0, 139.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 67.0, 65.0, 67.0, 65.0, 67.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1508.6000000000001}]} 00:27:10 INFO - Return code: 0 00:27:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:27:10 ERROR - # TBPL SUCCESS # 00:27:10 INFO - Running post-action listener: _resource_record_post_action 00:27:10 INFO - Running post-run listener: _resource_record_post_run 00:27:11 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 274432; Write bytes: 492789760; Read time: 48; Write time: 421296 00:27:11 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 245071872; Read time: 0; Write time: 276928 00:27:11 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 274432; Write bytes: 247717888; Read time: 48; Write time: 144368 00:27:11 INFO - Running post-run listener: _upload_blobber_files 00:27:11 INFO - Blob upload gear active. 00:27:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:27:11 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 00:27:11 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'] 00:27:11 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 00:27:12 INFO - (blobuploader) - INFO - Open directory for files ... 00:27:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:27:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:27:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:27:12 INFO - (blobuploader) - INFO - Done attempting. 00:27:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:27:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:27:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:27:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:27:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:27:13 INFO - (blobuploader) - INFO - Done attempting. 00:27:13 INFO - (blobuploader) - INFO - Iteration through files over. 00:27:13 INFO - Return code: 0 00:27:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:27:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:27:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc825472a04f27d7bb40b3ea2277ba46130e275afc791ccb8234f9b1567c7664c558ca67fcb7e3ece9c96dccce83d19222a764ad6eb1374940dbd71e41a300c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44bebc42d2b47fc56df9d9c344455f11ae99f8a3ce5336fea5d05dd9bac199c140c8ec1551e530777187038d0ac24d535b4d851f76d7f7a3c694a2db1aa759fa"} 00:27:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:27:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:27:13 INFO - Contents: 00:27:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc825472a04f27d7bb40b3ea2277ba46130e275afc791ccb8234f9b1567c7664c558ca67fcb7e3ece9c96dccce83d19222a764ad6eb1374940dbd71e41a300c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44bebc42d2b47fc56df9d9c344455f11ae99f8a3ce5336fea5d05dd9bac199c140c8ec1551e530777187038d0ac24d535b4d851f76d7f7a3c694a2db1aa759fa"} 00:27:13 INFO - Running post-run listener: copy_logs_to_upload_dir 00:27:13 INFO - Copying logs to upload dir... 00:27:13 INFO - mkdir: /builds/slave/test/build/upload/logs 00:27:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.746704 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-17 00:27:13.363702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 00:27:13.368527) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766 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/dc825472a04f27d7bb40b3ea2277ba46130e275afc791ccb8234f9b1567c7664c558ca67fcb7e3ece9c96dccce83d19222a764ad6eb1374940dbd71e41a300c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44bebc42d2b47fc56df9d9c344455f11ae99f8a3ce5336fea5d05dd9bac199c140c8ec1551e530777187038d0ac24d535b4d851f76d7f7a3c694a2db1aa759fa"} build_url:https://queue.taskcluster.net/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/f88U7dteTVaXMLdb9ghLCQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc825472a04f27d7bb40b3ea2277ba46130e275afc791ccb8234f9b1567c7664c558ca67fcb7e3ece9c96dccce83d19222a764ad6eb1374940dbd71e41a300c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44bebc42d2b47fc56df9d9c344455f11ae99f8a3ce5336fea5d05dd9bac199c140c8ec1551e530777187038d0ac24d535b4d851f76d7f7a3c694a2db1aa759fa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 00:27:13.393668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 00:27:13.393998) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460875577.688870-546908766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 00:27:13.477412) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 00:27:13.477762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 00:27:13.478209) ========= ========= Total master_lag: 0.19 =========