builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1461083977.73 results: success (0) buildid: 20160419071033 builduid: 9fe06245d54648769791125562980d93 revision: c07c7171bcc979c24398fa9c0389a82dff425f10 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:37.733162) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:37.733640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:37.733915) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:37.751150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:37.751512) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 09:39:38-- 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% 71.1M=0s 2016-04-19 09:39:38 (71.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094192 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:37.859050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:37.859430) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015919 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:37.909956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:37.910361) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c07c7171bcc979c24398fa9c0389a82dff425f10 --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 c07c7171bcc979c24398fa9c0389a82dff425f10 --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=9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 09:39:38,330 truncating revision to first 12 chars 2016-04-19 09:39:38,330 Setting DEBUG logging. 2016-04-19 09:39:38,330 attempt 1/10 2016-04-19 09:39:38,330 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c07c7171bcc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 09:39:38,575 unpacking tar archive at: mozilla-aurora-c07c7171bcc9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525730 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:38.448652) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:38.448943) ========= script_repo_revision: c07c7171bcc979c24398fa9c0389a82dff425f10 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:38.449356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:38.449623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 09:39:38.458680) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-19 09:39:38.458965) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:39:38 INFO - MultiFileLogger online at 20160419 09:39:38 in /builds/slave/test 09:39:38 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 09:39:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:38 INFO - {'append_to_log': False, 09:39:38 INFO - 'base_work_dir': '/builds/slave/test', 09:39:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:39:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:38 INFO - 'branch': 'Mozilla-Aurora', 09:39:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:38 INFO - 'config_files': ('talos/linux_config.py',), 09:39:38 INFO - 'default_actions': ('clobber', 09:39:38 INFO - 'read-buildbot-config', 09:39:38 INFO - 'download-and-extract', 09:39:38 INFO - 'populate-webroot', 09:39:38 INFO - 'create-virtualenv', 09:39:38 INFO - 'install', 09:39:38 INFO - 'run-tests'), 09:39:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:38 INFO - 'download_minidump_stackwalk': True, 09:39:38 INFO - 'download_symbols': 'ondemand', 09:39:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:39:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:39:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:39:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:39:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:38 INFO - 'installer_path': 'installer.exe', 09:39:38 INFO - 'log_level': 'info', 09:39:38 INFO - 'log_name': 'talos', 09:39:38 INFO - 'log_to_console': True, 09:39:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:39:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:39:38 INFO - 'opt_config_files': (), 09:39:38 INFO - 'pip_index': False, 09:39:38 INFO - 'sps_profile': False, 09:39:38 INFO - 'sps_profile_interval': 0, 09:39:38 INFO - 'suite': 'dromaeojs-e10s', 09:39:38 INFO - 'system_bits': '32', 09:39:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:38 INFO - 'title': 'talos-linux64-ix-022', 09:39:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:38 INFO - 'use_talos_json': True, 09:39:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:38 INFO - 'work_dir': 'build'} 09:39:38 INFO - ##### 09:39:38 INFO - ##### Running clobber step. 09:39:38 INFO - ##### 09:39:38 INFO - Running pre-action listener: _resource_record_pre_action 09:39:38 INFO - Running main action method: clobber 09:39:38 INFO - rmtree: /builds/slave/test/build 09:39:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:39 INFO - Running post-action listener: _resource_record_post_action 09:39:39 INFO - ##### 09:39:39 INFO - ##### Running read-buildbot-config step. 09:39:39 INFO - ##### 09:39:39 INFO - Running pre-action listener: _resource_record_pre_action 09:39:39 INFO - Running main action method: read_buildbot_config 09:39:39 INFO - Using buildbot properties: 09:39:39 INFO - { 09:39:39 INFO - "project": "", 09:39:39 INFO - "product": "firefox", 09:39:39 INFO - "script_repo_revision": "production", 09:39:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:39:39 INFO - "repository": "", 09:39:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:39:39 INFO - "buildid": "20160419071033", 09:39:39 INFO - "pgo_build": "True", 09:39:39 INFO - "basedir": "/builds/slave/test", 09:39:39 INFO - "buildnumber": 209, 09:39:39 INFO - "slavename": "talos-linux64-ix-022", 09:39:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:39:39 INFO - "platform": "ubuntu64_hw", 09:39:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:39:39 INFO - "branch": "mozilla-aurora", 09:39:39 INFO - "repo_path": "releases/mozilla-aurora", 09:39:39 INFO - "revision": "c07c7171bcc979c24398fa9c0389a82dff425f10", 09:39:39 INFO - "stage_platform": "linux64-pgo", 09:39:39 INFO - "builduid": "9fe06245d54648769791125562980d93", 09:39:39 INFO - "slavebuilddir": "test" 09:39:39 INFO - } 09:39:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 09:39:39 INFO - Running post-action listener: _resource_record_post_action 09:39:39 INFO - ##### 09:39:39 INFO - ##### Running download-and-extract step. 09:39:39 INFO - ##### 09:39:39 INFO - Running pre-action listener: _resource_record_pre_action 09:39:39 INFO - Running main action method: download_and_extract 09:39:39 INFO - mkdir: /builds/slave/test/build/tests 09:39: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')]} 09:39:39 INFO - https://queue.taskcluster.net/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:39:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:39:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:39:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/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 09:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/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 09:39:41 INFO - Downloaded 1448 bytes. 09:39:41 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:39:41 INFO - Using the following test package requirements: 09:39:41 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:39:41 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:39:41 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:39:41 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'jsshell-linux-x86_64.zip'], 09:39:41 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:39:41 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:39:41 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:39:41 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:39:41 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:39:41 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:39:41 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:39:41 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:39:41 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')]} 09:39:41 INFO - https://queue.taskcluster.net/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/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 09:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/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 09:39:42 INFO - Downloaded 23352267 bytes. 09:39:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:39:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:39:43 INFO - Return code: 0 09:39:43 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 09:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:43 INFO - https://queue.taskcluster.net/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:39:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:39:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:39:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/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 09:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/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 09:39:45 INFO - Downloaded 23352267 bytes. 09:39:45 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'] 09:39:45 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 09:39:46 INFO - Return code: 0 09:39: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')]} 09:39:46 INFO - https://queue.taskcluster.net/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/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 09:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/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 09:39:47 INFO - Downloaded 10845168 bytes. 09:39:47 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'] 09:39:47 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 09:39:47 INFO - Return code: 0 09:39:47 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')]} 09:39:47 INFO - https://queue.taskcluster.net/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/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 09:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCMn9saZQD68ZX411hd3Mg/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 09:39:51 INFO - Downloaded 60596488 bytes. 09:39:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:39:51 INFO - mkdir: /builds/slave/test/properties 09:39:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:51 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:51 INFO - Contents: 09:39:51 INFO - build_url:https://queue.taskcluster.net/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:39:52 INFO - Running post-action listener: _resource_record_post_action 09:39:52 INFO - Running post-action listener: set_extra_try_arguments 09:39:52 INFO - ##### 09:39:52 INFO - ##### Running populate-webroot step. 09:39:52 INFO - ##### 09:39:52 INFO - Running pre-action listener: _resource_record_pre_action 09:39:52 INFO - Running main action method: populate_webroot 09:39:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:39:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:39:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:39:52 INFO - '--tppagecycles', 09:39:52 INFO - '7'], 09:39:52 INFO - 'tests': ['tsvgm']}}, 09:39:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:39:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:39:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:39:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:39:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:39:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:39:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:52 INFO - 'talos_options': ['--e10s'], 09:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:52 INFO - 'tests': ['damp', 'tps']}, 09:39:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:52 INFO - 'talos_options': ['--e10s'], 09:39:52 INFO - 'tests': ['damp', 'tps']}, 09:39:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:39:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:52 INFO - 'other': {'tests': ['a11yr', 09:39:52 INFO - 'ts_paint', 09:39:52 INFO - 'tpaint', 09:39:52 INFO - 'sessionrestore', 09:39:52 INFO - 'sessionrestore_no_auto_restore', 09:39:52 INFO - 'tabpaint']}, 09:39:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:39:52 INFO - 'tests': ['a11yr', 09:39:52 INFO - 'ts_paint', 09:39:52 INFO - 'tpaint', 09:39:52 INFO - 'sessionrestore', 09:39:52 INFO - 'sessionrestore_no_auto_restore', 09:39:52 INFO - 'tabpaint']}, 09:39:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:39:52 INFO - 'tests': ['a11yr', 09:39:52 INFO - 'ts_paint', 09:39:52 INFO - 'tpaint', 09:39:52 INFO - 'sessionrestore', 09:39:52 INFO - 'sessionrestore_no_auto_restore', 09:39:52 INFO - 'tabpaint']}, 09:39:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:39:52 INFO - 'tests': ['a11yr', 09:39:52 INFO - 'ts_paint', 09:39:52 INFO - 'tpaint', 09:39:52 INFO - 'sessionrestore', 09:39:52 INFO - 'sessionrestore_no_auto_restore', 09:39:52 INFO - 'tabpaint']}, 09:39:52 INFO - 'other_l64': {'tests': ['a11yr', 09:39:52 INFO - 'ts_paint', 09:39:52 INFO - 'tpaint', 09:39:52 INFO - 'sessionrestore', 09:39:52 INFO - 'sessionrestore_no_auto_restore', 09:39:52 INFO - 'tabpaint']}, 09:39:52 INFO - 'other_nol64': {'tests': ['a11yr', 09:39:52 INFO - 'ts_paint', 09:39:52 INFO - 'tpaint', 09:39:52 INFO - 'sessionrestore', 09:39:52 INFO - 'sessionrestore_no_auto_restore', 09:39:52 INFO - 'tabpaint']}, 09:39:52 INFO - 'svgr': {'tests': ['tsvgx', 09:39:52 INFO - 'tsvgr_opacity', 09:39:52 INFO - 'tart', 09:39:52 INFO - 'tscrollx', 09:39:52 INFO - 'cart']}, 09:39:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:39:52 INFO - 'tests': ['tsvgx', 09:39:52 INFO - 'tsvgr_opacity', 09:39:52 INFO - 'tart', 09:39:52 INFO - 'tscrollx', 09:39:52 INFO - 'cart']}, 09:39:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:52 INFO - 'tests': ['tp5o']}, 09:39:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:52 INFO - 'talos_options': ['--e10s'], 09:39:52 INFO - 'tests': ['tp5o']}, 09:39:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:52 INFO - 'talos_options': ['--xperf_path', 09:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:52 INFO - 'tests': ['tp5n']}, 09:39:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:52 INFO - 'talos_options': ['--e10s', 09:39:52 INFO - '--xperf_path', 09:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:52 INFO - 'tests': ['tp5n']}}, 09:39:52 INFO - 'talos.zip': {'path': '', 09:39:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:39:52 INFO - Running post-action listener: _resource_record_post_action 09:39:52 INFO - ##### 09:39:52 INFO - ##### Running create-virtualenv step. 09:39:52 INFO - ##### 09:39:52 INFO - Running pre-action listener: _resource_record_pre_action 09:39:52 INFO - Running main action method: create_virtualenv 09:39:52 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:52 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 09:39:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:39:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:52 INFO - Using real prefix '/usr' 09:39:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:52 INFO - Installing distribute.............................................................................................................................................................................................done. 09:39:54 INFO - Installing pip.................done. 09:39:54 INFO - Return code: 0 09:39:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc06faabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112d160>, '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 0x112e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112e4f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', '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 09:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:39:54 INFO - Using env: {'DISPLAY': ':0', 09:39:54 INFO - 'HOME': '/home/cltbld', 09:39:54 INFO - 'LANG': 'en_US.UTF-8', 09:39:54 INFO - 'LANGUAGE': 'en_US:en', 09:39:54 INFO - 'LOGNAME': 'cltbld', 09:39:54 INFO - 'MAIL': '/var/mail/cltbld', 09:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:54 INFO - 'MOZ_NO_REMOTE': '1', 09:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:54 INFO - 'NO_EM_RESTART': '1', 09:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:54 INFO - 'PWD': '/builds/slave/test', 09:39:54 INFO - 'SHELL': '/bin/bash', 09:39:54 INFO - 'SHLVL': '1', 09:39:54 INFO - 'TERM': 'linux', 09:39:54 INFO - 'TMOUT': '86400', 09:39:54 INFO - 'USER': 'cltbld', 09:39:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', 09:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:54 INFO - '_': '/tools/buildbot/bin/python'} 09:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:55 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 09:39:55 INFO - Cleaning up... 09:39:55 INFO - Return code: 0 09:39:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc06faabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112d160>, '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 0x112e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112e4f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', '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 09:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:39:55 INFO - Using env: {'DISPLAY': ':0', 09:39:55 INFO - 'HOME': '/home/cltbld', 09:39:55 INFO - 'LANG': 'en_US.UTF-8', 09:39:55 INFO - 'LANGUAGE': 'en_US:en', 09:39:55 INFO - 'LOGNAME': 'cltbld', 09:39:55 INFO - 'MAIL': '/var/mail/cltbld', 09:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:55 INFO - 'MOZ_NO_REMOTE': '1', 09:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:55 INFO - 'NO_EM_RESTART': '1', 09:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:55 INFO - 'PWD': '/builds/slave/test', 09:39:55 INFO - 'SHELL': '/bin/bash', 09:39:55 INFO - 'SHLVL': '1', 09:39:55 INFO - 'TERM': 'linux', 09:39:55 INFO - 'TMOUT': '86400', 09:39:55 INFO - 'USER': 'cltbld', 09:39:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', 09:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:55 INFO - '_': '/tools/buildbot/bin/python'} 09:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:55 INFO - Downloading/unpacking psutil>=0.7.1 09:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:39:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:57 INFO - Installing collected packages: psutil 09:39:57 INFO - Running setup.py install for psutil 09:39:57 INFO - building 'psutil._psutil_linux' extension 09:39:57 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 09:39:57 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 09:39:57 INFO - building 'psutil._psutil_posix' extension 09:39:57 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 09:39:57 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 09:39:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:57 INFO - Successfully installed psutil 09:39:57 INFO - Cleaning up... 09:39:57 INFO - Return code: 0 09:39:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:57 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 0x7fc06faabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112d160>, '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 0x112e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112e4f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', '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 09:39:57 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 09:39:57 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 09:39:57 INFO - Using env: {'DISPLAY': ':0', 09:39:57 INFO - 'HOME': '/home/cltbld', 09:39:57 INFO - 'LANG': 'en_US.UTF-8', 09:39:57 INFO - 'LANGUAGE': 'en_US:en', 09:39:57 INFO - 'LOGNAME': 'cltbld', 09:39:57 INFO - 'MAIL': '/var/mail/cltbld', 09:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:57 INFO - 'MOZ_NO_REMOTE': '1', 09:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:57 INFO - 'NO_EM_RESTART': '1', 09:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:57 INFO - 'PWD': '/builds/slave/test', 09:39:57 INFO - 'SHELL': '/bin/bash', 09:39:57 INFO - 'SHLVL': '1', 09:39:57 INFO - 'TERM': 'linux', 09:39:57 INFO - 'TMOUT': '86400', 09:39:57 INFO - 'USER': 'cltbld', 09:39:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', 09:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:57 INFO - '_': '/tools/buildbot/bin/python'} 09:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:39:59 INFO - Installing collected packages: mozsystemmonitor 09:39:59 INFO - Running setup.py install for mozsystemmonitor 09:40:00 INFO - Successfully installed mozsystemmonitor 09:40:00 INFO - Cleaning up... 09:40:00 INFO - Return code: 0 09:40:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:40:00 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')]} 09:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:00 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')]} 09:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:00 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 0x7fc06faabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112d160>, '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 0x112e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112e4f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', '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 09:40:00 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 09:40:00 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 09:40:00 INFO - Using env: {'DISPLAY': ':0', 09:40:00 INFO - 'HOME': '/home/cltbld', 09:40:00 INFO - 'LANG': 'en_US.UTF-8', 09:40:00 INFO - 'LANGUAGE': 'en_US:en', 09:40:00 INFO - 'LOGNAME': 'cltbld', 09:40:00 INFO - 'MAIL': '/var/mail/cltbld', 09:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:00 INFO - 'MOZ_NO_REMOTE': '1', 09:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:00 INFO - 'NO_EM_RESTART': '1', 09:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:00 INFO - 'PWD': '/builds/slave/test', 09:40:00 INFO - 'SHELL': '/bin/bash', 09:40:00 INFO - 'SHLVL': '1', 09:40:00 INFO - 'TERM': 'linux', 09:40:00 INFO - 'TMOUT': '86400', 09:40:00 INFO - 'USER': 'cltbld', 09:40:00 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', 09:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:00 INFO - '_': '/tools/buildbot/bin/python'} 09:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:40:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:40:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40:02 INFO - Downloading docopt-0.6.1.tar.gz 09:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:40:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:40:02 INFO - Running setup.py install for blobuploader 09:40:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:40:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:40:03 INFO - Running setup.py install for requests 09:40:03 INFO - Running setup.py install for docopt 09:40:03 INFO - Successfully installed blobuploader requests docopt 09:40:03 INFO - Cleaning up... 09:40:03 INFO - Return code: 0 09:40:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:03 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')]} 09:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:03 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')]} 09:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:03 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 0x7fc06faabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112d160>, '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 0x112e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112e4f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', '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 09:40:03 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 09:40:03 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 09:40:03 INFO - Using env: {'DISPLAY': ':0', 09:40:03 INFO - 'HOME': '/home/cltbld', 09:40:03 INFO - 'LANG': 'en_US.UTF-8', 09:40:03 INFO - 'LANGUAGE': 'en_US:en', 09:40:03 INFO - 'LOGNAME': 'cltbld', 09:40:03 INFO - 'MAIL': '/var/mail/cltbld', 09:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:03 INFO - 'MOZ_NO_REMOTE': '1', 09:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:03 INFO - 'NO_EM_RESTART': '1', 09:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:03 INFO - 'PWD': '/builds/slave/test', 09:40:03 INFO - 'SHELL': '/bin/bash', 09:40:03 INFO - 'SHLVL': '1', 09:40:03 INFO - 'TERM': 'linux', 09:40:03 INFO - 'TMOUT': '86400', 09:40:03 INFO - 'USER': 'cltbld', 09:40:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', 09:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:03 INFO - '_': '/tools/buildbot/bin/python'} 09:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:03 INFO - Running setup.py (path:/tmp/pip-avdT_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:03 INFO - Running setup.py (path:/tmp/pip-jVFdNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:03 INFO - Running setup.py (path:/tmp/pip-B0pK5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:03 INFO - Running setup.py (path:/tmp/pip-mH2RMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:04 INFO - Running setup.py (path:/tmp/pip-HM1YUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:04 INFO - Running setup.py (path:/tmp/pip-LyR4BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:04 INFO - Running setup.py (path:/tmp/pip-L29PUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:04 INFO - Running setup.py (path:/tmp/pip-FUSr_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:04 INFO - Running setup.py (path:/tmp/pip-1O6drB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:04 INFO - Running setup.py (path:/tmp/pip-9BrRoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:04 INFO - Running setup.py (path:/tmp/pip-VZ4fk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:04 INFO - Running setup.py (path:/tmp/pip-zrEjUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:04 INFO - Running setup.py (path:/tmp/pip-hWw78B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:04 INFO - Running setup.py (path:/tmp/pip-48VWOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:04 INFO - Running setup.py (path:/tmp/pip-QEvEne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:04 INFO - Running setup.py (path:/tmp/pip-rLK7FA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:04 INFO - Running setup.py (path:/tmp/pip-K6n0lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:40:04 INFO - Running setup.py install for manifestparser 09:40:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:40:05 INFO - Running setup.py install for mozcrash 09:40:05 INFO - Running setup.py install for mozdebug 09:40:05 INFO - Running setup.py install for mozdevice 09:40:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:40:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:40:05 INFO - Running setup.py install for mozfile 09:40:05 INFO - Running setup.py install for mozhttpd 09:40:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:40:05 INFO - Running setup.py install for mozinfo 09:40:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:40:05 INFO - Running setup.py install for mozInstall 09:40:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:40:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:40:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:40:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:40:05 INFO - Running setup.py install for mozleak 09:40:05 INFO - Running setup.py install for mozlog 09:40:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:40:06 INFO - Running setup.py install for moznetwork 09:40:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:40:06 INFO - Running setup.py install for mozprocess 09:40:06 INFO - Running setup.py install for mozprofile 09:40:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:40:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:40:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:40:06 INFO - Running setup.py install for mozrunner 09:40:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:40:06 INFO - Running setup.py install for mozscreenshot 09:40:06 INFO - Running setup.py install for moztest 09:40:06 INFO - Running setup.py install for mozversion 09:40:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:40:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:40:06 INFO - Cleaning up... 09:40:06 INFO - Return code: 0 09:40:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:06 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')]} 09:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:06 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')]} 09:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:06 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 0x7fc06faabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112d160>, '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 0x112e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112e4f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', '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 09:40:06 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 09:40:06 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 09:40:06 INFO - Using env: {'DISPLAY': ':0', 09:40:06 INFO - 'HOME': '/home/cltbld', 09:40:06 INFO - 'LANG': 'en_US.UTF-8', 09:40:06 INFO - 'LANGUAGE': 'en_US:en', 09:40:06 INFO - 'LOGNAME': 'cltbld', 09:40:06 INFO - 'MAIL': '/var/mail/cltbld', 09:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:06 INFO - 'MOZ_NO_REMOTE': '1', 09:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:06 INFO - 'NO_EM_RESTART': '1', 09:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:06 INFO - 'PWD': '/builds/slave/test', 09:40:06 INFO - 'SHELL': '/bin/bash', 09:40:06 INFO - 'SHLVL': '1', 09:40:06 INFO - 'TERM': 'linux', 09:40:06 INFO - 'TMOUT': '86400', 09:40:06 INFO - 'USER': 'cltbld', 09:40:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', 09:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:06 INFO - '_': '/tools/buildbot/bin/python'} 09:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:06 INFO - Running setup.py (path:/tmp/pip-Ouit0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:07 INFO - Running setup.py (path:/tmp/pip-tysACI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:07 INFO - Running setup.py (path:/tmp/pip-MoVOmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:07 INFO - Running setup.py (path:/tmp/pip-rZjDiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:07 INFO - Running setup.py (path:/tmp/pip-14Ix5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:07 INFO - Running setup.py (path:/tmp/pip-d6ju79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:07 INFO - Running setup.py (path:/tmp/pip-eeBL9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:07 INFO - Running setup.py (path:/tmp/pip-iLiK8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:07 INFO - Running setup.py (path:/tmp/pip-IwBtM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:07 INFO - Running setup.py (path:/tmp/pip-t6vF2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:07 INFO - Running setup.py (path:/tmp/pip-qKfMiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:07 INFO - Running setup.py (path:/tmp/pip-aKNgOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:07 INFO - Running setup.py (path:/tmp/pip-PExlcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:07 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)) 09:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:07 INFO - Running setup.py (path:/tmp/pip-NoKpRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:08 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)) 09:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:08 INFO - Running setup.py (path:/tmp/pip-A2nzux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:08 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)) 09:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:08 INFO - Running setup.py (path:/tmp/pip-rCxrFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:08 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)) 09:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:08 INFO - Running setup.py (path:/tmp/pip-U9m8et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:08 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)) 09:40:08 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)) 09:40:08 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)) 09:40:08 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)) 09:40:08 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)) 09:40:08 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)) 09:40:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40:08 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 09:40:08 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 09:40:08 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 09:40:08 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 09:40:08 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 09:40:08 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 09:40:10 INFO - Downloading blessings-1.6.tar.gz 09:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:10 INFO - Installing collected packages: blessings 09:40:10 INFO - Running setup.py install for blessings 09:40:10 INFO - Successfully installed blessings 09:40:10 INFO - Cleaning up... 09:40:10 INFO - Return code: 0 09:40:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:10 INFO - Reading from file tmpfile_stdout 09:40:10 INFO - Current package versions: 09:40:10 INFO - argparse == 1.2.1 09:40:10 INFO - blessings == 1.6 09:40:10 INFO - blobuploader == 1.2.4 09:40:10 INFO - docopt == 0.6.1 09:40:10 INFO - manifestparser == 1.1 09:40:10 INFO - mozInstall == 1.12 09:40:10 INFO - mozcrash == 0.17 09:40:10 INFO - mozdebug == 0.1 09:40:10 INFO - mozdevice == 0.48 09:40:10 INFO - mozfile == 1.2 09:40:10 INFO - mozhttpd == 0.7 09:40:10 INFO - mozinfo == 0.9 09:40:10 INFO - mozleak == 0.1 09:40:10 INFO - mozlog == 3.1 09:40:10 INFO - moznetwork == 0.27 09:40:10 INFO - mozprocess == 0.22 09:40:10 INFO - mozprofile == 0.28 09:40:10 INFO - mozrunner == 6.11 09:40:10 INFO - mozscreenshot == 0.1 09:40:10 INFO - mozsystemmonitor == 0.0 09:40:10 INFO - moztest == 0.7 09:40:10 INFO - mozversion == 1.4 09:40:10 INFO - psutil == 3.1.1 09:40:10 INFO - requests == 1.2.3 09:40:10 INFO - wsgiref == 0.1.2 09:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40: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')]} 09:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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')]} 09:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:10 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 0x7fc06faabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112d160>, '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 0x112e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112e4f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', '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 09:40:10 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 09:40:10 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 09:40:10 INFO - Using env: {'DISPLAY': ':0', 09:40:10 INFO - 'HOME': '/home/cltbld', 09:40:10 INFO - 'LANG': 'en_US.UTF-8', 09:40:10 INFO - 'LANGUAGE': 'en_US:en', 09:40:10 INFO - 'LOGNAME': 'cltbld', 09:40:10 INFO - 'MAIL': '/var/mail/cltbld', 09:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:10 INFO - 'MOZ_NO_REMOTE': '1', 09:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:10 INFO - 'NO_EM_RESTART': '1', 09:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:10 INFO - 'PWD': '/builds/slave/test', 09:40:10 INFO - 'SHELL': '/bin/bash', 09:40:10 INFO - 'SHLVL': '1', 09:40:10 INFO - 'TERM': 'linux', 09:40:10 INFO - 'TMOUT': '86400', 09:40:10 INFO - 'USER': 'cltbld', 09:40:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', 09:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:10 INFO - '_': '/tools/buildbot/bin/python'} 09:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:10 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)) 09:40:10 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)) 09:40:10 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)) 09:40:10 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)) 09:40:10 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)) 09:40:10 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)) 09:40:10 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)) 09:40:10 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)) 09:40:10 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)) 09:40:10 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)) 09:40:10 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)) 09:40:10 INFO - Cleaning up... 09:40:10 INFO - Return code: 0 09:40:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40: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')]} 09:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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')]} 09:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc06faabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112d160>, '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 0x112e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112e4f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', '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 09:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:40:10 INFO - Using env: {'DISPLAY': ':0', 09:40:10 INFO - 'HOME': '/home/cltbld', 09:40:10 INFO - 'LANG': 'en_US.UTF-8', 09:40:10 INFO - 'LANGUAGE': 'en_US:en', 09:40:10 INFO - 'LOGNAME': 'cltbld', 09:40:10 INFO - 'MAIL': '/var/mail/cltbld', 09:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:10 INFO - 'MOZ_NO_REMOTE': '1', 09:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:10 INFO - 'NO_EM_RESTART': '1', 09:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:10 INFO - 'PWD': '/builds/slave/test', 09:40:10 INFO - 'SHELL': '/bin/bash', 09:40:10 INFO - 'SHLVL': '1', 09:40:10 INFO - 'TERM': 'linux', 09:40:10 INFO - 'TMOUT': '86400', 09:40:10 INFO - 'USER': 'cltbld', 09:40:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', 09:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:10 INFO - '_': '/tools/buildbot/bin/python'} 09:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:11 INFO - Downloading/unpacking jsonschema 09:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:40:13 INFO - Downloading/unpacking functools32 (from jsonschema) 09:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:40:14 INFO - warning: no files found matching '*.txt' 09:40:14 INFO - no previously-included directories found matching 'build' 09:40:14 INFO - no previously-included directories found matching 'dist' 09:40:14 INFO - no previously-included directories found matching '.git*' 09:40:14 INFO - Installing collected packages: jsonschema, functools32 09:40:14 INFO - Running setup.py install for functools32 09:40:14 INFO - warning: no files found matching '*.txt' 09:40:14 INFO - no previously-included directories found matching 'build' 09:40:14 INFO - no previously-included directories found matching 'dist' 09:40:14 INFO - no previously-included directories found matching '.git*' 09:40:14 INFO - Successfully installed jsonschema functools32 09:40:14 INFO - Cleaning up... 09:40:14 INFO - Return code: 0 09:40:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:40: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')]} 09:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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')]} 09:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:14 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 0x7fc06faabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112d160>, '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 0x112e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112e4f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', '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 09:40:14 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 09:40:14 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 09:40:14 INFO - Using env: {'DISPLAY': ':0', 09:40:14 INFO - 'HOME': '/home/cltbld', 09:40:14 INFO - 'LANG': 'en_US.UTF-8', 09:40:14 INFO - 'LANGUAGE': 'en_US:en', 09:40:14 INFO - 'LOGNAME': 'cltbld', 09:40:14 INFO - 'MAIL': '/var/mail/cltbld', 09:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:14 INFO - 'MOZ_NO_REMOTE': '1', 09:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:14 INFO - 'NO_EM_RESTART': '1', 09:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:14 INFO - 'PWD': '/builds/slave/test', 09:40:14 INFO - 'SHELL': '/bin/bash', 09:40:14 INFO - 'SHLVL': '1', 09:40:14 INFO - 'TERM': 'linux', 09:40:14 INFO - 'TMOUT': '86400', 09:40:14 INFO - 'USER': 'cltbld', 09:40:14 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', 09:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:14 INFO - '_': '/tools/buildbot/bin/python'} 09:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:14 INFO - Downloading/unpacking flake8 09:40:14 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 09:40:14 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 09:40:14 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 09:40:14 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 09:40:14 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 09:40:14 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 09:40:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:40:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:40:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:40:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:40:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:40:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:40:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:40:17 INFO - no previously-included directories found matching 'docs/_build' 09:40:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:40:17 INFO - Running setup.py install for pep8 09:40:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:40:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:40:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:40:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:40:17 INFO - no previously-included directories found matching 'docs/_build' 09:40:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:40:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:40:17 INFO - Cleaning up... 09:40:18 INFO - Return code: 0 09:40:18 INFO - Running post-action listener: _resource_record_post_action 09:40:18 INFO - Running post-action listener: _start_resource_monitoring 09:40:19 INFO - Starting resource monitoring. 09:40:19 INFO - ##### 09:40:19 INFO - ##### Running install step. 09:40:19 INFO - ##### 09:40:19 INFO - Running pre-action listener: _resource_record_pre_action 09:40:19 INFO - Running main action method: install 09:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:19 INFO - Reading from file tmpfile_stdout 09:40:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:19 INFO - Reading from file tmpfile_stdout 09:40:19 INFO - Output received: 09:40:19 INFO - Usage: mozinstall [options] installer 09:40:19 INFO - Options: 09:40:19 INFO - -h, --help show this help message and exit 09:40:19 INFO - -d DEST, --destination=DEST 09:40:19 INFO - Directory to install application into. [default: 09:40:19 INFO - "/builds/slave/test"] 09:40:19 INFO - --app=APP Application being installed. [default: firefox] 09:40:19 INFO - mkdir: /builds/slave/test/build/application 09:40:19 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'] 09:40:19 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 09:40:34 INFO - Reading from file tmpfile_stdout 09:40:34 INFO - Output received: 09:40:34 INFO - /builds/slave/test/build/application/firefox/firefox 09:40:34 INFO - Running post-action listener: _resource_record_post_action 09:40:34 INFO - ##### 09:40:34 INFO - ##### Running run-tests step. 09:40:34 INFO - ##### 09:40:34 INFO - Running pre-action listener: _resource_record_pre_action 09:40:34 INFO - Running main action method: run_tests 09:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:34 INFO - Python 2.7.3 09:40:34 INFO - Return code: 0 09:40:34 INFO - grabbing minidump binary from tooltool 09:40:34 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')]} 09:40:34 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 0x112d160>, '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 0x112e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112e4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:34 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 09:40:34 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 09:40:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:34 INFO - Return code: 0 09:40:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:40:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:40:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:40:35 INFO - Return code: 0 09:40:35 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/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 09:40:35 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/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 09:40:35 INFO - Using env: {'DISPLAY': ':0', 09:40:35 INFO - 'HOME': '/home/cltbld', 09:40:35 INFO - 'LANG': 'en_US.UTF-8', 09:40:35 INFO - 'LANGUAGE': 'en_US:en', 09:40:35 INFO - 'LOGNAME': 'cltbld', 09:40:35 INFO - 'MAIL': '/var/mail/cltbld', 09:40:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:35 INFO - 'MOZ_NO_REMOTE': '1', 09:40:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:35 INFO - 'NO_EM_RESTART': '1', 09:40:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:35 INFO - 'PWD': '/builds/slave/test', 09:40:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:35 INFO - 'SHELL': '/bin/bash', 09:40:35 INFO - 'SHLVL': '1', 09:40:35 INFO - 'TERM': 'linux', 09:40:35 INFO - 'TMOUT': '86400', 09:40:35 INFO - 'USER': 'cltbld', 09:40:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022', 09:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:35 INFO - '_': '/tools/buildbot/bin/python'} 09:40:35 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/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 09:40:35 INFO - mozversion application_buildid: 20160419071033 09:40:35 INFO - mozversion application_changeset: c07c7171bcc979c24398fa9c0389a82dff425f10 09:40:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:40:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:35 INFO - mozversion application_name: Firefox 09:40:35 INFO - mozversion application_remotingname: firefox-dev 09:40:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:40:35 INFO - mozversion application_vendor: Mozilla 09:40:35 INFO - mozversion application_version: 47.0a2 09:40:35 INFO - mozversion platform_buildid: 20160419071033 09:40:35 INFO - mozversion platform_changeset: c07c7171bcc979c24398fa9c0389a82dff425f10 09:40:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:40:35 INFO - mozversion platform_version: 47.0a2 09:40:35 INFO - using testdate: 1461084035 09:40:35 INFO - actual date: 1461084035 09:40:35 INFO - starting webserver on 'localhost:49693' 09:40:35 INFO - SUITE-START | Running 2 tests 09:40:35 INFO - TEST-START | dromaeo_css 09:40:35 INFO - operating with platform_type : linux_ 09:40:35 INFO - Initialising browser for dromaeo_css test... 09:40:35 INFO - TEST-INFO | started process 28667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIW8__A/profile http://localhost:49693/getInfo.html) 09:40:39 INFO - PROCESS | 28667 | 09:40:39 INFO - PROCESS | 28667 | (process:28742): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:40:40 INFO - PROCESS | 28667 | __metrics Screen width/height:1600/1200 09:40:40 INFO - PROCESS | 28667 | colorDepth:24 09:40:40 INFO - PROCESS | 28667 | Browser inner width/height: 1024/697 09:40:40 INFO - PROCESS | 28667 | __metrics 09:40:41 ERROR - PROCESS | 28667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:40:42 INFO - TEST-INFO | 28667: exit 0 09:40:42 INFO - Browser initialized. 09:40:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:40:42 INFO - TEST-INFO | started process 28793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIW8__A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:44 INFO - PROCESS | 28793 | 09:40:44 INFO - PROCESS | 28793 | (process:28862): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:40:54 INFO - PROCESS | 28793 | RSS: Main: 151588864 09:40:54 INFO - PROCESS | 28793 | 09:41:43 INFO - PROCESS | 28793 | 1461084103633 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] 09:43:51 INFO - PROCESS | 28793 | Cycle 1(1): loaded http://localhost:49693/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49693/tests/dromaeo/cssquery-ext.html) 09:43:52 INFO - PROCESS | 28793 | RSS: Main: 154144768 09:43:52 INFO - PROCESS | 28793 | 09:46:54 INFO - PROCESS | 28793 | Cycle 1(1): loaded http://localhost:49693/tests/dromaeo/cssquery-ext.html (next: http://localhost:49693/tests/dromaeo/cssquery-jquery.html) 09:46:55 INFO - PROCESS | 28793 | RSS: Main: 153088000 09:46:55 INFO - PROCESS | 28793 | 09:49:56 INFO - PROCESS | 28793 | Cycle 1(1): loaded http://localhost:49693/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49693/tests/dromaeo/cssquery-mootools.html) 09:49:57 INFO - PROCESS | 28793 | RSS: Main: 153776128 09:49:57 INFO - PROCESS | 28793 | 09:52:59 INFO - PROCESS | 28793 | Cycle 1(1): loaded http://localhost:49693/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49693/tests/dromaeo/cssquery-prototype.html) 09:52:59 INFO - PROCESS | 28793 | RSS: Main: 152899584 09:52:59 INFO - PROCESS | 28793 | 09:56:02 INFO - PROCESS | 28793 | Cycle 1(1): loaded http://localhost:49693/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49693/tests/dromaeo/cssquery-yui.html) 09:56:02 INFO - PROCESS | 28793 | RSS: Main: 154238976 09:56:02 INFO - PROCESS | 28793 | 09:59:04 INFO - PROCESS | 28793 | Cycle 1(1): loaded http://localhost:49693/tests/dromaeo/cssquery-yui.html (next: http://localhost:49693/tests/dromaeo/cssquery-dojo.html) 09:59:04 INFO - PROCESS | 28793 | RSS: Main: 155504640 09:59:04 INFO - PROCESS | 28793 | 09:59:04 INFO - PROCESS | 28793 | __start_tp_report 09:59:04 INFO - PROCESS | 28793 | _x_x_mozilla_page_load 09:59:04 INFO - PROCESS | 28793 | _x_x_mozilla_page_load_details 09:59:04 INFO - PROCESS | 28793 | |i|pagename|runs| 09:59:04 INFO - PROCESS | 28793 | |0;dojo.html;3298.191942973972;3346.514755360472;3359.8824041158564;3376.797392156471;3382.0868365541305;5504.889902201953;5519.39286678465;5525.4474552544725;5531.336239651242;5551.555875529958;5472.480114389126;5484.670919744818;5518.310211223597;5528.308961379827;5535.446455354472;5018.749062546876;5049.798008079672;5106.719130447824;5120.795168193268;5128.205128205134;4996.650234483587;5094.79620815167;5105.361829771278;5114.923276150861;5185.714785686786;5069.214271787879;5077.873053173664;5145.099607568679;5167.4057483389515;5200.973995130038;5125.487451254882;5160.509751573613;5163.922541161885;5165.948340516622;5213.478652134794;4873.488283730228;4936.308916751657;5020.046191223656;5075;5112.923306150411;5333.546648534879;5342.492463215988;5370.570354371641;5381.784728610851;5390.245365648812;5935.376785437553;5989.251343582052;5997.760089596411;6002.159697642333;6013.428724271187;5879.52963762898;5992.940070599282;6026.939730602681;6079.635221886701;6087.939120608826;5541.030319694038;5551.444855514456;5551.7779288828;5562.805301814457;5565.972170139164;5959.374265702038;6084.6349219047;6085.847853803691;6089.939100609025;6097.115918191837;5862.8534286642325;5917.970410147922;5920.348761636216;5934.584579079509;5936.376680448577;5962.672053037125;5973.37279585646;5983.311919129269;5985.16207730918;5990.191324171181;5803;5885.499732522698;5937.346891841894;5946.137810017523;5963.850903727354;5945.791897283574;5959.582829201914;5981.252343457068;6002.759889604455;6015.699215039231;4547.772611369484;4567.314902764546;4572.222722137245;4587.266037433995;4598.333241679938;4052.49343832021;4058.9594104059174;4074.5721699221153;4106.7946602669745;4156.43888075112;5546.334439867242;5674.517665998436;5709.3434255060365;5749.252597162342;5818.5636077294375;5961.910571341434;5978.28260608721;5997.520198384119;6012;6022.5784195105925;5547.944520554824;5645.717714114277;5712.742926568314;5730.942690573041;5735.8566035849435;5103.18349064148;5108.9744551277745;5133.768980395891;5135.845924622267;5160.92258616121;6227.595206311666;6228.34602366745;6228.813135605848;6228.937710622836;6242.5942313749465;5885.47030767233;5937.673427961504;6001.819945401645;6007.06890431975;6019.458248757633;6215.502759779117;6243.968780156252;6274.6548939808745;6282.026285925689;6286.779962701284;5901.675407852609;5930.733117009659;5940.435658612425;5944.762209511571;5945.940540594712;5736.799212027559;5968.462838344396;6005.90991135142;6042.969785151046;6074;5835.94164058354;5841.649501029951;5847.795327163529;5858.94141058584;5893.086571581412;5857.619254748428;5869.295684517885;5871.853203669943;5875.823725288248;5875.94124058771;5577.665340079446;5681.943180568307;5727.4845263926445;5736.340320862987;5737.225474560881;5828.358880523224;5850.853728656818;5870.7945221917025;5893.675847828239;5907.3797251288;5632.239647647515;5754.597178197653;5755.107958266475;5762.942370576408;5784.566157538286 09:59:04 INFO - PROCESS | 28793 | |1;ext.html;561.9325680918289;578.1934201788504;584.3075954993333;589.6079107393583;623.7816764132551;38185.045373865665;38561.807190964006;38641;38782.22435551291;38855.41716874249;43258.13483730331;43861.56138438615;43913.560864391424;43929.34105988405;43951.78024109875;8809.427387219826;8992.595333210022;9001.099890011012;9004.459732416077;9013.188813006827;8822.161894620032;8946.731598052036;8954.552272386387;8958.328125390623;8958.552072396387;9156.496392698398;9255.398399104037;9255.53722313885;9258.120478554527;9292.814143717122;9126.680566180185;9218.124278193627;9221.123993220634;9230.86153707695;9245.260379169684;9035;9122.315826313054;9171.220446262008;9174.495402752846;9193.448393096369;42446.78776606128;42868;42922.57077429248;42957.78521107406;42981.925451863644;2925.985370073136;3546.9238868457333;3614.981925090358;3629.074585980558;3696.075981004749;32064;32538;32696.182595435304;32711.836440817882;33010.33979320424;4087.9591204088174;4177.6866734995;4182.519010313822;4202.117555313388;4234.724742891703;284372;289547;290710.9999999979;291686;292244;47703.28445073327;70727.64636176787;71522.2847771526;72194.27805721981;72258;47956.760216198694;48195.75902120467;48255.517444825804;48376.758116209894;48393.75803120962;16755.497335079966;16921.830781692024;16997.49007529776;17000.149992500326;17017.064061476736;13415.664608384674;13625.659358516117;13625.931870340584;13666.316684165751;13684.93157534206;15831.920840395724;15955.760663590056;15963.680726385408;16294.837051629569;16329.10189939541;6192.566520343533;6218.471429928416;6222.937770622236;6262.968685156545;6270.122182894398;1022.1107636356418;1057.4025675493322;1096.9451527423596;1176.7117056321256;1176.8587769467547;29727;30562.694373055983;30669.386612268077;30852.074437766903;30872.0738377849;1194.474431250247;1245.1844042152404;1269.3906924676207;1273.9554115605908;1285.8585555588877;15491.612709682122;15745;16102.516924492284;16150.919245403698;16318;354613;545489;551461;838668;842365;58959.41040589539;59531.40468595345;60071.39928600658;60286.39713602808;60584.394156058755;1436.4685066525453;1460.627539977299;1480.208088672555;1484.5917372722372;1489.5605796289904;27834;28671;28776.280592985342;28961.7103828959;29192.854035729684;48576;48813.75593122012;49303.26045109398;49343.506564933894;49529.752351238014;322975;323631;325375;326283;326708;33975.49036764401;50435;50772.23841642452;51474.22788658248;52037;47928.52071479241;48368.75815620899;48569;48600.270995935796;48993.510064898896;39546;39658.60341396549;39809;40391.3941290875;40419.39370909498;38592.42111368276;38733.418998715606;39030.6096939027;39337.213255734154;42521.36217956795;42454.78772606241;42457.787711061246;43084.35373469463;43235.35146972735;43367.34948975705;38057.42913856239;38148.80925595354;38369.2326153481;38992.80503597464;39037.219255615295;29159.562606560496;29171.708282916898;29575.924622136696;29585.556216657198;29886.701132988394 09:59:04 INFO - PROCESS | 28793 | |2;jquery.html;374.3990894614144;375.6337570868404;378.2963687541173;383.2947376826638;384.76144790230063;17583.736243956337;18296.817031829676;19405.41783746486;19558.51103722406;19611.901940490312;19232.326868559605;19236.71144932827;19239.134238959246;19276.518087047833;19668.803311966876;6136.570440069186;6391.328910464404;6436.420722135007;6436.549441539094;6442.259140198867;5190.2474141249495;6228.096925945735;6619.569727967691;6647.50143739219;6683.231428385725;6464.644444555547;6594.109795177637;6639.535232533724;7017.087778588776;7126.964365178193;6983.3714965653335;6984.650767461607;7035.824104397379;7092.148942126952;7095.964520177392;6550.541462097655;6902.827429314257;6903.033575299462;6905.965470172668;6944.4097251733665;24089.156879509133;24723.25830225096;24737.752622473727;24861.751382486123;25117.62323565148;2469.1111199967995;2491.476789874129;2677.9866100669565;2756.6554180727408;3178.9350567559895;14136.787948180785;15478;15648.374065037386;15700.528984130495;15739.92130039354;1962.1562728026943;2044.7137400763756;2070.554830711389;2091.1008266445424;2111.6199084164846;80078;83648;84059;84565.57717211374;85154;15043.774343384857;15398.230088495531;15401;15432.22838858075;15779;26831.195064147716;27221.727782722315;27488.17535473939;27643.44713105767;27766.8893244272;9393.90606093944;9457.810843783085;9635.325527213028;9709.563069661883;9721.951390243003;8249.79375515605;8383.790405239795;8452.408331416866;8453.661853525913;8497.575121243914;7760.758278675385;7784.688612455551;7925.365970722329;7927.445078844426;8069.878951815727;2899.666538348075;3025.7579393648894;3138.9686103139134;3258.4381865388646;3352.966470335314;974.91713204377;989.5497548615363;1051.4900273367412;1057.2123767793043;1068.3322923173016;17061.40285090016;17340.826591734174;17348.132593370534;17487.650246995243;17758.37845675421;985.2069084387138;997.9870431512021;1021.5913634546092;1029.325791606499;1065.9979619157966;8246.3815213858;10073.194144468425;10195.439250841275;10325.84511232332;10400.843987340197;443578;452086;458881;461077;488299;68593.65703171452;75929.62035189789;84328;86306.56846715852;88336.55831720801;1043.89561043895;1068.4070340960686;1081.3457857995957;1081.588996181446;1084.8589683341115;16384.098874562012;16462.588435288733;16549.50351489457;16601.169941502634;16793.91603041977;36149.81925090358;36381;37522;37785;38495.80752096222;51545.22682159695;51744.22383664173;52186;52230.21654675259;52239.73880130575;8528.786780330292;8641.481511109354;8657.091005444337;8741.213290803604;8752.168543988311;9881.145192235701;13207.471701132232;13334.19994800315;13631.727365452834;13655.795163072364;11151.275167114112;11360.204785664924;11397.658070257905;11422.714432139262;11554.422278885853;11270.478485404365;11424.885751142383;11663.475143618387;11703.122265829927;11849.637291711564;11351.14866385008;11464.541418343173;11584.247023943417;11826.34955077479;12052.51789928393;8485.236328730443;8551.786205344915;8578.099299573705;8649.221570058726;8807.471551706918;9090.545472726206;11236.66290011301;11669.708257293636;11763.235389699643;11771.823422648838 09:59:04 INFO - PROCESS | 28793 | |3;mootools.html;1567.4592265668343;1578.7631855221719;1773;1867.0851282871397;1880.8965506897123;8294.585270736454;8340.708075217368;8442.704505342313;8525.786855328612;8573.185547372997;8760;8794.6921857735;8882.467051976886;8906.866397004034;8923.375363724526;2435.1720415058876;2455.9807679812902;2484.62730590412;2486.651868738378;2497.7127630322566;2432.8297019208662;2489.676342075528;2512.0705339024585;2515.8993640254366;2517.0812653381568;2405.1581946318825;2435.6833611630464;2482.329770961839;2487;2489.8381605195696;2420.552197843396;2439.353571303606;2453.116877923946;2478.962815557768;2490.1533478617175;2463.1379017343966;2470.4688491974134;2480.8635525046116;2482.094035676983;2503.3366157968153;8667.653293868301;8720.738377848675;8726.781830454225;8730.301575873978;8733.519656418894;5112.846614601568;5223.738813059332;5231.058409486291;5250.343707036621;5256.474352564751;3084.2443601317823;3093.458644737162;3135.263213144909;3167.034054613342;3199.760017998636;1004.0260946881514;1015.7511409704596;1033.8449232615092;1056.487603512296;1068.3643232276784;11753.236039657395;11776.587819426364;11864;11895.643130706007;11902.226355286879;4242.915141697211;4271.786410679453;4304.375865499485;4463.709858859163;4469.396631454777;9544.141027307436;9546.856797148048;9569.952150239204;9598.95200523993;9611;5080.390353157644;5084.237364395371;5102.872428189325;5103.693778373309;5127.692338459704;4125.278076336629;4665.510121437268;4713.811447542129;4722.055588882237;4747.596454301423;3613.4399168128457;3664.8350824212976;3668.9633103669157;3722.441633754904;3737.4954381158195;1031.118393773328;1062.4475272858226;1086.8858769829212;1096.1011970184531;1097.118441872177;1224.797908345113;1239.1264158768047;1254.1597129922973;1498.4156179090164;1498.4231071037511;7853.09689385728;8034.718784842503;8076.717314894068;8087.0295564532635;8174.754757357289;1095.8465814785936;1100.1528822806395;1101.553870682375;1197.7664355450604;1200.6578125234266;6428.067930150102;6457.903131453032;6529.2817790043055;6544.116544266463;6557.442617377576;10239.129673977795;10555.261131720707;10556.049955504042;10567.524461399256;10613.310134841211;9647.517624118766;10400.427976461368;10415.16678665705;10433.478326083665;10514.842277365846;7903.841923161504;8011.559364234907;8012.31895288907;8017.6792928283385;8042.3968202383885;7689;7711.344535714303;7784.610769461391;7798.181190975093;7846.254605812439;9169.266458683423;9279.39683920543;9356.859647105162;9420.152186303265;9624;9486.95256523713;9736.853947190657;9806.166475849634;9831.950840245752;9931.602735890483;6304.810855674337;6913.619750913748;7120.465965052746;7121.287871212838;7364.852702946018;8055.838883222185;8077.87883181741;8078.3133433658795;8105.594720263845;8110.756677299691;7161.4628902831455;7373.889391659022;7413.629318534159;7424.443166762407;7552.471327007276;6956.826079348057;7044;7055.753048643272;7113.146422429341;7206.7117315306805;7580.583067931317;7603.163651998387;7611.314981651678;7621.504602201061;7643.235676432312;6779.830504237433;6818.590884546943;6873.793786186422;6883.139607549057;6883.483738719716;6850.349216824394;6889;6931.44548436134;6946.548474349152;6953.26990665993 09:59:04 INFO - PROCESS | 28793 | |4;prototype.html;358.3388647944542;359.9784012959224;362.94192929131344;368.64057543894705;368.67372375447735;6363.936360636392;6391.904121438182;6407.743690252396;6431.517636177288;6467.288598254188;6310.936890631092;6327.050942358648;6346.079818426326;6350.682465876711;6363.71363288652;4695.295705644146;4795.664303498756;4902.901941961159;4904.239842824368;4907.190313598252;4862.562369386755;4879.341288926003;4880.779805048738;4906.460289368167;4908.141075311824;4845.6123510119105;4849.563539281464;4900.289458028584;4916.434610019858;4918.04098200851;4904;4911.557959783619;4919.286703428019;4924.212126059813;4943.505649435046;4380.6276466500385;4380.67144964129;4386.8025938832825;4388.551777913281;4393.209222339978;5933.851653708649;6050.515958723292;6060.909086363708;6065.181200537915;6072.878542429126;5730.799422020251;5772.422757724236;5778.451047150514;5778.942210577882;5787.218725472049;6696.330366963313;6725.226598941135;6744.7976560703255;6748.865022699519;6764.425023872976;4832.830850920236;4833.371661683958;4835.854924352275;4837.637177211724;4839.05638400512;7072.398846098036;7073.610951397671;7077.504574679774;7078.362947334765;7089.361957423856;4644.767761611906;4812.590929770939;4821.445533763592;4966.329545511309;4993.550580447777;4847.80608775652;4873.074115917964;4877.6585639004925;4878.170710979142;4886.804527818918;5622.072358060956;5633.042382794934;5635.971820140955;5660.066089095253;5661.943380566142;6770.255271920085;6807.353301436356;6815.182178138655;6816.795496135124;6840.384365407137;1704.701677206484;1738.6696527659958;1741.7822772153481;1743.0500377294404;1743.7122874725783;1075.6074032978063;1094.7810437912449;1110.2672236323988;1121.7195701074731;1132.7960967026015;6612.239592446834;6617.04052912325;6620.768273110418;6629.701663425158;6632;6993.125859267591;7000.544964577286;7044.295570442915;7057.082579264663;7060.6116663584;6530.869382612321;6694.765683201064;6732.730690772314;6736.528443008942;6741.52809303344;3808.9428658570146;3859.749116307431;3859.942100868433;3861.67175790061;3868.497095377583;7439.9256007439235;7466.775996720107;7493.138289096823;7513.39892808574;7518.699252029967;7293.817654558678;7304.853902921912;7314.853702925911;7319.780406587811;7324.707011719578;7190.496665233488;7454.962725186339;7510.061242344707;7513.924860751432;7521.774346769496;7125.75059872902;7140.07179066718;7150.284971503016;7156.928430715626;7157.24848890859;7037.190723066708;7040.964795175992;7044.753433629799;7050.823729406806;7055.647217638995;7262.96368518154;7456.067991501062;7483.738069167553;7494.775156745306;7495.850082998419;4828.130936431336;4886.511348865085;4888;4893.510648935078;4902.3872015998;7085.362317391253;7102.893456598052;7117.288271172842;7131.679074441767;7137.678804453916;6800.217974932946;6837.589744615339;6896.379325860697;6898.758543450955;6921.342472465108;6804.96597517029;6868.416184624363;6871.484638652021;6874.450043996369;6889.793306200822;6760.96619516919;6793.490488213502;6794.388505034571;6795.014722865256;6805.183377994672;6892.414144797748;6896.827579310558;6910.343517365842;6936.653167341714;6947.096877405905;6766.8646627068165;6815.454763618799;6851.897221541781;6865;6878.759243426456 09:59:04 INFO - PROCESS | 28793 | |5;yui.html;795.320001398804;799.1808396393694;810.8297257575908;818.67662273402;821.1172989036779;17110.743338849927;17274.91362543187;17410.477685669433;17526;17557.82442175578;15758.448454304102;15781.368745250205;15783.763243551328;15785.526434206964;15789.052656840599;909.686158275394;912.8493798523235;922.0272612393921;923.0907556057278;932.6129656192688;905.6332185464897;912.2382810353363;914.7804526913559;914.8947870994821;916.0610374366295;963.3689933093834;963.9373440726365;964.2237998411276;965.7923546437514;973.6932866147176;958.3148049144895;959.4339339789523;960.3229723045237;962.100436092256;969.3263182088451;706.2231545300128;712.419378206765;713.0587624335878;714.8427345983876;716.2515171645591;15068.246587670572;15112.471063512834;15141.621459463491;15682.451114210948;15688.294026768823;13605.795913061313;13611;13667.316634168252;13699.109557878706;13738;11009.779804403866;11286.830697539543;11469.827952580717;11493.655190344303;11759.412029398582;3693.649103335179;3713.2387860488534;3722.6091260417807;3751.3435148849117;3831.942520862189;53262.46737532652;53496;54182.187267191024;54343;54552.45447545513;9958.751031224132;10703.464826758787;10711.08955738771;10752.0323170915;10896.945515272373;19798.604027919362;19801.10895009728;19817.900910495355;19833.900830496044;19842.801571984382;7436.367908727819;7560.810979725441;7705;7721.03487064117;7722.845543089107;4297.162053399557;4376.627986621173;4387.078713470143;4492.775361231926;4493.168763778646;3353.161709572607;3359.6808303211155;3389.0510657016075;3393.983030084883;3394.8472318745717;633.6958260035117;641.8812519683873;643.1638869469764;644.3009334871716;649.4869053447818;558.8770470496485;564.9915251271152;572.4104172702123;582.1675004743173;604.2024527623495;8231.46495477792;8261.628226729812;8290.585470726439;8323.583820809057;8405.747827565183;558.1906235957796;565.3187908570245;573;574.1645905207912;577.8324285957109;3771.321162190777;3855.094052897567;3872.4772155759174;3986.681065514752;4029.798510074543;60783.6960815202;61039.694801526595;61557.69221153955;62086.689566551875;62218.0667289991;53427.19859202115;55004.72497637566;56183.43816561864;57172.42827571671;60094;45178;48377.758111209216;48639.02721945541;49361.259581106315;49498.50501495083;8338.583070846555;8416;8520.616572254388;8549.401541892257;8870.689525866565;36707.63292367042;37319.25361492809;37662.435063474615;37848;37939.05152371102;42626;42724.35913461363;46027;47553.524464756294;47757;11221.66335009951;11323.263987840764;11345.716357091138;11372.772544549229;11418.942905285421;11720.238184517979;11858.940705296418;12245.265284082983;12277.75444491123;12380.195287306296;10557.788844223227;10580;10584.100351470212;10612.204084693833;10712.250142489951;11234.606788762354;11280;11342.489587968395;11351.54593816238;11494.252873563526;10383.896161038292;10669.626563070255;10676.679699609023;10718.303310284806;11250.156238282325;9431.858522122311;9777.608895644094;9900.504974751379;9972.401655900669;10015.899841001788;9042.005379408129;9085;9174.724758257264;9198.310126740387;9271.536423178679 09:59:04 INFO - PROCESS | 28793 | __end_tp_report 09:59:04 INFO - PROCESS | 28793 | __start_cc_report 09:59:04 INFO - PROCESS | 28793 | _x_x_mozilla_cycle_collect,333 09:59:04 INFO - PROCESS | 28793 | __end_cc_report 09:59:04 INFO - PROCESS | 28793 | __startTimestamp1461085144950__endTimestamp 09:59:04 INFO - PROCESS | 28793 | 09:59:04 INFO - PROCESS | 28793 | ------- Summary: start ------- 09:59:04 INFO - PROCESS | 28793 | Number of tests: 6 09:59:04 INFO - PROCESS | 28793 | 09:59:04 INFO - PROCESS | 28793 | [#0] dojo.html Cycles:165 Average:5551.07 Median:5755.11 stddev:619.68 (10.8%) stddev-sans-first:595.84 09:59:04 INFO - PROCESS | 28793 | Values: 3298.2 3346.5 3359.9 3376.8 3382.1 5504.9 5519.4 5525.4 5531.3 5551.6 5472.5 5484.7 5518.3 5528.3 5535.4 5018.7 5049.8 5106.7 5120.8 5128.2 4996.7 5094.8 5105.4 5114.9 5185.7 5069.2 5077.9 5145.1 5167.4 5201.0 5125.5 5160.5 5163.9 5165.9 5213.5 4873.5 4936.3 5020.0 5075.0 5112.9 5333.5 5342.5 5370.6 5381.8 5390.2 5935.4 5989.3 5997.8 6002.2 6013.4 5879.5 5992.9 6026.9 6079.6 6087.9 5541.0 5551.4 5551.8 5562.8 5566.0 5959.4 6084.6 6085.8 6089.9 6097.1 5862.9 5918.0 5920.3 5934.6 5936.4 5962.7 5973.4 5983.3 5985.2 5990.2 5803.0 5885.5 5937.3 5946.1 5963.9 5945.8 5959.6 5981.3 6002.8 6015.7 4547.8 4567.3 4572.2 4587.3 4598.3 4052.5 4059.0 4074.6 4106.8 4156.4 5546.3 5674.5 5709.3 5749.3 5818.6 5961.9 5978.3 5997.5 6012.0 6022.6 5547.9 5645.7 5712.7 5730.9 5735.9 5103.2 5109.0 5133.8 5135.8 5160.9 6227.6 6228.3 6228.8 6228.9 6242.6 5885.5 5937.7 6001.8 6007.1 6019.5 6215.5 6244.0 6274.7 6282.0 6286.8 5901.7 5930.7 5940.4 5944.8 5945.9 5736.8 5968.5 6005.9 6043.0 6074.0 5835.9 5841.6 5847.8 5858.9 5893.1 5857.6 5869.3 5871.9 5875.8 5875.9 5577.7 5681.9 5727.5 5736.3 5737.2 5828.4 5850.9 5870.8 5893.7 5907.4 5632.2 5754.6 5755.1 5762.9 5784.6 09:59:04 INFO - PROCESS | 28793 | 09:59:04 INFO - PROCESS | 28793 | [#1] ext.html Cycles:180 Average:58208.95 Median:22253.68 stddev:121688.34 (546.8%) stddev-sans-first:121952.74 09:59:04 INFO - PROCESS | 28793 | Values: 561.9 578.2 584.3 589.6 623.8 38185.0 38561.8 38641.0 38782.2 38855.4 43258.1 43861.6 43913.6 43929.3 43951.8 8809.4 8992.6 9001.1 9004.5 9013.2 8822.2 8946.7 8954.6 8958.3 8958.6 9156.5 9255.4 9255.5 9258.1 9292.8 9126.7 9218.1 9221.1 9230.9 9245.3 9035.0 9122.3 9171.2 9174.5 9193.4 42446.8 42868.0 42922.6 42957.8 42981.9 2926.0 3546.9 3615.0 3629.1 3696.1 32064.0 32538.0 32696.2 32711.8 33010.3 4088.0 4177.7 4182.5 4202.1 4234.7 284372.0 289547.0 290711.0 291686.0 292244.0 47703.3 70727.6 71522.3 72194.3 72258.0 47956.8 48195.8 48255.5 48376.8 48393.8 16755.5 16921.8 16997.5 17000.1 17017.1 13415.7 13625.7 13625.9 13666.3 13684.9 15831.9 15955.8 15963.7 16294.8 16329.1 6192.6 6218.5 6222.9 6263.0 6270.1 1022.1 1057.4 1096.9 1176.7 1176.9 29727.0 30562.7 30669.4 30852.1 30872.1 1194.5 1245.2 1269.4 1274.0 1285.9 15491.6 15745.0 16102.5 16150.9 16318.0 354613.0 545489.0 551461.0 838668.0 842365.0 58959.4 59531.4 60071.4 60286.4 60584.4 1436.5 1460.6 1480.2 1484.6 1489.6 27834.0 28671.0 28776.3 28961.7 29192.9 48576.0 48813.8 49303.3 49343.5 49529.8 322975.0 323631.0 325375.0 326283.0 326708.0 33975.5 50435.0 50772.2 51474.2 52037.0 47928.5 48368.8 48569.0 48600.3 48993.5 39546.0 39658.6 39809.0 40391.4 40419.4 38592.4 38733.4 39030.6 39337.2 42521.4 42454.8 42457.8 43084.4 43235.4 43367.3 38057.4 38148.8 38369.2 38992.8 39037.2 29159.6 29171.7 29575.9 29585.6 29886.7 09:59:04 INFO - PROCESS | 28793 | 09:59:04 INFO - PROCESS | 28793 | [#2] jquery.html Cycles:180 Average:28484.41 Median:3218.69 stddev:75768.76 (2354.0%) stddev-sans-first:75951.91 09:59:04 INFO - PROCESS | 28793 | Values: 374.4 375.6 378.3 383.3 384.8 17583.7 18296.8 19405.4 19558.5 19611.9 19232.3 19236.7 19239.1 19276.5 19668.8 6136.6 6391.3 6436.4 6436.5 6442.3 5190.2 6228.1 6619.6 6647.5 6683.2 6464.6 6594.1 6639.5 7017.1 7127.0 6983.4 6984.7 7035.8 7092.1 7096.0 6550.5 6902.8 6903.0 6906.0 6944.4 24089.2 24723.3 24737.8 24861.8 25117.6 2469.1 2491.5 2678.0 2756.7 3178.9 14136.8 15478.0 15648.4 15700.5 15739.9 1962.2 2044.7 2070.6 2091.1 2111.6 80078.0 83648.0 84059.0 84565.6 85154.0 15043.8 15398.2 15401.0 15432.2 15779.0 26831.2 27221.7 27488.2 27643.4 27766.9 9393.9 9457.8 9635.3 9709.6 9722.0 8249.8 8383.8 8452.4 8453.7 8497.6 7760.8 7784.7 7925.4 7927.4 8069.9 2899.7 3025.8 3139.0 3258.4 3353.0 974.9 989.5 1051.5 1057.2 1068.3 17061.4 17340.8 17348.1 17487.7 17758.4 985.2 998.0 1021.6 1029.3 1066.0 8246.4 10073.2 10195.4 10325.8 10400.8 443578.0 452086.0 458881.0 461077.0 488299.0 68593.7 75929.6 84328.0 86306.6 88336.6 1043.9 1068.4 1081.3 1081.6 1084.9 16384.1 16462.6 16549.5 16601.2 16793.9 36149.8 36381.0 37522.0 37785.0 38495.8 51545.2 51744.2 52186.0 52230.2 52239.7 8528.8 8641.5 8657.1 8741.2 8752.2 9881.1 13207.5 13334.2 13631.7 13655.8 11151.3 11360.2 11397.7 11422.7 11554.4 11270.5 11424.9 11663.5 11703.1 11849.6 11351.1 11464.5 11584.2 11826.3 12052.5 8485.2 8551.8 8578.1 8649.2 8807.5 9090.5 11236.7 11669.7 11763.2 11771.8 09:59:04 INFO - PROCESS | 28793 | 09:59:04 INFO - PROCESS | 28793 | [#3] mootools.html Cycles:180 Average:5924.91 Median:5227.40 stddev:3131.70 (59.9%) stddev-sans-first:3123.36 09:59:04 INFO - PROCESS | 28793 | Values: 1567.5 1578.8 1773.0 1867.1 1880.9 8294.6 8340.7 8442.7 8525.8 8573.2 8760.0 8794.7 8882.5 8906.9 8923.4 2435.2 2456.0 2484.6 2486.7 2497.7 2432.8 2489.7 2512.1 2515.9 2517.1 2405.2 2435.7 2482.3 2487.0 2489.8 2420.6 2439.4 2453.1 2479.0 2490.2 2463.1 2470.5 2480.9 2482.1 2503.3 8667.7 8720.7 8726.8 8730.3 8733.5 5112.8 5223.7 5231.1 5250.3 5256.5 3084.2 3093.5 3135.3 3167.0 3199.8 1004.0 1015.8 1033.8 1056.5 1068.4 11753.2 11776.6 11864.0 11895.6 11902.2 4242.9 4271.8 4304.4 4463.7 4469.4 9544.1 9546.9 9570.0 9599.0 9611.0 5080.4 5084.2 5102.9 5103.7 5127.7 4125.3 4665.5 4713.8 4722.1 4747.6 3613.4 3664.8 3669.0 3722.4 3737.5 1031.1 1062.4 1086.9 1096.1 1097.1 1224.8 1239.1 1254.2 1498.4 1498.4 7853.1 8034.7 8076.7 8087.0 8174.8 1095.8 1100.2 1101.6 1197.8 1200.7 6428.1 6457.9 6529.3 6544.1 6557.4 10239.1 10555.3 10556.0 10567.5 10613.3 9647.5 10400.4 10415.2 10433.5 10514.8 7903.8 8011.6 8012.3 8017.7 8042.4 7689.0 7711.3 7784.6 7798.2 7846.3 9169.3 9279.4 9356.9 9420.2 9624.0 9487.0 9736.9 9806.2 9832.0 9931.6 6304.8 6913.6 7120.5 7121.3 7364.9 8055.8 8077.9 8078.3 8105.6 8110.8 7161.5 7373.9 7413.6 7424.4 7552.5 6956.8 7044.0 7055.8 7113.1 7206.7 7580.6 7603.2 7611.3 7621.5 7643.2 6779.8 6818.6 6873.8 6883.1 6883.5 6850.3 6889.0 6931.4 6946.5 6953.3 09:59:04 INFO - PROCESS | 28793 | 09:59:04 INFO - PROCESS | 28793 | [#4] prototype.html Cycles:180 Average:5745.45 Median:6571.55 stddev:1746.43 (26.6%) stddev-sans-first:1703.88 09:59:04 INFO - PROCESS | 28793 | Values: 358.3 360.0 362.9 368.6 368.7 6363.9 6391.9 6407.7 6431.5 6467.3 6310.9 6327.1 6346.1 6350.7 6363.7 4695.3 4795.7 4902.9 4904.2 4907.2 4862.6 4879.3 4880.8 4906.5 4908.1 4845.6 4849.6 4900.3 4916.4 4918.0 4904.0 4911.6 4919.3 4924.2 4943.5 4380.6 4380.7 4386.8 4388.6 4393.2 5933.9 6050.5 6060.9 6065.2 6072.9 5730.8 5772.4 5778.5 5778.9 5787.2 6696.3 6725.2 6744.8 6748.9 6764.4 4832.8 4833.4 4835.9 4837.6 4839.1 7072.4 7073.6 7077.5 7078.4 7089.4 4644.8 4812.6 4821.4 4966.3 4993.6 4847.8 4873.1 4877.7 4878.2 4886.8 5622.1 5633.0 5636.0 5660.1 5661.9 6770.3 6807.4 6815.2 6816.8 6840.4 1704.7 1738.7 1741.8 1743.1 1743.7 1075.6 1094.8 1110.3 1121.7 1132.8 6612.2 6617.0 6620.8 6629.7 6632.0 6993.1 7000.5 7044.3 7057.1 7060.6 6530.9 6694.8 6732.7 6736.5 6741.5 3808.9 3859.7 3859.9 3861.7 3868.5 7439.9 7466.8 7493.1 7513.4 7518.7 7293.8 7304.9 7314.9 7319.8 7324.7 7190.5 7455.0 7510.1 7513.9 7521.8 7125.8 7140.1 7150.3 7156.9 7157.2 7037.2 7041.0 7044.8 7050.8 7055.6 7263.0 7456.1 7483.7 7494.8 7495.9 4828.1 4886.5 4888.0 4893.5 4902.4 7085.4 7102.9 7117.3 7131.7 7137.7 6800.2 6837.6 6896.4 6898.8 6921.3 6805.0 6868.4 6871.5 6874.5 6889.8 6761.0 6793.5 6794.4 6795.0 6805.2 6892.4 6896.8 6910.3 6936.7 6947.1 6766.9 6815.5 6851.9 6865.0 6878.8 09:59:04 INFO - PROCESS | 28793 | 09:59:04 INFO - PROCESS | 28793 | [#5] yui.html Cycles:180 Average:14693.94 Median:48067.38 stddev:17199.15 (35.8%) stddev-sans-first:17215.73 09:59:04 INFO - PROCESS | 28793 | Values: 795.3 799.2 810.8 818.7 821.1 17110.7 17274.9 17410.5 17526.0 17557.8 15758.4 15781.4 15783.8 15785.5 15789.1 909.7 912.8 922.0 923.1 932.6 905.6 912.2 914.8 914.9 916.1 963.4 963.9 964.2 965.8 973.7 958.3 959.4 960.3 962.1 969.3 706.2 712.4 713.1 714.8 716.3 15068.2 15112.5 15141.6 15682.5 15688.3 13605.8 13611.0 13667.3 13699.1 13738.0 11009.8 11286.8 11469.8 11493.7 11759.4 3693.6 3713.2 3722.6 3751.3 3831.9 53262.5 53496.0 54182.2 54343.0 54552.5 9958.8 10703.5 10711.1 10752.0 10896.9 19798.6 19801.1 19817.9 19833.9 19842.8 7436.4 7560.8 7705.0 7721.0 7722.8 4297.2 4376.6 4387.1 4492.8 4493.2 3353.2 3359.7 3389.1 3394.0 3394.8 633.7 641.9 643.2 644.3 649.5 558.9 565.0 572.4 582.2 604.2 8231.5 8261.6 8290.6 8323.6 8405.7 558.2 565.3 573.0 574.2 577.8 3771.3 3855.1 3872.5 3986.7 4029.8 60783.7 61039.7 61557.7 62086.7 62218.1 53427.2 55004.7 56183.4 57172.4 60094.0 45178.0 48377.8 48639.0 49361.3 49498.5 8338.6 8416.0 8520.6 8549.4 8870.7 36707.6 37319.3 37662.4 37848.0 37939.1 42626.0 42724.4 46027.0 47553.5 47757.0 11221.7 11323.3 11345.7 11372.8 11418.9 11720.2 11858.9 12245.3 12277.8 12380.2 10557.8 10580.0 10584.1 10612.2 10712.3 11234.6 11280.0 11342.5 11351.5 11494.3 10383.9 10669.6 10676.7 10718.3 11250.2 9431.9 9777.6 9900.5 9972.4 10015.9 9042.0 9085.0 9174.7 9198.3 9271.5 09:59:04 INFO - PROCESS | 28793 | -------- Summary: end -------- 09:59:04 INFO - PROCESS | 28793 | 09:59:05 INFO - TEST-INFO | 28793: exit 0 09:59:05 INFO - TEST-OK | dromaeo_css | took 1109867ms 09:59:05 INFO - TEST-START | kraken 09:59:05 INFO - operating with platform_type : linux_ 09:59:05 INFO - Initialising browser for kraken test... 09:59:05 INFO - TEST-INFO | started process 29037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp93zEBL/profile http://localhost:49693/getInfo.html) 09:59:09 INFO - PROCESS | 29037 | 09:59:09 INFO - PROCESS | 29037 | (process:29114): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:59:10 INFO - PROCESS | 29037 | __metrics Screen width/height:1600/1200 09:59:10 INFO - PROCESS | 29037 | colorDepth:24 09:59:10 INFO - PROCESS | 29037 | Browser inner width/height: 1024/697 09:59:10 INFO - PROCESS | 29037 | __metrics 09:59:11 ERROR - PROCESS | 29037 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:59:11 INFO - TEST-INFO | 29037: exit 0 09:59:11 INFO - Browser initialized. 09:59:11 INFO - Running cycle 1/1 for kraken test... 09:59:11 INFO - TEST-INFO | started process 29165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp93zEBL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:13 INFO - PROCESS | 29165 | 09:59:13 INFO - PROCESS | 29165 | (process:29234): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:59:23 INFO - PROCESS | 29165 | RSS: Main: 151654400 09:59:23 INFO - PROCESS | 29165 | 09:59:26 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49693/tests/kraken/driver.html?testName=audio-beat-detection) 09:59:26 INFO - PROCESS | 29165 | RSS: Main: 156016640 09:59:26 INFO - PROCESS | 29165 | 09:59:29 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49693/tests/kraken/driver.html?testName=audio-dft) 09:59:30 INFO - PROCESS | 29165 | RSS: Main: 156221440 09:59:30 INFO - PROCESS | 29165 | 09:59:32 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49693/tests/kraken/driver.html?testName=audio-fft) 09:59:33 INFO - PROCESS | 29165 | RSS: Main: 156672000 09:59:33 INFO - PROCESS | 29165 | 09:59:35 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49693/tests/kraken/driver.html?testName=audio-oscillator) 09:59:36 INFO - PROCESS | 29165 | RSS: Main: 156848128 09:59:36 INFO - PROCESS | 29165 | 09:59:38 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49693/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:59:39 INFO - PROCESS | 29165 | RSS: Main: 156512256 09:59:39 INFO - PROCESS | 29165 | 09:59:42 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49693/tests/kraken/driver.html?testName=imaging-darkroom) 09:59:42 INFO - PROCESS | 29165 | RSS: Main: 156786688 09:59:42 INFO - PROCESS | 29165 | 09:59:46 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49693/tests/kraken/driver.html?testName=imaging-desaturate) 09:59:46 INFO - PROCESS | 29165 | RSS: Main: 157032448 09:59:46 INFO - PROCESS | 29165 | 09:59:49 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49693/tests/kraken/driver.html?testName=json-parse-financial) 09:59:50 INFO - PROCESS | 29165 | RSS: Main: 156930048 09:59:50 INFO - PROCESS | 29165 | 09:59:51 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49693/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:59:52 INFO - PROCESS | 29165 | RSS: Main: 157151232 09:59:52 INFO - PROCESS | 29165 | 09:59:54 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49693/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:59:54 INFO - PROCESS | 29165 | RSS: Main: 157368320 09:59:54 INFO - PROCESS | 29165 | 09:59:56 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49693/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:57 INFO - PROCESS | 29165 | RSS: Main: 157306880 09:59:57 INFO - PROCESS | 29165 | 09:59:59 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:00:00 INFO - PROCESS | 29165 | RSS: Main: 157548544 10:00:00 INFO - PROCESS | 29165 | 10:00:02 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:00:03 INFO - PROCESS | 29165 | RSS: Main: 157765632 10:00:03 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:49693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49693/tests/kraken/driver.html?testName=ai-astar) 10:00:05 INFO - PROCESS | 29165 | RSS: Main: 159379456 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | __start_tp_report 10:00:05 INFO - PROCESS | 29165 | _x_x_mozilla_page_load 10:00:05 INFO - PROCESS | 29165 | _x_x_mozilla_page_load_details 10:00:05 INFO - PROCESS | 29165 | |i|pagename|runs| 10:00:05 INFO - PROCESS | 29165 | |0;ai-astar;111;104;112;111;111;120;110;113;110;111 10:00:05 INFO - PROCESS | 29165 | |1;audio-beat-detection;163;126;154;167;127;160;150;133;164;128 10:00:05 INFO - PROCESS | 29165 | |2;audio-dft;163;163;163;163;163;163;163;166;167;163 10:00:05 INFO - PROCESS | 29165 | |3;audio-fft;74;77;75;168;74;76;75;77;164;77 10:00:05 INFO - PROCESS | 29165 | |4;audio-oscillator;94;94;144;93;95;94;140;94;93;138 10:00:05 INFO - PROCESS | 29165 | |5;imaging-gaussian-blur;119;118;117;118;117;118;117;117;117;117 10:00:05 INFO - PROCESS | 29165 | |6;imaging-darkroom;147;148;147;147;148;147;147;146;148;148 10:00:05 INFO - PROCESS | 29165 | |7;imaging-desaturate;99;96;97;96;96;96;96;96;96;97 10:00:05 INFO - PROCESS | 29165 | |8;json-parse-financial;56;57;56;55;59;56;56;62;55;52 10:00:05 INFO - PROCESS | 29165 | |9;json-stringify-tinderbox;66;65;65;65;66;66;65;66;65;65 10:00:05 INFO - PROCESS | 29165 | |10;stanford-crypto-aes;79;88;82;89;80;81;83;81;81;82 10:00:05 INFO - PROCESS | 29165 | |11;stanford-crypto-ccm;113;113;124;113;113;118;119;116;121;122 10:00:05 INFO - PROCESS | 29165 | |12;stanford-crypto-pbkdf2;136;153;147;162;151;152;151;148;149;151 10:00:05 INFO - PROCESS | 29165 | |13;stanford-crypto-sha256-iterative;68;68;68;69;70;65;69;72;67;67 10:00:05 INFO - PROCESS | 29165 | __end_tp_report 10:00:05 INFO - PROCESS | 29165 | __start_cc_report 10:00:05 INFO - PROCESS | 29165 | _x_x_mozilla_cycle_collect,824 10:00:05 INFO - PROCESS | 29165 | __end_cc_report 10:00:05 INFO - PROCESS | 29165 | __startTimestamp1461085205471__endTimestamp 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | ------- Summary: start ------- 10:00:05 INFO - PROCESS | 29165 | Number of tests: 14 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:4.12 10:00:05 INFO - PROCESS | 29165 | Values: 111.0 104.0 112.0 111.0 111.0 120.0 110.0 113.0 110.0 111.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:157.00 stddev:16.90 (10.8%) stddev-sans-first:16.93 10:00:05 INFO - PROCESS | 29165 | Values: 163.0 126.0 154.0 167.0 127.0 160.0 150.0 133.0 164.0 128.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 10:00:05 INFO - PROCESS | 29165 | Values: 163.0 163.0 163.0 163.0 163.0 163.0 163.0 166.0 167.0 163.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.50 stddev:38.13 (50.5%) stddev-sans-first:39.78 10:00:05 INFO - PROCESS | 29165 | Values: 74.0 77.0 75.0 168.0 74.0 76.0 75.0 77.0 164.0 77.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:94.00 stddev:22.66 (24.1%) stddev-sans-first:23.47 10:00:05 INFO - PROCESS | 29165 | Values: 94.0 94.0 144.0 93.0 95.0 94.0 140.0 94.0 93.0 138.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 10:00:05 INFO - PROCESS | 29165 | Values: 119.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:00:05 INFO - PROCESS | 29165 | Values: 147.0 148.0 147.0 147.0 148.0 147.0 147.0 146.0 148.0 148.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:0.44 10:00:05 INFO - PROCESS | 29165 | Values: 99.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:2.63 (4.7%) stddev-sans-first:2.79 10:00:05 INFO - PROCESS | 29165 | Values: 56.0 57.0 56.0 55.0 59.0 56.0 56.0 62.0 55.0 52.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 10:00:05 INFO - PROCESS | 29165 | Values: 66.0 65.0 65.0 65.0 66.0 66.0 65.0 66.0 65.0 65.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:3.31 (4.0%) stddev-sans-first:3.24 10:00:05 INFO - PROCESS | 29165 | Values: 79.0 88.0 82.0 89.0 80.0 81.0 83.0 81.0 81.0 82.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:118.50 stddev:4.21 (3.6%) stddev-sans-first:4.18 10:00:05 INFO - PROCESS | 29165 | Values: 113.0 113.0 124.0 113.0 113.0 118.0 119.0 116.0 121.0 122.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:151.00 stddev:6.41 (4.2%) stddev-sans-first:4.36 10:00:05 INFO - PROCESS | 29165 | Values: 136.0 153.0 147.0 162.0 151.0 152.0 151.0 148.0 149.0 151.0 10:00:05 INFO - PROCESS | 29165 | 10:00:05 INFO - PROCESS | 29165 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.89 (2.8%) stddev-sans-first:2.00 10:00:05 INFO - PROCESS | 29165 | Values: 68.0 68.0 68.0 69.0 70.0 65.0 69.0 72.0 67.0 67.0 10:00:05 INFO - PROCESS | 29165 | -------- Summary: end -------- 10:00:05 INFO - PROCESS | 29165 | 10:00:06 INFO - TEST-INFO | 29165: exit 0 10:00:06 INFO - TEST-OK | kraken | took 60688ms 10:00:06 INFO - SUITE-END | took 1170s 10:00:06 INFO - Completed test suite (00:19:30) 10:00:06 INFO - javascript benchmark 10:00:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3298.191942973972, 3346.514755360472, 3359.8824041158564, 3376.797392156471, 3382.0868365541305, 5504.889902201953, 5519.39286678465, 5525.4474552544725, 5531.336239651242, 5551.555875529958, 5472.480114389126, 5484.670919744818, 5518.310211223597, 5528.308961379827, 5535.446455354472, 5018.749062546876, 5049.798008079672, 5106.719130447824, 5120.795168193268, 5128.205128205134, 4996.650234483587, 5094.79620815167, 5105.361829771278, 5114.923276150861, 5185.714785686786, 5069.214271787879, 5077.873053173664, 5145.099607568679, 5167.4057483389515, 5200.973995130038, 5125.487451254882, 5160.509751573613, 5163.922541161885, 5165.948340516622, 5213.478652134794, 4873.488283730228, 4936.308916751657, 5020.046191223656, 5075.0, 5112.923306150411, 5333.546648534879, 5342.492463215988, 5370.570354371641, 5381.784728610851, 5390.245365648812, 5935.376785437553, 5989.251343582052, 5997.760089596411, 6002.159697642333, 6013.428724271187, 5879.52963762898, 5992.940070599282, 6026.939730602681, 6079.635221886701, 6087.939120608826, 5541.030319694038, 5551.444855514456, 5551.7779288828, 5562.805301814457, 5565.972170139164, 5959.374265702038, 6084.6349219047, 6085.847853803691, 6089.939100609025, 6097.115918191837, 5862.8534286642325, 5917.970410147922, 5920.348761636216, 5934.584579079509, 5936.376680448577, 5962.672053037125, 5973.37279585646, 5983.311919129269, 5985.16207730918, 5990.191324171181, 5803.0, 5885.499732522698, 5937.346891841894, 5946.137810017523, 5963.850903727354, 5945.791897283574, 5959.582829201914, 5981.252343457068, 6002.759889604455, 6015.699215039231, 4547.772611369484, 4567.314902764546, 4572.222722137245, 4587.266037433995, 4598.333241679938, 4052.49343832021, 4058.9594104059174, 4074.5721699221153, 4106.7946602669745, 4156.43888075112, 5546.334439867242, 5674.517665998436, 5709.3434255060365, 5749.252597162342, 5818.5636077294375, 5961.910571341434, 5978.28260608721, 5997.520198384119, 6012.0, 6022.5784195105925, 5547.944520554824, 5645.717714114277, 5712.742926568314, 5730.942690573041, 5735.8566035849435, 5103.18349064148, 5108.9744551277745, 5133.768980395891, 5135.845924622267, 5160.92258616121, 6227.595206311666, 6228.34602366745, 6228.813135605848, 6228.937710622836, 6242.5942313749465, 5885.47030767233, 5937.673427961504, 6001.819945401645, 6007.06890431975, 6019.458248757633, 6215.502759779117, 6243.968780156252, 6274.6548939808745, 6282.026285925689, 6286.779962701284, 5901.675407852609, 5930.733117009659, 5940.435658612425, 5944.762209511571, 5945.940540594712, 5736.799212027559, 5968.462838344396, 6005.90991135142, 6042.969785151046, 6074.0, 5835.94164058354, 5841.649501029951, 5847.795327163529, 5858.94141058584, 5893.086571581412, 5857.619254748428, 5869.295684517885, 5871.853203669943, 5875.823725288248, 5875.94124058771, 5577.665340079446, 5681.943180568307, 5727.4845263926445, 5736.340320862987, 5737.225474560881, 5828.358880523224, 5850.853728656818, 5870.7945221917025, 5893.675847828239, 5907.3797251288, 5632.239647647515, 5754.597178197653, 5755.107958266475, 5762.942370576408, 5784.566157538286], "unit": "score", "name": "dojo.html", "value": 5510.707852747927}, {"lowerIsBetter": false, "replicates": [561.9325680918289, 578.1934201788504, 584.3075954993333, 589.6079107393583, 623.7816764132551, 38185.045373865665, 38561.807190964006, 38641.0, 38782.22435551291, 38855.41716874249, 43258.13483730331, 43861.56138438615, 43913.560864391424, 43929.34105988405, 43951.78024109875, 8809.427387219826, 8992.595333210022, 9001.099890011012, 9004.459732416077, 9013.188813006827, 8822.161894620032, 8946.731598052036, 8954.552272386387, 8958.328125390623, 8958.552072396387, 9156.496392698398, 9255.398399104037, 9255.53722313885, 9258.120478554527, 9292.814143717122, 9126.680566180185, 9218.124278193627, 9221.123993220634, 9230.86153707695, 9245.260379169684, 9035.0, 9122.315826313054, 9171.220446262008, 9174.495402752846, 9193.448393096369, 42446.78776606128, 42868.0, 42922.57077429248, 42957.78521107406, 42981.925451863644, 2925.985370073136, 3546.9238868457333, 3614.981925090358, 3629.074585980558, 3696.075981004749, 32064.0, 32538.0, 32696.182595435304, 32711.836440817882, 33010.33979320424, 4087.9591204088174, 4177.6866734995, 4182.519010313822, 4202.117555313388, 4234.724742891703, 284372.0, 289547.0, 290710.9999999979, 291686.0, 292244.0, 47703.28445073327, 70727.64636176787, 71522.2847771526, 72194.27805721981, 72258.0, 47956.760216198694, 48195.75902120467, 48255.517444825804, 48376.758116209894, 48393.75803120962, 16755.497335079966, 16921.830781692024, 16997.49007529776, 17000.149992500326, 17017.064061476736, 13415.664608384674, 13625.659358516117, 13625.931870340584, 13666.316684165751, 13684.93157534206, 15831.920840395724, 15955.760663590056, 15963.680726385408, 16294.837051629569, 16329.10189939541, 6192.566520343533, 6218.471429928416, 6222.937770622236, 6262.968685156545, 6270.122182894398, 1022.1107636356418, 1057.4025675493322, 1096.9451527423596, 1176.7117056321256, 1176.8587769467547, 29727.0, 30562.694373055983, 30669.386612268077, 30852.074437766903, 30872.0738377849, 1194.474431250247, 1245.1844042152404, 1269.3906924676207, 1273.9554115605908, 1285.8585555588877, 15491.612709682122, 15745.0, 16102.516924492284, 16150.919245403698, 16318.0, 354613.0, 545489.0, 551461.0, 838668.0, 842365.0, 58959.41040589539, 59531.40468595345, 60071.39928600658, 60286.39713602808, 60584.394156058755, 1436.4685066525453, 1460.627539977299, 1480.208088672555, 1484.5917372722372, 1489.5605796289904, 27834.0, 28671.0, 28776.280592985342, 28961.7103828959, 29192.854035729684, 48576.0, 48813.75593122012, 49303.26045109398, 49343.506564933894, 49529.752351238014, 322975.0, 323631.0, 325375.0, 326283.0, 326708.0, 33975.49036764401, 50435.0, 50772.23841642452, 51474.22788658248, 52037.0, 47928.52071479241, 48368.75815620899, 48569.0, 48600.270995935796, 48993.510064898896, 39546.0, 39658.60341396549, 39809.0, 40391.3941290875, 40419.39370909498, 38592.42111368276, 38733.418998715606, 39030.6096939027, 39337.213255734154, 42521.36217956795, 42454.78772606241, 42457.787711061246, 43084.35373469463, 43235.35146972735, 43367.34948975705, 38057.42913856239, 38148.80925595354, 38369.2326153481, 38992.80503597464, 39037.219255615295, 29159.562606560496, 29171.708282916898, 29575.924622136696, 29585.556216657198, 29886.701132988394], "unit": "score", "name": "ext.html", "value": 20105.644718457268}, {"lowerIsBetter": false, "replicates": [374.3990894614144, 375.6337570868404, 378.2963687541173, 383.2947376826638, 384.76144790230063, 17583.736243956337, 18296.817031829676, 19405.41783746486, 19558.51103722406, 19611.901940490312, 19232.326868559605, 19236.71144932827, 19239.134238959246, 19276.518087047833, 19668.803311966876, 6136.570440069186, 6391.328910464404, 6436.420722135007, 6436.549441539094, 6442.259140198867, 5190.2474141249495, 6228.096925945735, 6619.569727967691, 6647.50143739219, 6683.231428385725, 6464.644444555547, 6594.109795177637, 6639.535232533724, 7017.087778588776, 7126.964365178193, 6983.3714965653335, 6984.650767461607, 7035.824104397379, 7092.148942126952, 7095.964520177392, 6550.541462097655, 6902.827429314257, 6903.033575299462, 6905.965470172668, 6944.4097251733665, 24089.156879509133, 24723.25830225096, 24737.752622473727, 24861.751382486123, 25117.62323565148, 2469.1111199967995, 2491.476789874129, 2677.9866100669565, 2756.6554180727408, 3178.9350567559895, 14136.787948180785, 15478.0, 15648.374065037386, 15700.528984130495, 15739.92130039354, 1962.1562728026943, 2044.7137400763756, 2070.554830711389, 2091.1008266445424, 2111.6199084164846, 80078.0, 83648.0, 84059.0, 84565.57717211374, 85154.0, 15043.774343384857, 15398.230088495531, 15401.0, 15432.22838858075, 15779.0, 26831.195064147716, 27221.727782722315, 27488.17535473939, 27643.44713105767, 27766.8893244272, 9393.90606093944, 9457.810843783085, 9635.325527213028, 9709.563069661883, 9721.951390243003, 8249.79375515605, 8383.790405239795, 8452.408331416866, 8453.661853525913, 8497.575121243914, 7760.758278675385, 7784.688612455551, 7925.365970722329, 7927.445078844426, 8069.878951815727, 2899.666538348075, 3025.7579393648894, 3138.9686103139134, 3258.4381865388646, 3352.966470335314, 974.91713204377, 989.5497548615363, 1051.4900273367412, 1057.2123767793043, 1068.3322923173016, 17061.40285090016, 17340.826591734174, 17348.132593370534, 17487.650246995243, 17758.37845675421, 985.2069084387138, 997.9870431512021, 1021.5913634546092, 1029.325791606499, 1065.9979619157966, 8246.3815213858, 10073.194144468425, 10195.439250841275, 10325.84511232332, 10400.843987340197, 443578.0, 452086.0, 458881.0, 461077.0, 488299.0, 68593.65703171452, 75929.62035189789, 84328.0, 86306.56846715852, 88336.55831720801, 1043.89561043895, 1068.4070340960686, 1081.3457857995957, 1081.588996181446, 1084.8589683341115, 16384.098874562012, 16462.588435288733, 16549.50351489457, 16601.169941502634, 16793.91603041977, 36149.81925090358, 36381.0, 37522.0, 37785.0, 38495.80752096222, 51545.22682159695, 51744.22383664173, 52186.0, 52230.21654675259, 52239.73880130575, 8528.786780330292, 8641.481511109354, 8657.091005444337, 8741.213290803604, 8752.168543988311, 9881.145192235701, 13207.471701132232, 13334.19994800315, 13631.727365452834, 13655.795163072364, 11151.275167114112, 11360.204785664924, 11397.658070257905, 11422.714432139262, 11554.422278885853, 11270.478485404365, 11424.885751142383, 11663.475143618387, 11703.122265829927, 11849.637291711564, 11351.14866385008, 11464.541418343173, 11584.247023943417, 11826.34955077479, 12052.51789928393, 8485.236328730443, 8551.786205344915, 8578.099299573705, 8649.221570058726, 8807.471551706918, 9090.545472726206, 11236.66290011301, 11669.708257293636, 11763.235389699643, 11771.823422648838], "unit": "score", "name": "jquery.html", "value": 10001.506848536568}, {"lowerIsBetter": false, "replicates": [1567.4592265668343, 1578.7631855221719, 1773.0, 1867.0851282871397, 1880.8965506897123, 8294.585270736454, 8340.708075217368, 8442.704505342313, 8525.786855328612, 8573.185547372997, 8760.0, 8794.6921857735, 8882.467051976886, 8906.866397004034, 8923.375363724526, 2435.1720415058876, 2455.9807679812902, 2484.62730590412, 2486.651868738378, 2497.7127630322566, 2432.8297019208662, 2489.676342075528, 2512.0705339024585, 2515.8993640254366, 2517.0812653381568, 2405.1581946318825, 2435.6833611630464, 2482.329770961839, 2487.0, 2489.8381605195696, 2420.552197843396, 2439.353571303606, 2453.116877923946, 2478.962815557768, 2490.1533478617175, 2463.1379017343966, 2470.4688491974134, 2480.8635525046116, 2482.094035676983, 2503.3366157968153, 8667.653293868301, 8720.738377848675, 8726.781830454225, 8730.301575873978, 8733.519656418894, 5112.846614601568, 5223.738813059332, 5231.058409486291, 5250.343707036621, 5256.474352564751, 3084.2443601317823, 3093.458644737162, 3135.263213144909, 3167.034054613342, 3199.760017998636, 1004.0260946881514, 1015.7511409704596, 1033.8449232615092, 1056.487603512296, 1068.3643232276784, 11753.236039657395, 11776.587819426364, 11864.0, 11895.643130706007, 11902.226355286879, 4242.915141697211, 4271.786410679453, 4304.375865499485, 4463.709858859163, 4469.396631454777, 9544.141027307436, 9546.856797148048, 9569.952150239204, 9598.95200523993, 9611.0, 5080.390353157644, 5084.237364395371, 5102.872428189325, 5103.693778373309, 5127.692338459704, 4125.278076336629, 4665.510121437268, 4713.811447542129, 4722.055588882237, 4747.596454301423, 3613.4399168128457, 3664.8350824212976, 3668.9633103669157, 3722.441633754904, 3737.4954381158195, 1031.118393773328, 1062.4475272858226, 1086.8858769829212, 1096.1011970184531, 1097.118441872177, 1224.797908345113, 1239.1264158768047, 1254.1597129922973, 1498.4156179090164, 1498.4231071037511, 7853.09689385728, 8034.718784842503, 8076.717314894068, 8087.0295564532635, 8174.754757357289, 1095.8465814785936, 1100.1528822806395, 1101.553870682375, 1197.7664355450604, 1200.6578125234266, 6428.067930150102, 6457.903131453032, 6529.2817790043055, 6544.116544266463, 6557.442617377576, 10239.129673977795, 10555.261131720707, 10556.049955504042, 10567.524461399256, 10613.310134841211, 9647.517624118766, 10400.427976461368, 10415.16678665705, 10433.478326083665, 10514.842277365846, 7903.841923161504, 8011.559364234907, 8012.31895288907, 8017.6792928283385, 8042.3968202383885, 7689.0, 7711.344535714303, 7784.610769461391, 7798.181190975093, 7846.254605812439, 9169.266458683423, 9279.39683920543, 9356.859647105162, 9420.152186303265, 9624.0, 9486.95256523713, 9736.853947190657, 9806.166475849634, 9831.950840245752, 9931.602735890483, 6304.810855674337, 6913.619750913748, 7120.465965052746, 7121.287871212838, 7364.852702946018, 8055.838883222185, 8077.87883181741, 8078.3133433658795, 8105.594720263845, 8110.756677299691, 7161.4628902831455, 7373.889391659022, 7413.629318534159, 7424.443166762407, 7552.471327007276, 6956.826079348057, 7044.0, 7055.753048643272, 7113.146422429341, 7206.7117315306805, 7580.583067931317, 7603.163651998387, 7611.314981651678, 7621.504602201061, 7643.235676432312, 6779.830504237433, 6818.590884546943, 6873.793786186422, 6883.139607549057, 6883.483738719716, 6850.349216824394, 6889.0, 6931.44548436134, 6946.548474349152, 6953.26990665993], "unit": "score", "name": "mootools.html", "value": 4830.799607187869}, {"lowerIsBetter": false, "replicates": [358.3388647944542, 359.9784012959224, 362.94192929131344, 368.64057543894705, 368.67372375447735, 6363.936360636392, 6391.904121438182, 6407.743690252396, 6431.517636177288, 6467.288598254188, 6310.936890631092, 6327.050942358648, 6346.079818426326, 6350.682465876711, 6363.71363288652, 4695.295705644146, 4795.664303498756, 4902.901941961159, 4904.239842824368, 4907.190313598252, 4862.562369386755, 4879.341288926003, 4880.779805048738, 4906.460289368167, 4908.141075311824, 4845.6123510119105, 4849.563539281464, 4900.289458028584, 4916.434610019858, 4918.04098200851, 4904.0, 4911.557959783619, 4919.286703428019, 4924.212126059813, 4943.505649435046, 4380.6276466500385, 4380.67144964129, 4386.8025938832825, 4388.551777913281, 4393.209222339978, 5933.851653708649, 6050.515958723292, 6060.909086363708, 6065.181200537915, 6072.878542429126, 5730.799422020251, 5772.422757724236, 5778.451047150514, 5778.942210577882, 5787.218725472049, 6696.330366963313, 6725.226598941135, 6744.7976560703255, 6748.865022699519, 6764.425023872976, 4832.830850920236, 4833.371661683958, 4835.854924352275, 4837.637177211724, 4839.05638400512, 7072.398846098036, 7073.610951397671, 7077.504574679774, 7078.362947334765, 7089.361957423856, 4644.767761611906, 4812.590929770939, 4821.445533763592, 4966.329545511309, 4993.550580447777, 4847.80608775652, 4873.074115917964, 4877.6585639004925, 4878.170710979142, 4886.804527818918, 5622.072358060956, 5633.042382794934, 5635.971820140955, 5660.066089095253, 5661.943380566142, 6770.255271920085, 6807.353301436356, 6815.182178138655, 6816.795496135124, 6840.384365407137, 1704.701677206484, 1738.6696527659958, 1741.7822772153481, 1743.0500377294404, 1743.7122874725783, 1075.6074032978063, 1094.7810437912449, 1110.2672236323988, 1121.7195701074731, 1132.7960967026015, 6612.239592446834, 6617.04052912325, 6620.768273110418, 6629.701663425158, 6632.0, 6993.125859267591, 7000.544964577286, 7044.295570442915, 7057.082579264663, 7060.6116663584, 6530.869382612321, 6694.765683201064, 6732.730690772314, 6736.528443008942, 6741.52809303344, 3808.9428658570146, 3859.749116307431, 3859.942100868433, 3861.67175790061, 3868.497095377583, 7439.9256007439235, 7466.775996720107, 7493.138289096823, 7513.39892808574, 7518.699252029967, 7293.817654558678, 7304.853902921912, 7314.853702925911, 7319.780406587811, 7324.707011719578, 7190.496665233488, 7454.962725186339, 7510.061242344707, 7513.924860751432, 7521.774346769496, 7125.75059872902, 7140.07179066718, 7150.284971503016, 7156.928430715626, 7157.24848890859, 7037.190723066708, 7040.964795175992, 7044.753433629799, 7050.823729406806, 7055.647217638995, 7262.96368518154, 7456.067991501062, 7483.738069167553, 7494.775156745306, 7495.850082998419, 4828.130936431336, 4886.511348865085, 4888.0, 4893.510648935078, 4902.3872015998, 7085.362317391253, 7102.893456598052, 7117.288271172842, 7131.679074441767, 7137.678804453916, 6800.217974932946, 6837.589744615339, 6896.379325860697, 6898.758543450955, 6921.342472465108, 6804.96597517029, 6868.416184624363, 6871.484638652021, 6874.450043996369, 6889.793306200822, 6760.96619516919, 6793.490488213502, 6794.388505034571, 6795.014722865256, 6805.183377994672, 6892.414144797748, 6896.827579310558, 6910.343517365842, 6936.653167341714, 6947.096877405905, 6766.8646627068165, 6815.454763618799, 6851.897221541781, 6865.0, 6878.759243426456], "unit": "score", "name": "prototype.html", "value": 5173.698275006313}, {"lowerIsBetter": false, "replicates": [795.320001398804, 799.1808396393694, 810.8297257575908, 818.67662273402, 821.1172989036779, 17110.743338849927, 17274.91362543187, 17410.477685669433, 17526.0, 17557.82442175578, 15758.448454304102, 15781.368745250205, 15783.763243551328, 15785.526434206964, 15789.052656840599, 909.686158275394, 912.8493798523235, 922.0272612393921, 923.0907556057278, 932.6129656192688, 905.6332185464897, 912.2382810353363, 914.7804526913559, 914.8947870994821, 916.0610374366295, 963.3689933093834, 963.9373440726365, 964.2237998411276, 965.7923546437514, 973.6932866147176, 958.3148049144895, 959.4339339789523, 960.3229723045237, 962.100436092256, 969.3263182088451, 706.2231545300128, 712.419378206765, 713.0587624335878, 714.8427345983876, 716.2515171645591, 15068.246587670572, 15112.471063512834, 15141.621459463491, 15682.451114210948, 15688.294026768823, 13605.795913061313, 13611.0, 13667.316634168252, 13699.109557878706, 13738.0, 11009.779804403866, 11286.830697539543, 11469.827952580717, 11493.655190344303, 11759.412029398582, 3693.649103335179, 3713.2387860488534, 3722.6091260417807, 3751.3435148849117, 3831.942520862189, 53262.46737532652, 53496.0, 54182.187267191024, 54343.0, 54552.45447545513, 9958.751031224132, 10703.464826758787, 10711.08955738771, 10752.0323170915, 10896.945515272373, 19798.604027919362, 19801.10895009728, 19817.900910495355, 19833.900830496044, 19842.801571984382, 7436.367908727819, 7560.810979725441, 7705.0, 7721.03487064117, 7722.845543089107, 4297.162053399557, 4376.627986621173, 4387.078713470143, 4492.775361231926, 4493.168763778646, 3353.161709572607, 3359.6808303211155, 3389.0510657016075, 3393.983030084883, 3394.8472318745717, 633.6958260035117, 641.8812519683873, 643.1638869469764, 644.3009334871716, 649.4869053447818, 558.8770470496485, 564.9915251271152, 572.4104172702123, 582.1675004743173, 604.2024527623495, 8231.46495477792, 8261.628226729812, 8290.585470726439, 8323.583820809057, 8405.747827565183, 558.1906235957796, 565.3187908570245, 573.0, 574.1645905207912, 577.8324285957109, 3771.321162190777, 3855.094052897567, 3872.4772155759174, 3986.681065514752, 4029.798510074543, 60783.6960815202, 61039.694801526595, 61557.69221153955, 62086.689566551875, 62218.0667289991, 53427.19859202115, 55004.72497637566, 56183.43816561864, 57172.42827571671, 60094.0, 45178.0, 48377.758111209216, 48639.02721945541, 49361.259581106315, 49498.50501495083, 8338.583070846555, 8416.0, 8520.616572254388, 8549.401541892257, 8870.689525866565, 36707.63292367042, 37319.25361492809, 37662.435063474615, 37848.0, 37939.05152371102, 42626.0, 42724.35913461363, 46027.0, 47553.524464756294, 47757.0, 11221.66335009951, 11323.263987840764, 11345.716357091138, 11372.772544549229, 11418.942905285421, 11720.238184517979, 11858.940705296418, 12245.265284082983, 12277.75444491123, 12380.195287306296, 10557.788844223227, 10580.0, 10584.100351470212, 10612.204084693833, 10712.250142489951, 11234.606788762354, 11280.0, 11342.489587968395, 11351.54593816238, 11494.252873563526, 10383.896161038292, 10669.626563070255, 10676.679699609023, 10718.303310284806, 11250.156238282325, 9431.858522122311, 9777.608895644094, 9900.504974751379, 9972.401655900669, 10015.899841001788, 9042.005379408129, 9085.0, 9174.724758257264, 9198.310126740387, 9271.536423178679], "unit": "score", "name": "yui.html", "value": 6632.066970203802}], "name": "dromaeo_css", "value": 7539.621869406184}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 112.0, 111.0, 111.0, 120.0, 110.0, 113.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [163.0, 126.0, 154.0, 167.0, 127.0, 160.0, 150.0, 133.0, 164.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 163.0, 163.0, 163.0, 163.0, 166.0, 167.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 75.0, 168.0, 74.0, 76.0, 75.0, 77.0, 164.0, 77.0], "unit": "score", "name": "audio-fft", "value": 93.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 144.0, 93.0, 95.0, 94.0, 140.0, 94.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [99.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 55.0, 59.0, 56.0, 56.0, 62.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [79.0, 88.0, 82.0, 89.0, 80.0, 81.0, 83.0, 81.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [113.0, 113.0, 124.0, 113.0, 113.0, 118.0, 119.0, 116.0, 121.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [136.0, 153.0, 147.0, 162.0, 151.0, 152.0, 151.0, 148.0, 149.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 70.0, 65.0, 69.0, 72.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1525.0}]} 10:00:06 INFO - Return code: 0 10:00:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:00:06 ERROR - # TBPL SUCCESS # 10:00:06 INFO - Running post-action listener: _resource_record_post_action 10:00:06 INFO - Running post-run listener: _resource_record_post_run 10:00:07 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 282624; Write bytes: 330559488; Read time: 68; Write time: 191248 10:00:07 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 81612800; Read time: 0; Write time: 69716 10:00:07 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 282624; Write bytes: 248897536; Read time: 68; Write time: 116612 10:00:07 INFO - Running post-run listener: _upload_blobber_files 10:00:07 INFO - Blob upload gear active. 10:00:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:00:07 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 10:00:07 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'] 10:00:07 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 10:00:08 INFO - (blobuploader) - INFO - Open directory for files ... 10:00:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:00:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:10 INFO - (blobuploader) - INFO - Done attempting. 10:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:00:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:11 INFO - (blobuploader) - INFO - Done attempting. 10:00:11 INFO - (blobuploader) - INFO - Iteration through files over. 10:00:11 INFO - Return code: 0 10:00:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:00:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:00:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/614cf28c6b9605733944ff6598fb6a15354db2ce4f368e33f49c655ac812b9e42bf09a10b9569c8d7b30fec2ed36f63ad4836bfc528afe9c5bae43662888b81c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75f20ccf7589340c88a8f951855cb3296f43c0eb3fd5ecbf1c3e1725482688194893b72755ca6fa1810cc8860dedd52a2715a3d7412d6f88bee6ef7ab80cd8d1"} 10:00:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:00:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:00:11 INFO - Contents: 10:00:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/614cf28c6b9605733944ff6598fb6a15354db2ce4f368e33f49c655ac812b9e42bf09a10b9569c8d7b30fec2ed36f63ad4836bfc528afe9c5bae43662888b81c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75f20ccf7589340c88a8f951855cb3296f43c0eb3fd5ecbf1c3e1725482688194893b72755ca6fa1810cc8860dedd52a2715a3d7412d6f88bee6ef7ab80cd8d1"} 10:00:11 INFO - Running post-run listener: copy_logs_to_upload_dir 10:00:11 INFO - Copying logs to upload dir... 10:00:11 INFO - mkdir: /builds/slave/test/build/upload/logs 10:00:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.714971 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-19 10:00:11.214007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 10:00:11.221507) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022 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/614cf28c6b9605733944ff6598fb6a15354db2ce4f368e33f49c655ac812b9e42bf09a10b9569c8d7b30fec2ed36f63ad4836bfc528afe9c5bae43662888b81c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75f20ccf7589340c88a8f951855cb3296f43c0eb3fd5ecbf1c3e1725482688194893b72755ca6fa1810cc8860dedd52a2715a3d7412d6f88bee6ef7ab80cd8d1"} build_url:https://queue.taskcluster.net/v1/task/OCMn9saZQD68ZX411hd3Mg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/OCMn9saZQD68ZX411hd3Mg/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/614cf28c6b9605733944ff6598fb6a15354db2ce4f368e33f49c655ac812b9e42bf09a10b9569c8d7b30fec2ed36f63ad4836bfc528afe9c5bae43662888b81c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75f20ccf7589340c88a8f951855cb3296f43c0eb3fd5ecbf1c3e1725482688194893b72755ca6fa1810cc8860dedd52a2715a3d7412d6f88bee6ef7ab80cd8d1"}' ========= master_lag: 0.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 10:00:11.512023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 10:00:11.514769) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461083977.360313-1715801022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 10:00:11.595759) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 10:00:11.599168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 10:00:11.599509) ========= ========= Total master_lag: 0.46 =========