builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1466813979.11 results: success (0) buildid: 20160624143557 builduid: 67b95f07284347e7aea2678b4c3b20e6 revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:39.114419) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:39.114901) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:39.115204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:39.152899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:39.153318) ========= 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=1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 17:19:39-- 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% 38.0M=0s 2016-06-24 17:19:39 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074033 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:39.249293) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:39.249632) ========= 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=1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015269 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:39.315157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:39.315784) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 229741b7de0485ca56b91e0e657fe5d37dbbc98f --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-beta --rev 229741b7de0485ca56b91e0e657fe5d37dbbc98f --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=1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 17:19:39,750 truncating revision to first 12 chars 2016-06-24 17:19:39,750 Setting DEBUG logging. 2016-06-24 17:19:39,750 attempt 1/10 2016-06-24 17:19:39,750 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/229741b7de04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 17:19:40,134 unpacking tar archive at: mozilla-beta-229741b7de04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849324 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:40.185041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:40.185324) ========= script_repo_revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:40.185694) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:40.186110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 17:19:40.196911) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-24 17:19:40.197277) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:19:40 INFO - MultiFileLogger online at 20160624 17:19:40 in /builds/slave/test 17:19:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:19:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:19:40 INFO - {'append_to_log': False, 17:19:40 INFO - 'base_work_dir': '/builds/slave/test', 17:19:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:19:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:19:40 INFO - 'branch': 'Mozilla-Beta', 17:19:40 INFO - 'buildbot_json_path': 'buildprops.json', 17:19:40 INFO - 'config_files': ('talos/linux_config.py',), 17:19:40 INFO - 'default_actions': ('clobber', 17:19:40 INFO - 'read-buildbot-config', 17:19:40 INFO - 'download-and-extract', 17:19:40 INFO - 'populate-webroot', 17:19:40 INFO - 'create-virtualenv', 17:19:40 INFO - 'install', 17:19:40 INFO - 'run-tests'), 17:19:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:19:40 INFO - 'download_minidump_stackwalk': True, 17:19:40 INFO - 'download_symbols': 'ondemand', 17:19:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:19:40 INFO - 'tooltool.py': '/tools/tooltool.py', 17:19:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:19:40 INFO - '/tools/misc-python/virtualenv.py')}, 17:19:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:19:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:19:40 INFO - 'installer_path': 'installer.exe', 17:19:40 INFO - 'log_level': 'info', 17:19:40 INFO - 'log_name': 'talos', 17:19:40 INFO - 'log_to_console': True, 17:19:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:19:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:19:40 INFO - 'opt_config_files': (), 17:19:40 INFO - 'pip_index': False, 17:19:40 INFO - 'sps_profile': False, 17:19:40 INFO - 'sps_profile_interval': 0, 17:19:40 INFO - 'suite': 'dromaeojs-e10s', 17:19:40 INFO - 'system_bits': '32', 17:19:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:19:40 INFO - 'title': 'talos-linux64-ix-027', 17:19:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:19:40 INFO - 'use_talos_json': True, 17:19:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:19:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:19:40 INFO - 'work_dir': 'build'} 17:19:40 INFO - ##### 17:19:40 INFO - ##### Running clobber step. 17:19:40 INFO - ##### 17:19:40 INFO - Running pre-action listener: _resource_record_pre_action 17:19:40 INFO - Running main action method: clobber 17:19:40 INFO - rmtree: /builds/slave/test/build 17:19:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:19:41 INFO - Running post-action listener: _resource_record_post_action 17:19:41 INFO - ##### 17:19:41 INFO - ##### Running read-buildbot-config step. 17:19:41 INFO - ##### 17:19:41 INFO - Running pre-action listener: _resource_record_pre_action 17:19:41 INFO - Running main action method: read_buildbot_config 17:19:41 INFO - Using buildbot properties: 17:19:41 INFO - { 17:19:41 INFO - "project": "", 17:19:41 INFO - "product": "firefox", 17:19:41 INFO - "script_repo_revision": "production", 17:19:41 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 17:19:41 INFO - "repository": "", 17:19:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 17:19:41 INFO - "buildid": "20160624143557", 17:19:41 INFO - "pgo_build": "True", 17:19:41 INFO - "basedir": "/builds/slave/test", 17:19:41 INFO - "buildnumber": 146, 17:19:41 INFO - "slavename": "talos-linux64-ix-027", 17:19:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:19:41 INFO - "platform": "ubuntu64_hw", 17:19:41 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:19:41 INFO - "branch": "mozilla-beta", 17:19:41 INFO - "repo_path": "releases/mozilla-beta", 17:19:41 INFO - "revision": "229741b7de0485ca56b91e0e657fe5d37dbbc98f", 17:19:41 INFO - "stage_platform": "linux64-pgo", 17:19:41 INFO - "builduid": "67b95f07284347e7aea2678b4c3b20e6", 17:19:41 INFO - "slavebuilddir": "test" 17:19:41 INFO - } 17:19:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 17:19:41 INFO - Running post-action listener: _resource_record_post_action 17:19:41 INFO - ##### 17:19:41 INFO - ##### Running download-and-extract step. 17:19:41 INFO - ##### 17:19:41 INFO - Running pre-action listener: _resource_record_pre_action 17:19:41 INFO - Running main action method: download_and_extract 17:19:41 INFO - mkdir: /builds/slave/test/build/tests 17:19: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')]} 17:19:41 INFO - https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:19:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:19:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:19:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:19:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:19:54 INFO - Downloaded 1327 bytes. 17:19:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:19:54 INFO - Using the following test package requirements: 17:19:54 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 17:19:54 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:19:54 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:19:54 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:19:54 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 17:19:54 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:19:54 INFO - u'jsshell-linux-x86_64.zip'], 17:19:54 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:19:54 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:19:54 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 17:19:54 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:19:54 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 17:19:54 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:19:54 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 17:19:54 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:19:54 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:19:54 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:19:54 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:19:54 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:19: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')]} 17:19:54 INFO - https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:19:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:19:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:19:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:20:01 INFO - Downloaded 24228390 bytes. 17:20:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:20:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:20:03 INFO - Return code: 0 17:20:03 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:20: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')]} 17:20:03 INFO - https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:20:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:20:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:20:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:20:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:20:06 INFO - Downloaded 24228390 bytes. 17:20:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:20:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:20:07 INFO - Return code: 0 17:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:07 INFO - https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:20:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:20:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:20:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:20:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:20:11 INFO - Downloaded 10840145 bytes. 17:20:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:20:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:20:11 INFO - Return code: 0 17:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:11 INFO - https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:20:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:20:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:20:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:20:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:20:14 INFO - Downloaded 56007799 bytes. 17:20:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:20:14 INFO - mkdir: /builds/slave/test/properties 17:20:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:20:14 INFO - Writing to file /builds/slave/test/properties/build_url 17:20:14 INFO - Contents: 17:20:14 INFO - build_url:https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:20:16 INFO - Running post-action listener: _resource_record_post_action 17:20:16 INFO - Running post-action listener: set_extra_try_arguments 17:20:16 INFO - ##### 17:20:16 INFO - ##### Running populate-webroot step. 17:20:16 INFO - ##### 17:20:16 INFO - Running pre-action listener: _resource_record_pre_action 17:20:16 INFO - Running main action method: populate_webroot 17:20:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:20:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:20:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:20:16 INFO - '--tppagecycles', 17:20:16 INFO - '7'], 17:20:16 INFO - 'tests': ['tsvgm']}}, 17:20:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:20:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:20:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:20:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:20:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:20:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:20:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:16 INFO - 'talos_options': ['--disable-e10s'], 17:20:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:20:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:20:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:16 INFO - 'talos_options': ['--disable-e10s'], 17:20:16 INFO - 'tests': ['damp', 'tps']}, 17:20:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:16 INFO - 'tests': ['damp', 'tps']}, 17:20:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:20:16 INFO - 'tests': ['dromaeo_dom']}, 17:20:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:20:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:20:16 INFO - 'tests': ['a11yr', 17:20:16 INFO - 'ts_paint', 17:20:16 INFO - 'tpaint', 17:20:16 INFO - 'sessionrestore', 17:20:16 INFO - 'sessionrestore_no_auto_restore', 17:20:16 INFO - 'tabpaint']}, 17:20:16 INFO - 'other-e10s': {'tests': ['a11yr', 17:20:16 INFO - 'ts_paint', 17:20:16 INFO - 'tpaint', 17:20:16 INFO - 'sessionrestore', 17:20:16 INFO - 'sessionrestore_no_auto_restore', 17:20:16 INFO - 'tabpaint']}, 17:20:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:20:16 INFO - 'ts_paint', 17:20:16 INFO - 'tpaint', 17:20:16 INFO - 'sessionrestore', 17:20:16 INFO - 'sessionrestore_no_auto_restore', 17:20:16 INFO - 'tabpaint']}, 17:20:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:20:16 INFO - 'ts_paint', 17:20:16 INFO - 'tpaint', 17:20:16 INFO - 'sessionrestore', 17:20:16 INFO - 'sessionrestore_no_auto_restore', 17:20:16 INFO - 'tabpaint']}, 17:20:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:20:16 INFO - 'tests': ['a11yr', 17:20:16 INFO - 'ts_paint', 17:20:16 INFO - 'tpaint', 17:20:16 INFO - 'sessionrestore', 17:20:16 INFO - 'sessionrestore_no_auto_restore', 17:20:16 INFO - 'tabpaint']}, 17:20:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:20:16 INFO - 'tests': ['a11yr', 17:20:16 INFO - 'ts_paint', 17:20:16 INFO - 'tpaint', 17:20:16 INFO - 'sessionrestore', 17:20:16 INFO - 'sessionrestore_no_auto_restore', 17:20:16 INFO - 'tabpaint']}, 17:20:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:20:16 INFO - 'tests': ['tsvgx', 17:20:16 INFO - 'tsvgr_opacity', 17:20:16 INFO - 'tart', 17:20:16 INFO - 'tscrollx', 17:20:16 INFO - 'cart']}, 17:20:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:20:16 INFO - 'tsvgr_opacity', 17:20:16 INFO - 'tart', 17:20:16 INFO - 'tscrollx', 17:20:16 INFO - 'cart']}, 17:20:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:16 INFO - 'talos_options': ['--disable-e10s'], 17:20:16 INFO - 'tests': ['tp5o']}, 17:20:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:16 INFO - 'tests': ['tp5o']}, 17:20:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:16 INFO - 'talos_options': ['--disable-e10s', 17:20:16 INFO - '--xperf_path', 17:20:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:20:16 INFO - 'tests': ['tp5n']}, 17:20:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:16 INFO - 'talos_options': ['--xperf_path', 17:20:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:20:16 INFO - 'tests': ['tp5n']}}, 17:20:16 INFO - 'talos.zip': {'path': '', 17:20:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:20:16 INFO - Running post-action listener: _resource_record_post_action 17:20:16 INFO - ##### 17:20:16 INFO - ##### Running create-virtualenv step. 17:20:16 INFO - ##### 17:20:16 INFO - Running pre-action listener: _resource_record_pre_action 17:20:16 INFO - Running main action method: create_virtualenv 17:20:16 INFO - Creating virtualenv /builds/slave/test/build/venv 17:20:16 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 17:20:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:20:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:20:16 INFO - Using real prefix '/usr' 17:20:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:20:16 INFO - Installing distribute.............................................................................................................................................................................................done. 17:20:18 INFO - Installing pip.................done. 17:20:18 INFO - Return code: 0 17:20:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:20:18 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')]} 17:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:18 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')]} 17:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:18 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 0x7fe0695b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1164410>, '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 0x1165310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11657a0>, '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': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', '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 17:20:18 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 17:20:18 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 17:20:18 INFO - Using env: {'DISPLAY': ':0', 17:20:18 INFO - 'HOME': '/home/cltbld', 17:20:18 INFO - 'LANG': 'en_US.UTF-8', 17:20:18 INFO - 'LANGUAGE': 'en_US:en', 17:20:18 INFO - 'LOGNAME': 'cltbld', 17:20:18 INFO - 'MAIL': '/var/mail/cltbld', 17:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:18 INFO - 'MOZ_NO_REMOTE': '1', 17:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:18 INFO - 'NO_EM_RESTART': '1', 17:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:18 INFO - 'PWD': '/builds/slave/test', 17:20:18 INFO - 'SHELL': '/bin/bash', 17:20:18 INFO - 'SHLVL': '1', 17:20:18 INFO - 'TERM': 'linux', 17:20:18 INFO - 'TMOUT': '86400', 17:20:18 INFO - 'USER': 'cltbld', 17:20:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', 17:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:18 INFO - '_': '/tools/buildbot/bin/python'} 17:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:18 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 17:20:18 INFO - Cleaning up... 17:20:18 INFO - Return code: 0 17:20:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:20:18 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')]} 17:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:18 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')]} 17:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:18 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 0x7fe0695b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1164410>, '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 0x1165310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11657a0>, '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': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', '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 17:20:18 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 17:20:18 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 17:20:18 INFO - Using env: {'DISPLAY': ':0', 17:20:18 INFO - 'HOME': '/home/cltbld', 17:20:18 INFO - 'LANG': 'en_US.UTF-8', 17:20:18 INFO - 'LANGUAGE': 'en_US:en', 17:20:18 INFO - 'LOGNAME': 'cltbld', 17:20:18 INFO - 'MAIL': '/var/mail/cltbld', 17:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:18 INFO - 'MOZ_NO_REMOTE': '1', 17:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:18 INFO - 'NO_EM_RESTART': '1', 17:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:18 INFO - 'PWD': '/builds/slave/test', 17:20:18 INFO - 'SHELL': '/bin/bash', 17:20:18 INFO - 'SHLVL': '1', 17:20:18 INFO - 'TERM': 'linux', 17:20:18 INFO - 'TMOUT': '86400', 17:20:18 INFO - 'USER': 'cltbld', 17:20:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', 17:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:18 INFO - '_': '/tools/buildbot/bin/python'} 17:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:19 INFO - Downloading/unpacking psutil>=0.7.1 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 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 17:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:20:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:21 INFO - Installing collected packages: psutil 17:20:21 INFO - Running setup.py install for psutil 17:20:21 INFO - building 'psutil._psutil_linux' extension 17:20:21 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 17:20:21 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 17:20:21 INFO - building 'psutil._psutil_posix' extension 17:20:21 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 17:20:21 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 17:20:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:21 INFO - Successfully installed psutil 17:20:21 INFO - Cleaning up... 17:20:21 INFO - Return code: 0 17:20:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:20:21 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')]} 17:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:21 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')]} 17:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:21 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 0x7fe0695b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1164410>, '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 0x1165310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11657a0>, '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': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', '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 17:20:21 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 17:20:21 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 17:20:21 INFO - Using env: {'DISPLAY': ':0', 17:20:21 INFO - 'HOME': '/home/cltbld', 17:20:21 INFO - 'LANG': 'en_US.UTF-8', 17:20:21 INFO - 'LANGUAGE': 'en_US:en', 17:20:21 INFO - 'LOGNAME': 'cltbld', 17:20:21 INFO - 'MAIL': '/var/mail/cltbld', 17:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:21 INFO - 'MOZ_NO_REMOTE': '1', 17:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:21 INFO - 'NO_EM_RESTART': '1', 17:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:21 INFO - 'PWD': '/builds/slave/test', 17:20:21 INFO - 'SHELL': '/bin/bash', 17:20:21 INFO - 'SHLVL': '1', 17:20:21 INFO - 'TERM': 'linux', 17:20:21 INFO - 'TMOUT': '86400', 17:20:21 INFO - 'USER': 'cltbld', 17:20:21 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', 17:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:21 INFO - '_': '/tools/buildbot/bin/python'} 17:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:20:21 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 17:20:21 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 17:20:21 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 17:20:21 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 17:20:21 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 17:20:21 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 17:20:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:20:23 INFO - Installing collected packages: mozsystemmonitor 17:20:23 INFO - Running setup.py install for mozsystemmonitor 17:20:23 INFO - Successfully installed mozsystemmonitor 17:20:23 INFO - Cleaning up... 17:20:24 INFO - Return code: 0 17:20:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:20:24 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')]} 17:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:24 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')]} 17:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:24 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 0x7fe0695b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1164410>, '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 0x1165310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11657a0>, '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': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', '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 17:20:24 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 17:20:24 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 17:20:24 INFO - Using env: {'DISPLAY': ':0', 17:20:24 INFO - 'HOME': '/home/cltbld', 17:20:24 INFO - 'LANG': 'en_US.UTF-8', 17:20:24 INFO - 'LANGUAGE': 'en_US:en', 17:20:24 INFO - 'LOGNAME': 'cltbld', 17:20:24 INFO - 'MAIL': '/var/mail/cltbld', 17:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:24 INFO - 'MOZ_NO_REMOTE': '1', 17:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:24 INFO - 'NO_EM_RESTART': '1', 17:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:24 INFO - 'PWD': '/builds/slave/test', 17:20:24 INFO - 'SHELL': '/bin/bash', 17:20:24 INFO - 'SHLVL': '1', 17:20:24 INFO - 'TERM': 'linux', 17:20:24 INFO - 'TMOUT': '86400', 17:20:24 INFO - 'USER': 'cltbld', 17:20:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', 17:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:24 INFO - '_': '/tools/buildbot/bin/python'} 17:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:24 INFO - Downloading/unpacking blobuploader==1.2.4 17:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:26 INFO - Downloading blobuploader-1.2.4.tar.gz 17:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:20:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:20:26 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 17:20:26 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 17:20:26 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 17:20:26 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 17:20:26 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 17:20:26 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 17:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:20:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:20:26 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 17:20:26 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 17:20:26 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 17:20:26 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 17:20:26 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 17:20:26 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 17:20:26 INFO - Downloading docopt-0.6.1.tar.gz 17:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:20:26 INFO - Installing collected packages: blobuploader, requests, docopt 17:20:26 INFO - Running setup.py install for blobuploader 17:20:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:20:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:20:27 INFO - Running setup.py install for requests 17:20:27 INFO - Running setup.py install for docopt 17:20:27 INFO - Successfully installed blobuploader requests docopt 17:20:27 INFO - Cleaning up... 17:20:27 INFO - Return code: 0 17:20:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:27 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')]} 17:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:27 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')]} 17:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:27 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 0x7fe0695b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1164410>, '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 0x1165310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11657a0>, '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': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', '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 17:20:27 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 17:20:27 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 17:20:27 INFO - Using env: {'DISPLAY': ':0', 17:20:27 INFO - 'HOME': '/home/cltbld', 17:20:27 INFO - 'LANG': 'en_US.UTF-8', 17:20:27 INFO - 'LANGUAGE': 'en_US:en', 17:20:27 INFO - 'LOGNAME': 'cltbld', 17:20:27 INFO - 'MAIL': '/var/mail/cltbld', 17:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:27 INFO - 'MOZ_NO_REMOTE': '1', 17:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:27 INFO - 'NO_EM_RESTART': '1', 17:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:27 INFO - 'PWD': '/builds/slave/test', 17:20:27 INFO - 'SHELL': '/bin/bash', 17:20:27 INFO - 'SHLVL': '1', 17:20:27 INFO - 'TERM': 'linux', 17:20:27 INFO - 'TMOUT': '86400', 17:20:27 INFO - 'USER': 'cltbld', 17:20:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', 17:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:27 INFO - '_': '/tools/buildbot/bin/python'} 17:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:27 INFO - Running setup.py (path:/tmp/pip-29XKsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:27 INFO - Running setup.py (path:/tmp/pip-eUOLgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:27 INFO - Running setup.py (path:/tmp/pip-khKupX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:27 INFO - Running setup.py (path:/tmp/pip-VtmpF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:28 INFO - Running setup.py (path:/tmp/pip-WfZlfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:28 INFO - Running setup.py (path:/tmp/pip-uvqEhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:28 INFO - Running setup.py (path:/tmp/pip-qXVdWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:28 INFO - Running setup.py (path:/tmp/pip-aeweHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:28 INFO - Running setup.py (path:/tmp/pip-srW1sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:28 INFO - Running setup.py (path:/tmp/pip-qnVygr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:28 INFO - Running setup.py (path:/tmp/pip-xnIfkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:28 INFO - Running setup.py (path:/tmp/pip-jkKYZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:28 INFO - Running setup.py (path:/tmp/pip-NksBLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:28 INFO - Running setup.py (path:/tmp/pip-W4Sl9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:28 INFO - Running setup.py (path:/tmp/pip-7stn96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:28 INFO - Running setup.py (path:/tmp/pip-zE8aWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:28 INFO - Running setup.py (path:/tmp/pip-EI84HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:20:28 INFO - Running setup.py install for manifestparser 17:20:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:20:29 INFO - Running setup.py install for mozcrash 17:20:29 INFO - Running setup.py install for mozdebug 17:20:29 INFO - Running setup.py install for mozdevice 17:20:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:20:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:20:29 INFO - Running setup.py install for mozfile 17:20:29 INFO - Running setup.py install for mozhttpd 17:20:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:20:29 INFO - Running setup.py install for mozinfo 17:20:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:20:29 INFO - Running setup.py install for mozInstall 17:20:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:20:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:20:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:20:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:20:29 INFO - Running setup.py install for mozleak 17:20:29 INFO - Running setup.py install for mozlog 17:20:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:20:29 INFO - Running setup.py install for moznetwork 17:20:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:20:30 INFO - Running setup.py install for mozprocess 17:20:30 INFO - Running setup.py install for mozprofile 17:20:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:20:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:20:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:20:30 INFO - Running setup.py install for mozrunner 17:20:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:20:30 INFO - Running setup.py install for mozscreenshot 17:20:30 INFO - Running setup.py install for moztest 17:20:30 INFO - Running setup.py install for mozversion 17:20:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:20:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:20:30 INFO - Cleaning up... 17:20:30 INFO - Return code: 0 17:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:30 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 0x7fe0695b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1164410>, '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 0x1165310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11657a0>, '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': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', '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 17:20:30 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 17:20:30 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 17:20:30 INFO - Using env: {'DISPLAY': ':0', 17:20:30 INFO - 'HOME': '/home/cltbld', 17:20:30 INFO - 'LANG': 'en_US.UTF-8', 17:20:30 INFO - 'LANGUAGE': 'en_US:en', 17:20:30 INFO - 'LOGNAME': 'cltbld', 17:20:30 INFO - 'MAIL': '/var/mail/cltbld', 17:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:30 INFO - 'MOZ_NO_REMOTE': '1', 17:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:30 INFO - 'NO_EM_RESTART': '1', 17:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:30 INFO - 'PWD': '/builds/slave/test', 17:20:30 INFO - 'SHELL': '/bin/bash', 17:20:30 INFO - 'SHLVL': '1', 17:20:30 INFO - 'TERM': 'linux', 17:20:30 INFO - 'TMOUT': '86400', 17:20:30 INFO - 'USER': 'cltbld', 17:20:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', 17:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:30 INFO - '_': '/tools/buildbot/bin/python'} 17:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:30 INFO - Running setup.py (path:/tmp/pip-RuLFvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:30 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)) 17:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:30 INFO - Running setup.py (path:/tmp/pip-M4Ir2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:31 INFO - Running setup.py (path:/tmp/pip-UQkewl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:31 INFO - Running setup.py (path:/tmp/pip-1ad6j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:31 INFO - Running setup.py (path:/tmp/pip-G48gHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:31 INFO - Running setup.py (path:/tmp/pip-oxmkfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:31 INFO - Running setup.py (path:/tmp/pip-ulsJaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:31 INFO - Running setup.py (path:/tmp/pip-seEziI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:31 INFO - Running setup.py (path:/tmp/pip-VAFuMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:31 INFO - Running setup.py (path:/tmp/pip-HPSbAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:31 INFO - Running setup.py (path:/tmp/pip-Bbr6AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:31 INFO - Running setup.py (path:/tmp/pip-MwfZF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:31 INFO - Running setup.py (path:/tmp/pip-AsesQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:31 INFO - Running setup.py (path:/tmp/pip-y9A_g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:31 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)) 17:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:31 INFO - Running setup.py (path:/tmp/pip-Fhlcoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:32 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)) 17:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:32 INFO - Running setup.py (path:/tmp/pip-RRNtZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:32 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)) 17:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:32 INFO - Running setup.py (path:/tmp/pip-oDBdEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:32 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)) 17:20:32 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)) 17:20:32 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)) 17:20:32 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)) 17:20:32 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)) 17:20:32 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)) 17:20:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:34 INFO - Downloading blessings-1.6.tar.gz 17:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:20:34 INFO - Installing collected packages: blessings 17:20:34 INFO - Running setup.py install for blessings 17:20:34 INFO - Successfully installed blessings 17:20:34 INFO - Cleaning up... 17:20:34 INFO - Return code: 0 17:20:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:20:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:34 INFO - Reading from file tmpfile_stdout 17:20:34 INFO - Current package versions: 17:20:34 INFO - argparse == 1.2.1 17:20:34 INFO - blessings == 1.6 17:20:34 INFO - blobuploader == 1.2.4 17:20:34 INFO - docopt == 0.6.1 17:20:34 INFO - manifestparser == 1.1 17:20:34 INFO - mozInstall == 1.12 17:20:34 INFO - mozcrash == 0.17 17:20:34 INFO - mozdebug == 0.1 17:20:34 INFO - mozdevice == 0.48 17:20:34 INFO - mozfile == 1.2 17:20:34 INFO - mozhttpd == 0.7 17:20:34 INFO - mozinfo == 0.9 17:20:34 INFO - mozleak == 0.1 17:20:34 INFO - mozlog == 3.1 17:20:34 INFO - moznetwork == 0.27 17:20:34 INFO - mozprocess == 0.22 17:20:34 INFO - mozprofile == 0.28 17:20:34 INFO - mozrunner == 6.11 17:20:34 INFO - mozscreenshot == 0.1 17:20:34 INFO - mozsystemmonitor == 0.0 17:20:34 INFO - moztest == 0.7 17:20:34 INFO - mozversion == 1.4 17:20:34 INFO - psutil == 3.1.1 17:20:34 INFO - requests == 1.2.3 17:20:34 INFO - wsgiref == 0.1.2 17:20:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20: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')]} 17:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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')]} 17:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:34 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 0x7fe0695b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1164410>, '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 0x1165310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11657a0>, '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': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', '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 17:20:34 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 17:20:34 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 17:20:34 INFO - Using env: {'DISPLAY': ':0', 17:20:34 INFO - 'HOME': '/home/cltbld', 17:20:34 INFO - 'LANG': 'en_US.UTF-8', 17:20:34 INFO - 'LANGUAGE': 'en_US:en', 17:20:34 INFO - 'LOGNAME': 'cltbld', 17:20:34 INFO - 'MAIL': '/var/mail/cltbld', 17:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:34 INFO - 'MOZ_NO_REMOTE': '1', 17:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:34 INFO - 'NO_EM_RESTART': '1', 17:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:34 INFO - 'PWD': '/builds/slave/test', 17:20:34 INFO - 'SHELL': '/bin/bash', 17:20:34 INFO - 'SHLVL': '1', 17:20:34 INFO - 'TERM': 'linux', 17:20:34 INFO - 'TMOUT': '86400', 17:20:34 INFO - 'USER': 'cltbld', 17:20:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', 17:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:34 INFO - '_': '/tools/buildbot/bin/python'} 17:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:34 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)) 17:20:34 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)) 17:20:34 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)) 17:20:34 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)) 17:20:34 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)) 17:20:34 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)) 17:20:34 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)) 17:20:34 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)) 17:20:34 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)) 17:20:34 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)) 17:20:34 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)) 17:20:34 INFO - Cleaning up... 17:20:34 INFO - Return code: 0 17:20:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:20: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')]} 17:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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')]} 17:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:34 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 0x7fe0695b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1164410>, '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 0x1165310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11657a0>, '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': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', '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 17:20:34 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 17:20:34 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 17:20:34 INFO - Using env: {'DISPLAY': ':0', 17:20:34 INFO - 'HOME': '/home/cltbld', 17:20:34 INFO - 'LANG': 'en_US.UTF-8', 17:20:34 INFO - 'LANGUAGE': 'en_US:en', 17:20:34 INFO - 'LOGNAME': 'cltbld', 17:20:34 INFO - 'MAIL': '/var/mail/cltbld', 17:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:34 INFO - 'MOZ_NO_REMOTE': '1', 17:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:34 INFO - 'NO_EM_RESTART': '1', 17:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:34 INFO - 'PWD': '/builds/slave/test', 17:20:34 INFO - 'SHELL': '/bin/bash', 17:20:34 INFO - 'SHLVL': '1', 17:20:34 INFO - 'TERM': 'linux', 17:20:34 INFO - 'TMOUT': '86400', 17:20:34 INFO - 'USER': 'cltbld', 17:20:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', 17:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:34 INFO - '_': '/tools/buildbot/bin/python'} 17:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:34 INFO - Downloading/unpacking jsonschema 17:20:34 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 17:20:34 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 17:20:34 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 17:20:34 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 17:20:34 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 17:20:34 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 17:20:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:20:36 INFO - Downloading/unpacking functools32 (from jsonschema) 17:20:36 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 17:20:36 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 17:20:36 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 17:20:36 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 17:20:36 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 17:20:36 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 17:20:37 INFO - Downloading functools32-3.2.3-2.tar.gz 17:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:20:37 INFO - warning: no files found matching '*.txt' 17:20:37 INFO - no previously-included directories found matching 'build' 17:20:37 INFO - no previously-included directories found matching 'dist' 17:20:37 INFO - no previously-included directories found matching '.git*' 17:20:37 INFO - Installing collected packages: jsonschema, functools32 17:20:37 INFO - Running setup.py install for functools32 17:20:37 INFO - warning: no files found matching '*.txt' 17:20:37 INFO - no previously-included directories found matching 'build' 17:20:37 INFO - no previously-included directories found matching 'dist' 17:20:37 INFO - no previously-included directories found matching '.git*' 17:20:37 INFO - Successfully installed jsonschema functools32 17:20:37 INFO - Cleaning up... 17:20:37 INFO - Return code: 0 17:20:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:20:37 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')]} 17:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:37 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')]} 17:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:37 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 0x7fe0695b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1164410>, '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 0x1165310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11657a0>, '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': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', '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 17:20:37 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 17:20:37 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 17:20:37 INFO - Using env: {'DISPLAY': ':0', 17:20:37 INFO - 'HOME': '/home/cltbld', 17:20:37 INFO - 'LANG': 'en_US.UTF-8', 17:20:37 INFO - 'LANGUAGE': 'en_US:en', 17:20:37 INFO - 'LOGNAME': 'cltbld', 17:20:37 INFO - 'MAIL': '/var/mail/cltbld', 17:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:37 INFO - 'MOZ_NO_REMOTE': '1', 17:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:37 INFO - 'NO_EM_RESTART': '1', 17:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:37 INFO - 'PWD': '/builds/slave/test', 17:20:37 INFO - 'SHELL': '/bin/bash', 17:20:37 INFO - 'SHLVL': '1', 17:20:37 INFO - 'TERM': 'linux', 17:20:37 INFO - 'TMOUT': '86400', 17:20:37 INFO - 'USER': 'cltbld', 17:20:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', 17:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:37 INFO - '_': '/tools/buildbot/bin/python'} 17:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:37 INFO - Downloading/unpacking flake8 17:20:37 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 17:20:37 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 17:20:37 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 17:20:37 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 17:20:37 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 17:20:37 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 17:20:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:20:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:20:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 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 17:20:39 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 17:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:20:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:20:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:20:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:20:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:20:40 INFO - no previously-included directories found matching 'docs/_build' 17:20:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:20:40 INFO - Running setup.py install for pep8 17:20:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:20:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:20:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:20:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:20:40 INFO - no previously-included directories found matching 'docs/_build' 17:20:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:20:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:20:40 INFO - Cleaning up... 17:20:40 INFO - Return code: 0 17:20:40 INFO - Running post-action listener: _resource_record_post_action 17:20:40 INFO - Running post-action listener: _start_resource_monitoring 17:20:40 INFO - Starting resource monitoring. 17:20:40 INFO - ##### 17:20:40 INFO - ##### Running install step. 17:20:40 INFO - ##### 17:20:40 INFO - Running pre-action listener: _resource_record_pre_action 17:20:40 INFO - Running main action method: install 17:20:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:40 INFO - Reading from file tmpfile_stdout 17:20:40 INFO - Detecting whether we're running mozinstall >=1.0... 17:20:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:20:40 INFO - Reading from file tmpfile_stdout 17:20:40 INFO - Output received: 17:20:40 INFO - Usage: mozinstall [options] installer 17:20:40 INFO - Options: 17:20:40 INFO - -h, --help show this help message and exit 17:20:40 INFO - -d DEST, --destination=DEST 17:20:40 INFO - Directory to install application into. [default: 17:20:40 INFO - "/builds/slave/test"] 17:20:40 INFO - --app=APP Application being installed. [default: firefox] 17:20:40 INFO - mkdir: /builds/slave/test/build/application 17:20:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:20:54 INFO - Reading from file tmpfile_stdout 17:20:54 INFO - Output received: 17:20:54 INFO - /builds/slave/test/build/application/firefox/firefox 17:20:54 INFO - Running post-action listener: _resource_record_post_action 17:20:54 INFO - ##### 17:20:54 INFO - ##### Running run-tests step. 17:20:54 INFO - ##### 17:20:54 INFO - Running pre-action listener: _resource_record_pre_action 17:20:54 INFO - Running main action method: run_tests 17:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:20:54 INFO - Python 2.7.3 17:20:54 INFO - Return code: 0 17:20:54 INFO - grabbing minidump binary from tooltool 17:20: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')]} 17:20:54 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 0x1164410>, '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 0x1165310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11657a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:20:54 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 17:20:54 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 17:20:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:20:54 INFO - Return code: 0 17:20:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:20:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:20:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:20:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:20:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:20:55 INFO - Return code: 0 17:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 17:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 17:20:55 INFO - Using env: {'DISPLAY': ':0', 17:20:55 INFO - 'HOME': '/home/cltbld', 17:20:55 INFO - 'LANG': 'en_US.UTF-8', 17:20:55 INFO - 'LANGUAGE': 'en_US:en', 17:20:55 INFO - 'LOGNAME': 'cltbld', 17:20:55 INFO - 'MAIL': '/var/mail/cltbld', 17:20:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:20:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:55 INFO - 'MOZ_NO_REMOTE': '1', 17:20:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:55 INFO - 'NO_EM_RESTART': '1', 17:20:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:55 INFO - 'PWD': '/builds/slave/test', 17:20:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:20:55 INFO - 'SHELL': '/bin/bash', 17:20:55 INFO - 'SHLVL': '1', 17:20:55 INFO - 'TERM': 'linux', 17:20:55 INFO - 'TMOUT': '86400', 17:20:55 INFO - 'USER': 'cltbld', 17:20:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324', 17:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:55 INFO - '_': '/tools/buildbot/bin/python'} 17:20:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 17:20:55 INFO - mozversion application_buildid: 20160624143557 17:20:55 INFO - mozversion application_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 17:20:55 INFO - mozversion application_display_name: Firefox 17:20:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:20:55 INFO - mozversion application_name: Firefox 17:20:55 INFO - mozversion application_remotingname: firefox 17:20:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:20:55 INFO - mozversion application_vendor: Mozilla 17:20:55 INFO - mozversion application_version: 48.0 17:20:55 INFO - mozversion platform_buildid: 20160624143557 17:20:55 INFO - mozversion platform_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 17:20:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:20:55 INFO - mozversion platform_version: 48.0 17:20:55 INFO - using testdate: 1466814055 17:20:55 INFO - actual date: 1466814055 17:20:55 INFO - starting webserver on 'localhost:54437' 17:20:55 INFO - SUITE-START | Running 2 tests 17:20:55 INFO - TEST-START | dromaeo_css 17:20:55 INFO - operating with platform_type : linux_ 17:20:55 INFO - Initialising browser for dromaeo_css test... 17:20:55 INFO - TEST-INFO | started process 25115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9dUvRs/profile http://localhost:54437/getInfo.html) 17:20:58 INFO - PROCESS | 25115 | 17:20:58 INFO - PROCESS | 25115 | (process:25192): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:20:59 INFO - PROCESS | 25115 | __metrics Screen width/height:1600/1200 17:20:59 INFO - PROCESS | 25115 | colorDepth:24 17:20:59 INFO - PROCESS | 25115 | Browser inner width/height: 1024/697 17:20:59 INFO - PROCESS | 25115 | __metrics 17:20:59 ERROR - PROCESS | 25115 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 17:21:00 INFO - TEST-INFO | 25115: exit 0 17:21:00 INFO - Browser initialized. 17:21:00 INFO - Running cycle 1/1 for dromaeo_css test... 17:21:00 INFO - TEST-INFO | started process 25244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9dUvRs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:02 INFO - PROCESS | 25244 | 17:21:02 INFO - PROCESS | 25244 | (process:25313): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:21:12 INFO - PROCESS | 25244 | RSS: Main: 150564864 17:21:12 INFO - PROCESS | 25244 | 17:22:02 INFO - PROCESS | 25244 | 1466814122293 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] 17:24:09 INFO - PROCESS | 25244 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54437/tests/dromaeo/cssquery-ext.html) 17:24:10 INFO - PROCESS | 25244 | RSS: Main: 154230784 17:24:10 INFO - PROCESS | 25244 | 17:27:12 INFO - PROCESS | 25244 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-ext.html (next: http://localhost:54437/tests/dromaeo/cssquery-jquery.html) 17:27:13 INFO - PROCESS | 25244 | RSS: Main: 152518656 17:27:13 INFO - PROCESS | 25244 | 17:30:14 INFO - PROCESS | 25244 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54437/tests/dromaeo/cssquery-mootools.html) 17:30:15 INFO - PROCESS | 25244 | RSS: Main: 152301568 17:30:15 INFO - PROCESS | 25244 | 17:33:16 INFO - PROCESS | 25244 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54437/tests/dromaeo/cssquery-prototype.html) 17:33:17 INFO - PROCESS | 25244 | RSS: Main: 153714688 17:33:17 INFO - PROCESS | 25244 | 17:36:19 INFO - PROCESS | 25244 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54437/tests/dromaeo/cssquery-yui.html) 17:36:20 INFO - PROCESS | 25244 | RSS: Main: 151752704 17:36:20 INFO - PROCESS | 25244 | 17:39:22 INFO - PROCESS | 25244 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-yui.html (next: http://localhost:54437/tests/dromaeo/cssquery-dojo.html) 17:39:22 INFO - PROCESS | 25244 | RSS: Main: 155344896 17:39:22 INFO - PROCESS | 25244 | 17:39:22 INFO - PROCESS | 25244 | __start_tp_report 17:39:22 INFO - PROCESS | 25244 | _x_x_mozilla_page_load 17:39:22 INFO - PROCESS | 25244 | _x_x_mozilla_page_load_details 17:39:22 INFO - PROCESS | 25244 | |i|pagename|runs| 17:39:22 INFO - PROCESS | 25244 | |0;dojo.html;3280.1307653471827;3351.5140304655843;3357.999999999999;3382.0699307690365;3404.948925766114;5470.234167216593;5509.449055094488;5512.283403157594;5539;5544.6673199608;5474.069408200606;5507.118860982244;5530.751116199771;5537.612367134292;5561.77752889884;4953.900921981558;5013.871878827271;5062.645614806965;5171.818986335479;5204.583633309327;4874.756262186894;4906.31311616374;5077.796888124471;5174.379074511064;5230.790768369261;5106.489351064883;5126.231065340192;5160.200168973815;5175.844724658247;5208.401033881114;5023.773930173151;5030.924536131961;5030.924536131979;5050.747462626872;5064.290999260106;4875.512448755132;4966.950330496685;4969.627277954131;4977.402711674586;5028.874278143039;5312.256284120226;5378.220158077096;5402.297701298845;5418.783248670048;5460.699661518614;5886.735096920649;5888.558358123158;5891.175235467038;5916.763329466816;5921.437463440966;5795.681237531934;5914.2902851657645;5963.7912673056235;5965.821025369246;5999.490043346277;5532.6680399175775;5538.889222215533;5540.030494663418;5541.639793413416;5543.667379957215;6008.429199226067;6009.939900601025;6010.158577799111;6016.067509535941;6021.939780602138;5723.885522289531;5773.220615216976;5837.270341207349;5908.793192238251;5951.434613711691;5935.881282374328;5966.492848107872;5972.970135149297;5974.85062873423;5976.282846058414;5873.853153671193;5908.586398952032;5921;5933.376995415506;5948.196993405835;5764.538836893039;5873.177755114288;5899.911501327483;5905.261842269716;5928.614640048383;4474.082813023322;4477.1269602427865;4489.19194544985;4490.932636010462;4522.050369422393;4009.498812648419;4044.474218351654;4058.9594104058583;4071.6742660587083;4078.1028173801715;5474.534664553478;5615.073512870413;5662.320521537442;5696.572757043238;5721.313442386857;5949.167116603679;5971.910421343683;5977.282726072899;5980.132880732356;6011.218541589566;5621.409751975983;5625.943740562624;5658.264425624642;5660.5471562274915;5680.005998950167;5048.469910659402;5050.873728156826;5060.898782024339;5072.137736584789;5107.97446012775;6100.481459076028;6167.444929956326;6180.5673602848265;6187.474064704461;6192.845178870564;5833.270841144857;5863.765449381977;5906.173135761082;5956.195913551615;5986.102084687332;6120.510359171345;6129.908051379322;6130.080487926668;6140.539459540463;6144.723487442986;5814.418558144152;5815.098659707752;5816.883662326814;5817.331006934257;5826.475617194473;5726.513246374105;5916.230889984275;5961.970190149195;6047.909281360695;6048.848778780566;5799.4780469757925;5845.41545845412;5854.443827836349;5855.151003104611;5866.149408335853;5756.280464941882;5835.824925252249;5840.795572154954;5842.474177324061;5843.824685259449;5510.311211098613;5686.34607020198;5690.2887139107615;5693;5729.598928074995;5795.1017592273265;5803;5858.179854820243;5868.2077919480325;5879.05935050407;5426.891462170814;5724.513416359489;5733.340665823317;5738.8278351649515;5741.3971532988435 17:39:22 INFO - PROCESS | 25244 | |1;ext.html;659.5152562866292;678.4233401608633;685.7565564224697;723.486324709456;736.9263073692631;39982.40026399602;40761.796191019006;40762.592374076215;40764;40770.59229407705;43787.12425751491;44306.7784661077;44349.77825110878;44437.33343999842;44505.33242001373;8801.251893589053;9110.86333704995;9111.908880911205;9115.95442022789;9128.771780705501;8882.289416846668;8918.910810891874;8924.286057115447;8943.418677785923;8963.775905602346;9224.03147669495;9273;9289.256859451261;9303.76740581484;9354.766130846716;9135.314851386172;9177.816443671156;9182.770430739218;9201.539923003824;9203.585838637244;9180.081991800833;9252;9257.768555786091;9285;9286.489243091628;42496.3625545617;43157.13685726268;43193.13613727739;43294.13411731779;43297;3982.26328129297;4020.9147208222535;4081.9591804081874;4145.7927103645;4184.539700632928;33056.28259175651;33519.83240083784;33691.15772105692;33900.660993389996;34087.3413368816;4313.82744690212;4334.176506463762;4361.258586040381;4411.27214009688;4481.932771008437;333777;335302;337525.561860953;341477;342970;58647.41352586505;59316.40683593195;59375.10937335943;59615.70192149098;59670.70164649236;70750.64624676947;71030.64484677544;71110.64444677744;71137;71582;18967.62064758697;19119.808801911804;19120.23519059222;19129.521761955784;19132.713009304873;14499;14518.346674399678;14586.927065364605;14644.707105857824;14684.559463216121;20154.899225503777;20575.485612859797;20585.970701464867;20638;21726.674099888514;7889.763307100796;7952.284294413531;8018.398620103399;8185.918140818635;8206.261436470746;1088.8965548272902;1157.2246594781516;1176.3588844079998;1212.5392350906775;1269.2384569258556;32882.3423531528;32984.3403131936;33365.83317083399;33706.66293337084;33830.323393531995;1220.2068655374078;1263;1279.6480967733949;1281.0648226794306;1281.3657239666425;17252.482425527254;17414;17605.911970440065;17613.20740566652;17673.502675392247;489757;543335;544703;566207;585238;63688;65631.34368656347;65702;65738;65765;1523.8552337527917;1569.1448160752418;1577.8501042400953;1579.9921000394925;1584.6196912740859;33441.33117337591;33711.3257734839;33847.3230535383;34190.97427077192;34432.82783586166;55594;56287;56346.71826641005;56611.15083273672;56842.715786420806;432249;432289;433634;434482;434497;31382.68617313889;32088.197795055312;32132.19669508281;32327.35345293128;32357.35285294234;50022.24966625576;50269.74865125651;50665.24002139897;51225.133612306774;51697.224541631156;42422;42855.35716964186;43143.56856431396;43527.78236108799;43860.342094869244;41557;41745;42562.57437425586;42680.57319426766;43692;44445.55554444544;44806.55193448024;44811.10377792491;45923;46452;33007.83496082504;33363.33273334471;33942;34285.82857085699;34555.481667774504;26828.329291767863;27215.183544493695;29279.56080658749;29303.41393172082;29460.705392945798 17:39:22 INFO - PROCESS | 25244 | |2;jquery.html;412.27028160156505;417.53444908926554;419.6684619150871;424.5160517010608;432.3385220612464;18698.53253668659;19393.22427102916;19425.12586933586;19595.118219680113;20903;20191.697124543145;20393.49016274594;20451.079701413433;20780.272690455837;20786.376408707725;5564.248826408434;5664.26364572605;5828.154917536955;5906.645601263938;5907.0548712206055;5769.076947688371;5792.073268277077;5807.332156801958;5813.709314534256;5831.446012628793;5576.302962129734;5762.625429347079;5807.680577568232;5820.796272130477;5836.6206196597295;5765.682887441189;5811.924793913139;5821.650700957914;5823.737931793079;5852.180694702745;5149.2791009258735;5181.637285390024;5185.429602743695;5228.2680424740565;5238.842834714965;23559.646605300935;23971.64042539346;24274;24329.87835060831;24392.512149757084;2549.4008907906627;2615.8299710518754;2623.252373073684;2676.4111895382985;2707.052531613939;15386;15519.456819011393;15657.217139142997;15907.522774316789;15946.9202653986;2039.653258945968;2049.5286084200716;2084.1871670048695;2087.1964293746864;2136.220279597951;77179;79363.99999999942;79464;79535.6023219886;80392.59803700945;10907.945460272647;11015.614453494089;11092.833607495893;11104.056155226895;11347.659570212907;15408.15255160977;15546.84453155454;15548.455804047031;15572.92213538925;15633.452829150925;8822.647094116164;8850.690225842194;8916.420432671855;8964.372493925493;9121.589528471102;8900.643974241088;8938.50838203905;8941.150590693873;9020.323475739346;9023.909760902437;6929.965350173217;6943.444524438033;6951;6994.265602111806;7105.076340075861;1882.2753240002423;1979.7723261824785;1985.1959956217754;1989.1645508886302;1990.0298903686949;1098.3300186885992;1111.5053801058452;1142.3260276436943;1160.14729174057;1197.4252358867793;19249;19270;19843.206271749255;20005.799942000394;20113.39659810208;1129.8757136714955;1143.731223162556;1147;1181.0433548825479;1227.490591404575;10799.40603266828;10917.727056823644;11028.172887033505;11067.612633557786;11125.777484450266;517683;519760;526027;558055;562297;63981;97946.5102674482;103364;103575.48212259042;104841.47579262055;1196.1447564991074;1200.9519619215134;1211.4245733276623;1225.154643296123;1258.087886282456;18309;18379.172937218125;18570.350037749155;18794.248230070643;18948.43154705361;26154.73845261523;27253;29563.85218073896;40210.597894021856;41505.37741933934;56905.14642280286;59719.70140149271;60908.39091609027;61499;62723.37276627358;12544.93727531393;12695.301758403008;12860.807087893501;12860.935695321463;12939.935300323437;14088;14118.50585229512;14146.43414263459;14302.141871487744;14353.569392918229;5918.408159184047;8280.254777070093;11136;11895.405229738306;12694.238345699288;11897.40512974365;12113;12247.632571022526;12465.688357791129;12755.87244127547;10732.248742587944;11018.228723989243;11174.66476005721;11358.886411135783;12263.202891812003;13152.605421837361;13160.144590601964;13186.934065329611;13233;13265.66835829112;10644.308119972176;10726.624568140078;10822.242443028912;10882.238243322892;10895.564177432814 17:39:22 INFO - PROCESS | 25244 | |3;mootools.html;1596.5609457399216;1609.9839001609985;1821.8542516598666;1915.434946690727;1941.5340318323606;7352.669129889155;8272.62773175207;8384.706535271267;8412.579371031446;8431.07258201598;8218.589070546464;8466.619002144902;8501.702440414587;8701.825963480727;8829.117088291168;2422.115927686395;2442.804575633945;2447.7674620910984;2449.081594402099;2455.852648841066;2455.373879660684;2456.5946618807966;2472.4066224106264;2489.8132640051977;2499.9750002499923;2439.195065628347;2456.4718585504115;2483.962740558893;2490.0288887333954;2492.102842976527;2478.9752102479106;2481.47888943323;2483.0688491815567;2488.850668959868;2497.3382053755768;2467.3584867934287;2472.25832250326;2483.416397146669;2486.925392238236;2503.499300139961;8632.309415246766;8763.079876612992;8818.86771698425;8836.779080522974;8841.513716745576;5345.1714984177515;5475.4524547544925;5481.780728770845;5515.751791169407;5519.641223320471;3477.1480987158056;3516.226430185355;3566.732495062855;3580.373434648952;3600.243948770761;1099.1316859680842;1115.983260251097;1122.1467154556576;1145.8453108830286;1148.9655310340704;12071.094667899943;12177.756444871053;12188.39058047103;12238.694032649166;12243.32661703606;4598.287265473857;4609.446866376056;4644.651651126179;4696.319033740088;4710.952890471051;9683.41899486033;9718.514074296258;9725.221982241404;9725.951370243245;9743.561539730728;5328.094223981932;5353.277307563507;5355.49122833338;5356.839294821161;5369.3556773187465;4680.180968330528;4864.5621894029;4867.318575399447;4877.097736918681;4897.338859254026;3852.499175107218;3910.0029492479803;3930;3940.7241493095207;4036.233115708006;1162.6802629277017;1172.7771723372532;1192.4812706472712;1192.7316353820495;1245.906557008228;965.7778710896392;1027.7225149209671;1069.4545781651414;1070.1652710885521;1079.5735684404617;5891.351951285355;5910.438508341701;5976.252968378953;6057.18228039209;6118.541109416722;459.91001326855564;462.5605674609135;465.68566217802845;486.14438588085227;486.19534670121004;3987.940180897289;3988.3419235826345;4001.6998725095737;4010.598940106024;4058.6955978301744;10260.538275777459;10799.67600971972;10974.780504389868;10987.835182472269;11039.39283339408;10546.894531054744;10743.462826858626;10764.78470430587;10876.347419154876;10880;8144.633491492897;8355.791105222417;8382.79043023917;8400.747977560683;8482.194191551793;5704.286964129484;5828.970855145697;5863.17915491823;5864.266966629171;5964.31410387811;9488.620455181992;9583.760405989906;9612.1829644481;9679.806403871742;9715.36850104741;9613.759656008655;9701.320907536405;9834.311598188058;9867.506624668882;9942.900570994198;6204.658743769136;7017.578945263301;7206.963965180141;7402.555846649218;7461.179270280156;8273.214044665747;8459.111793261618;8528.573571321533;8548.700795472378;8583.141685831368;7578.507397019176;7852.136265010959;7861.017372828396;7874;7931.960340198262;7442.1441534222095;7610;7715.189905059888;7766.650500727594;7834.020747406575;7044.15470143586;7052.365287124184;7055.153381594241;7099.680514376969;7108.3602475777425;5172.844814655567;5205.6356055075785;5267.209918512101;5274.920876186937;5310.150375939831;5216.791328346975;5227.843164705065;5230.241614965885;5253.185756207794;5303.7082960436 17:39:22 INFO - PROCESS | 25244 | |4;prototype.html;346.7434098766913;351.84167124793845;356.26431419119524;361.6365552619617;363.4040174114451;6478.481721462277;6580.8025759227185;6715.7985260442265;6716.361945615171;6734.966325168367;6536.607803531791;6556.2132544094775;6636.137302150713;6697.765578204764;6719.126513553243;4802.159622066142;4907.5583197512215;4909.288153217782;4927.0392273506595;4941.135301322272;4952.108620448318;4961.702297862122;4962.230854217584;4962.925556116661;4990.550850423461;4883.609311255091;4898.363212782333;4912.803487860481;4914.778834952435;4915.950840491603;4896.485868983759;4899.583535399495;4900.58345040672;4903.950960490385;4926.507349265081;4247.87256382309;4248.171606536726;4251.702380833343;4252.978735106305;4258.084511829971;6246.531510136758;6264.874702505925;6275.7175927082935;6282.874342513124;6283.465905398047;5585.609007369486;5662.745176467069;5664.433556644344;5677.063284558043;5687.289088863892;6808.38724514796;6843.7604683836325;6844.623545704984;6845.4865885058325;6856.41720453762;4670.766461676936;4675.228587283094;4676.95323046772;4677.2750223715375;4678.157931572316;7130.821729456753;7153.713851445936;7185.209626941085;7199.604021778852;7211.206767255598;4715.481297057321;4725.763711814464;4727.149113159664;4727.669063165546;4734.952650473451;4672.579467847842;4789.688670236424;4822.228443449031;4822.276658501253;4864.051509955595;5647.49172574462;5672.290963629546;5686.545076393879;5689.829305120853;5701.629394089371;6947.930520694728;6948.374646281758;6965.129358830146;6969.616671083139;6987.510874238857;1678.9412370566972;1709.9230534625972;1715.5711072231943;1719.5443207550009;1721.0276193950378;1082.9404382758867;1111.4664960818852;1120.8598925134359;1123.095907794217;1130.2822707580744;6787.728490860409;6794.592324460548;6795.252522222551;6805.6597170141295;6809.591424514545;7189.856202876018;7192;7198.496105272686;7205.4595905307315;7212.278772122746;6561.212654481397;6779.186497620219;6787.287334829772;6787.762428314985;6792.592444453348;3884.1454879926373;3891.2995660780766;3916.725829191986;3920.1179734560064;3926.2736393767245;7607.391408687292;7625.23747625233;7627.046619172604;7635.809104772425;7639.04511936008;7362.631868406558;7403.074615673041;7403.444741644398;7419.109706835215;7432.591207483641;7444.367228785505;7585.051868516435;7591.164971853092;7605.239476052461;7606.467547271638;7161.928380716126;7216.530925489827;7221.53060051095;7226.819329516804;7238.384737297178;7080.291970803085;7123.928760712327;7145.785626431215;7155.42756579462;7156.677949492389;7513.474056816189;7530.811729706582;7573.810654733676;7574.431917606092;7579.962100189464;4676.251799712029;4746.62027037843;4773.069251495925;4787.54518320759;4793.976030119827;7139.785806425608;7207.423406127602;7229.421646268391;7234.131904171533;7245.203027666847;6959.7216111357;7008.579485230903;7009.1589009319205;7009.719611215494;7012.649367531705;6954.095967524189;6967.198772141066;6981.441484681315;6981.755638552626;7014.68433920485;6751.426128779109;6830.21452532965;6848.3494068063455;6870.587764734132;6886.139232595926;6996.475264355092;7037.7184912602925;7048.577085374894;7054.753083642048;7080.398166155935;6881.724731010703;6886.827829304308;6897.965510172417;6903.723851045902;6915.03189553473 17:39:22 INFO - PROCESS | 25244 | |5;yui.html;856.7772379181419;871.3464901324011;899.3434792601402;945.5414124149788;961.5048250151169;14054.859451405508;14143.646408839772;14170.787438188436;14199.858001419983;14255.928720356409;14442.133471991689;14573.489927852528;14600.780988285183;14606.415743370253;16183.676326473464;924.4591913730459;940.0881145289059;940.8306504829128;942.0344147249056;942.2885721280458;915.9542022898828;918.0865039285886;924.4314746430964;924.4407133684125;929.1405449958795;977.4184360305642;977.9022097790236;978.5058545434581;978.872746542952;979.304693667497;955.9952200239023;958.7603099225194;965.8840939087285;966.9951650241774;968.4528241543505;714.7998560403043;718.4791026505794;719.3238355945447;721.2679130682361;721.7942886277385;15071.698566028728;15163.09021458705;15196.468123615621;15229;15318.463853765064;14637.853621463863;14909.179995100265;15010.62473438162;15040.924795375953;15172.393104275816;12208.206466579644;12430.813537796941;12437;12555.686107847285;12586.496540138383;3959.604039596017;3998.2490872372296;4048.1296521247777;4065.6747460203114;4103.651189648884;62894.37105628977;63032;63159.368406316265;63525.36474635287;63879.36120638827;11368.090552755759;11426.485808138654;11917.284962902253;12049.457774400173;12200.389980500939;20379.286724964553;20564.280250191172;20565.280215192695;20573.279935202198;20576.176952922015;8871.852132474649;9075.410098343587;9140.085991400807;9385.249180065579;9650;5079.08576456234;5107.310513080686;5136.5377116059735;5211.2443695663915;5228.424873263938;3684.1894783147663;3735.028892487973;3741.9064523386587;3751.306008388457;3752.061984503874;697.5953946710896;701.7543859649082;704.7920863345325;718.3140101203338;720.1106633307861;669.387510427953;746.0674157303371;750.4671683104948;788.4717239449583;820.9261166495044;9419.481928493999;9895.554700038516;9905.851412228822;10031.175682967298;10181.879655134688;659.581165959619;737.5574655206833;800.087899794235;810.3233799777252;814.1329484099415;4475.4181956345465;4660.277656963176;4853.733044682505;4862.610991120772;4868.853934381974;66505.66747166234;66722.66638666776;67534;67669;72332;53956.73021634945;58552.707236463546;61349.69325153435;64028.359716403174;66976.33023669798;56572.868542628916;57123;58329.125063124084;59166.40833591609;59873.40126598765;9950.701478955643;10007.449590272605;10052.44711540843;10228.744281393025;10265.794684106128;41238.38142427806;41294.58705413028;41406.792966036184;41807.37288940729;41865.162696746505;47675;50777.23834142417;52140;52598.47401526089;52925.47074529359;13670.794938075738;13684.52104176349;13959.302034898012;14036.578902632937;14092.506762263272;14061.648458788612;14584.343704533108;15219;15368.538943831703;15394.923025384802;13031.348432578523;13493;13542.458301667823;13571.050026498051;13707.588772336845;12253.877461225273;12331;13167.670808229488;13580.185188888303;13686.931565342109;13004.154729942524;13111.475540978254;13426.395812188279;13545.525906593222;13684.93157534206;10842.945785271339;10923.563057477611;11301.773964520498;11447.599334023269;11524;10195.337303075275;10894.509747061244;11363.943180284046;11587.246828956091;11715.589954351557 17:39:22 INFO - PROCESS | 25244 | __end_tp_report 17:39:22 INFO - PROCESS | 25244 | __start_cc_report 17:39:22 INFO - PROCESS | 25244 | _x_x_mozilla_cycle_collect,321 17:39:22 INFO - PROCESS | 25244 | __end_cc_report 17:39:22 INFO - PROCESS | 25244 | __startTimestamp1466815162881__endTimestamp 17:39:22 INFO - PROCESS | 25244 | 17:39:22 INFO - PROCESS | 25244 | ------- Summary: start ------- 17:39:22 INFO - PROCESS | 25244 | Number of tests: 6 17:39:22 INFO - PROCESS | 25244 | 17:39:22 INFO - PROCESS | 25244 | [#0] dojo.html Cycles:165 Average:5507.27 Median:5726.51 stddev:610.77 (10.7%) stddev-sans-first:587.12 17:39:22 INFO - PROCESS | 25244 | Values: 3280.1 3351.5 3358.0 3382.1 3404.9 5470.2 5509.4 5512.3 5539.0 5544.7 5474.1 5507.1 5530.8 5537.6 5561.8 4953.9 5013.9 5062.6 5171.8 5204.6 4874.8 4906.3 5077.8 5174.4 5230.8 5106.5 5126.2 5160.2 5175.8 5208.4 5023.8 5030.9 5030.9 5050.7 5064.3 4875.5 4967.0 4969.6 4977.4 5028.9 5312.3 5378.2 5402.3 5418.8 5460.7 5886.7 5888.6 5891.2 5916.8 5921.4 5795.7 5914.3 5963.8 5965.8 5999.5 5532.7 5538.9 5540.0 5541.6 5543.7 6008.4 6009.9 6010.2 6016.1 6021.9 5723.9 5773.2 5837.3 5908.8 5951.4 5935.9 5966.5 5973.0 5974.9 5976.3 5873.9 5908.6 5921.0 5933.4 5948.2 5764.5 5873.2 5899.9 5905.3 5928.6 4474.1 4477.1 4489.2 4490.9 4522.1 4009.5 4044.5 4059.0 4071.7 4078.1 5474.5 5615.1 5662.3 5696.6 5721.3 5949.2 5971.9 5977.3 5980.1 6011.2 5621.4 5625.9 5658.3 5660.5 5680.0 5048.5 5050.9 5060.9 5072.1 5108.0 6100.5 6167.4 6180.6 6187.5 6192.8 5833.3 5863.8 5906.2 5956.2 5986.1 6120.5 6129.9 6130.1 6140.5 6144.7 5814.4 5815.1 5816.9 5817.3 5826.5 5726.5 5916.2 5962.0 6047.9 6048.8 5799.5 5845.4 5854.4 5855.2 5866.1 5756.3 5835.8 5840.8 5842.5 5843.8 5510.3 5686.3 5690.3 5693.0 5729.6 5795.1 5803.0 5858.2 5868.2 5879.1 5426.9 5724.5 5733.3 5738.8 5741.4 17:39:22 INFO - PROCESS | 25244 | 17:39:22 INFO - PROCESS | 25244 | [#1] ext.html Cycles:180 Average:61480.91 Median:237721.07 stddev:118552.10 (49.9%) stddev-sans-first:118796.72 17:39:22 INFO - PROCESS | 25244 | Values: 659.5 678.4 685.8 723.5 736.9 39982.4 40761.8 40762.6 40764.0 40770.6 43787.1 44306.8 44349.8 44437.3 44505.3 8801.3 9110.9 9111.9 9116.0 9128.8 8882.3 8918.9 8924.3 8943.4 8963.8 9224.0 9273.0 9289.3 9303.8 9354.8 9135.3 9177.8 9182.8 9201.5 9203.6 9180.1 9252.0 9257.8 9285.0 9286.5 42496.4 43157.1 43193.1 43294.1 43297.0 3982.3 4020.9 4082.0 4145.8 4184.5 33056.3 33519.8 33691.2 33900.7 34087.3 4313.8 4334.2 4361.3 4411.3 4481.9 333777.0 335302.0 337525.6 341477.0 342970.0 58647.4 59316.4 59375.1 59615.7 59670.7 70750.6 71030.6 71110.6 71137.0 71582.0 18967.6 19119.8 19120.2 19129.5 19132.7 14499.0 14518.3 14586.9 14644.7 14684.6 20154.9 20575.5 20586.0 20638.0 21726.7 7889.8 7952.3 8018.4 8185.9 8206.3 1088.9 1157.2 1176.4 1212.5 1269.2 32882.3 32984.3 33365.8 33706.7 33830.3 1220.2 1263.0 1279.6 1281.1 1281.4 17252.5 17414.0 17605.9 17613.2 17673.5 489757.0 543335.0 544703.0 566207.0 585238.0 63688.0 65631.3 65702.0 65738.0 65765.0 1523.9 1569.1 1577.9 1580.0 1584.6 33441.3 33711.3 33847.3 34191.0 34432.8 55594.0 56287.0 56346.7 56611.2 56842.7 432249.0 432289.0 433634.0 434482.0 434497.0 31382.7 32088.2 32132.2 32327.4 32357.4 50022.2 50269.7 50665.2 51225.1 51697.2 42422.0 42855.4 43143.6 43527.8 43860.3 41557.0 41745.0 42562.6 42680.6 43692.0 44445.6 44806.6 44811.1 45923.0 46452.0 33007.8 33363.3 33942.0 34285.8 34555.5 26828.3 27215.2 29279.6 29303.4 29460.7 17:39:22 INFO - PROCESS | 25244 | 17:39:22 INFO - PROCESS | 25244 | [#2] jquery.html Cycles:180 Average:30784.47 Median:11115.68 stddev:88267.27 (794.1%) stddev-sans-first:88485.42 17:39:22 INFO - PROCESS | 25244 | Values: 412.3 417.5 419.7 424.5 432.3 18698.5 19393.2 19425.1 19595.1 20903.0 20191.7 20393.5 20451.1 20780.3 20786.4 5564.2 5664.3 5828.2 5906.6 5907.1 5769.1 5792.1 5807.3 5813.7 5831.4 5576.3 5762.6 5807.7 5820.8 5836.6 5765.7 5811.9 5821.7 5823.7 5852.2 5149.3 5181.6 5185.4 5228.3 5238.8 23559.6 23971.6 24274.0 24329.9 24392.5 2549.4 2615.8 2623.3 2676.4 2707.1 15386.0 15519.5 15657.2 15907.5 15946.9 2039.7 2049.5 2084.2 2087.2 2136.2 77179.0 79364.0 79464.0 79535.6 80392.6 10907.9 11015.6 11092.8 11104.1 11347.7 15408.2 15546.8 15548.5 15572.9 15633.5 8822.6 8850.7 8916.4 8964.4 9121.6 8900.6 8938.5 8941.2 9020.3 9023.9 6930.0 6943.4 6951.0 6994.3 7105.1 1882.3 1979.8 1985.2 1989.2 1990.0 1098.3 1111.5 1142.3 1160.1 1197.4 19249.0 19270.0 19843.2 20005.8 20113.4 1129.9 1143.7 1147.0 1181.0 1227.5 10799.4 10917.7 11028.2 11067.6 11125.8 517683.0 519760.0 526027.0 558055.0 562297.0 63981.0 97946.5 103364.0 103575.5 104841.5 1196.1 1201.0 1211.4 1225.2 1258.1 18309.0 18379.2 18570.4 18794.2 18948.4 26154.7 27253.0 29563.9 40210.6 41505.4 56905.1 59719.7 60908.4 61499.0 62723.4 12544.9 12695.3 12860.8 12860.9 12939.9 14088.0 14118.5 14146.4 14302.1 14353.6 5918.4 8280.3 11136.0 11895.4 12694.2 11897.4 12113.0 12247.6 12465.7 12755.9 10732.2 11018.2 11174.7 11358.9 12263.2 13152.6 13160.1 13186.9 13233.0 13265.7 10644.3 10726.6 10822.2 10882.2 10895.6 17:39:22 INFO - PROCESS | 25244 | 17:39:22 INFO - PROCESS | 25244 | [#3] mootools.html Cycles:180 Average:5748.17 Median:5211.21 stddev:3188.92 (61.2%) stddev-sans-first:3182.60 17:39:22 INFO - PROCESS | 25244 | Values: 1596.6 1610.0 1821.9 1915.4 1941.5 7352.7 8272.6 8384.7 8412.6 8431.1 8218.6 8466.6 8501.7 8701.8 8829.1 2422.1 2442.8 2447.8 2449.1 2455.9 2455.4 2456.6 2472.4 2489.8 2500.0 2439.2 2456.5 2484.0 2490.0 2492.1 2479.0 2481.5 2483.1 2488.9 2497.3 2467.4 2472.3 2483.4 2486.9 2503.5 8632.3 8763.1 8818.9 8836.8 8841.5 5345.2 5475.5 5481.8 5515.8 5519.6 3477.1 3516.2 3566.7 3580.4 3600.2 1099.1 1116.0 1122.1 1145.8 1149.0 12071.1 12177.8 12188.4 12238.7 12243.3 4598.3 4609.4 4644.7 4696.3 4711.0 9683.4 9718.5 9725.2 9726.0 9743.6 5328.1 5353.3 5355.5 5356.8 5369.4 4680.2 4864.6 4867.3 4877.1 4897.3 3852.5 3910.0 3930.0 3940.7 4036.2 1162.7 1172.8 1192.5 1192.7 1245.9 965.8 1027.7 1069.5 1070.2 1079.6 5891.4 5910.4 5976.3 6057.2 6118.5 459.9 462.6 465.7 486.1 486.2 3987.9 3988.3 4001.7 4010.6 4058.7 10260.5 10799.7 10974.8 10987.8 11039.4 10546.9 10743.5 10764.8 10876.3 10880.0 8144.6 8355.8 8382.8 8400.7 8482.2 5704.3 5829.0 5863.2 5864.3 5964.3 9488.6 9583.8 9612.2 9679.8 9715.4 9613.8 9701.3 9834.3 9867.5 9942.9 6204.7 7017.6 7207.0 7402.6 7461.2 8273.2 8459.1 8528.6 8548.7 8583.1 7578.5 7852.1 7861.0 7874.0 7932.0 7442.1 7610.0 7715.2 7766.7 7834.0 7044.2 7052.4 7055.2 7099.7 7108.4 5172.8 5205.6 5267.2 5274.9 5310.2 5216.8 5227.8 5230.2 5253.2 5303.7 17:39:22 INFO - PROCESS | 25244 | 17:39:22 INFO - PROCESS | 25244 | [#4] prototype.html Cycles:180 Average:5806.38 Median:6743.20 stddev:1802.80 (26.7%) stddev-sans-first:1760.67 17:39:22 INFO - PROCESS | 25244 | Values: 346.7 351.8 356.3 361.6 363.4 6478.5 6580.8 6715.8 6716.4 6735.0 6536.6 6556.2 6636.1 6697.8 6719.1 4802.2 4907.6 4909.3 4927.0 4941.1 4952.1 4961.7 4962.2 4962.9 4990.6 4883.6 4898.4 4912.8 4914.8 4916.0 4896.5 4899.6 4900.6 4904.0 4926.5 4247.9 4248.2 4251.7 4253.0 4258.1 6246.5 6264.9 6275.7 6282.9 6283.5 5585.6 5662.7 5664.4 5677.1 5687.3 6808.4 6843.8 6844.6 6845.5 6856.4 4670.8 4675.2 4677.0 4677.3 4678.2 7130.8 7153.7 7185.2 7199.6 7211.2 4715.5 4725.8 4727.1 4727.7 4735.0 4672.6 4789.7 4822.2 4822.3 4864.1 5647.5 5672.3 5686.5 5689.8 5701.6 6947.9 6948.4 6965.1 6969.6 6987.5 1678.9 1709.9 1715.6 1719.5 1721.0 1082.9 1111.5 1120.9 1123.1 1130.3 6787.7 6794.6 6795.3 6805.7 6809.6 7189.9 7192.0 7198.5 7205.5 7212.3 6561.2 6779.2 6787.3 6787.8 6792.6 3884.1 3891.3 3916.7 3920.1 3926.3 7607.4 7625.2 7627.0 7635.8 7639.0 7362.6 7403.1 7403.4 7419.1 7432.6 7444.4 7585.1 7591.2 7605.2 7606.5 7161.9 7216.5 7221.5 7226.8 7238.4 7080.3 7123.9 7145.8 7155.4 7156.7 7513.5 7530.8 7573.8 7574.4 7580.0 4676.3 4746.6 4773.1 4787.5 4794.0 7139.8 7207.4 7229.4 7234.1 7245.2 6959.7 7008.6 7009.2 7009.7 7012.6 6954.1 6967.2 6981.4 6981.8 7014.7 6751.4 6830.2 6848.3 6870.6 6886.1 6996.5 7037.7 7048.6 7054.8 7080.4 6881.7 6886.8 6898.0 6903.7 6915.0 17:39:22 INFO - PROCESS | 25244 | 17:39:22 INFO - PROCESS | 25244 | [#5] yui.html Cycles:180 Average:16468.90 Median:23170.29 stddev:19441.30 (83.9%) stddev-sans-first:19460.49 17:39:22 INFO - PROCESS | 25244 | Values: 856.8 871.3 899.3 945.5 961.5 14054.9 14143.6 14170.8 14199.9 14255.9 14442.1 14573.5 14600.8 14606.4 16183.7 924.5 940.1 940.8 942.0 942.3 916.0 918.1 924.4 924.4 929.1 977.4 977.9 978.5 978.9 979.3 956.0 958.8 965.9 967.0 968.5 714.8 718.5 719.3 721.3 721.8 15071.7 15163.1 15196.5 15229.0 15318.5 14637.9 14909.2 15010.6 15040.9 15172.4 12208.2 12430.8 12437.0 12555.7 12586.5 3959.6 3998.2 4048.1 4065.7 4103.7 62894.4 63032.0 63159.4 63525.4 63879.4 11368.1 11426.5 11917.3 12049.5 12200.4 20379.3 20564.3 20565.3 20573.3 20576.2 8871.9 9075.4 9140.1 9385.2 9650.0 5079.1 5107.3 5136.5 5211.2 5228.4 3684.2 3735.0 3741.9 3751.3 3752.1 697.6 701.8 704.8 718.3 720.1 669.4 746.1 750.5 788.5 820.9 9419.5 9895.6 9905.9 10031.2 10181.9 659.6 737.6 800.1 810.3 814.1 4475.4 4660.3 4853.7 4862.6 4868.9 66505.7 66722.7 67534.0 67669.0 72332.0 53956.7 58552.7 61349.7 64028.4 66976.3 56572.9 57123.0 58329.1 59166.4 59873.4 9950.7 10007.4 10052.4 10228.7 10265.8 41238.4 41294.6 41406.8 41807.4 41865.2 47675.0 50777.2 52140.0 52598.5 52925.5 13670.8 13684.5 13959.3 14036.6 14092.5 14061.6 14584.3 15219.0 15368.5 15394.9 13031.3 13493.0 13542.5 13571.1 13707.6 12253.9 12331.0 13167.7 13580.2 13686.9 13004.2 13111.5 13426.4 13545.5 13684.9 10842.9 10923.6 11301.8 11447.6 11524.0 10195.3 10894.5 11363.9 11587.2 11715.6 17:39:22 INFO - PROCESS | 25244 | -------- Summary: end -------- 17:39:22 INFO - PROCESS | 25244 | 17:39:23 INFO - TEST-INFO | 25244: exit 0 17:39:23 INFO - TEST-OK | dromaeo_css | took 1108263ms 17:39:23 INFO - TEST-START | kraken 17:39:23 INFO - operating with platform_type : linux_ 17:39:23 INFO - Initialising browser for kraken test... 17:39:23 INFO - TEST-INFO | started process 25484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvFAE5X/profile http://localhost:54437/getInfo.html) 17:39:26 INFO - PROCESS | 25484 | 17:39:26 INFO - PROCESS | 25484 | (process:25563): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:39:27 INFO - PROCESS | 25484 | __metrics Screen width/height:1600/1200 17:39:27 INFO - PROCESS | 25484 | colorDepth:24 17:39:27 INFO - PROCESS | 25484 | Browser inner width/height: 1024/697 17:39:27 INFO - PROCESS | 25484 | __metrics 17:39:28 ERROR - PROCESS | 25484 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 17:39:29 INFO - TEST-INFO | 25484: exit 0 17:39:29 INFO - Browser initialized. 17:39:29 INFO - Running cycle 1/1 for kraken test... 17:39:29 INFO - TEST-INFO | started process 25613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvFAE5X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:30 INFO - PROCESS | 25613 | 17:39:30 INFO - PROCESS | 25613 | (process:25680): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:39:40 INFO - PROCESS | 25613 | RSS: Main: 150433792 17:39:40 INFO - PROCESS | 25613 | 17:39:43 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54437/tests/kraken/driver.html?testName=audio-beat-detection) 17:39:44 INFO - PROCESS | 25613 | RSS: Main: 156237824 17:39:44 INFO - PROCESS | 25613 | 17:39:46 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54437/tests/kraken/driver.html?testName=audio-dft) 17:39:47 INFO - PROCESS | 25613 | RSS: Main: 156254208 17:39:47 INFO - PROCESS | 25613 | 17:39:50 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54437/tests/kraken/driver.html?testName=audio-fft) 17:39:50 INFO - PROCESS | 25613 | RSS: Main: 156303360 17:39:50 INFO - PROCESS | 25613 | 17:39:52 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54437/tests/kraken/driver.html?testName=audio-oscillator) 17:39:53 INFO - PROCESS | 25613 | RSS: Main: 156098560 17:39:53 INFO - PROCESS | 25613 | 17:39:55 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:39:56 INFO - PROCESS | 25613 | RSS: Main: 156196864 17:39:56 INFO - PROCESS | 25613 | 17:39:59 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54437/tests/kraken/driver.html?testName=imaging-darkroom) 17:40:00 INFO - PROCESS | 25613 | RSS: Main: 156463104 17:40:00 INFO - PROCESS | 25613 | 17:40:03 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54437/tests/kraken/driver.html?testName=imaging-desaturate) 17:40:03 INFO - PROCESS | 25613 | RSS: Main: 156897280 17:40:03 INFO - PROCESS | 25613 | 17:40:06 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54437/tests/kraken/driver.html?testName=json-parse-financial) 17:40:07 INFO - PROCESS | 25613 | RSS: Main: 156762112 17:40:07 INFO - PROCESS | 25613 | 17:40:08 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:40:09 INFO - PROCESS | 25613 | RSS: Main: 156504064 17:40:09 INFO - PROCESS | 25613 | 17:40:11 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:40:11 INFO - PROCESS | 25613 | RSS: Main: 156680192 17:40:11 INFO - PROCESS | 25613 | 17:40:13 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:40:14 INFO - PROCESS | 25613 | RSS: Main: 157081600 17:40:14 INFO - PROCESS | 25613 | 17:40:16 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:40:17 INFO - PROCESS | 25613 | RSS: Main: 157290496 17:40:17 INFO - PROCESS | 25613 | 17:40:20 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:40:20 INFO - PROCESS | 25613 | RSS: Main: 157376512 17:40:20 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54437/tests/kraken/driver.html?testName=ai-astar) 17:40:22 INFO - PROCESS | 25613 | RSS: Main: 158961664 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | __start_tp_report 17:40:22 INFO - PROCESS | 25613 | _x_x_mozilla_page_load 17:40:22 INFO - PROCESS | 25613 | _x_x_mozilla_page_load_details 17:40:22 INFO - PROCESS | 25613 | |i|pagename|runs| 17:40:22 INFO - PROCESS | 25613 | |0;ai-astar;109;113;103;111;113;110;101;110;110;112 17:40:22 INFO - PROCESS | 25613 | |1;audio-beat-detection;160;126;164;178;128;157;165;137;182;127 17:40:22 INFO - PROCESS | 25613 | |2;audio-dft;163;162;163;163;162;163;162;162;164;163 17:40:22 INFO - PROCESS | 25613 | |3;audio-fft;73;77;76;171;75;77;76;76;180;76 17:40:22 INFO - PROCESS | 25613 | |4;audio-oscillator;92;93;150;91;92;92;144;93;91;156 17:40:22 INFO - PROCESS | 25613 | |5;imaging-gaussian-blur;118;117;117;117;118;117;118;118;117;116 17:40:22 INFO - PROCESS | 25613 | |6;imaging-darkroom;148;148;146;147;147;149;146;147;146;146 17:40:22 INFO - PROCESS | 25613 | |7;imaging-desaturate;95;95;95;97;94;95;95;95;95;95 17:40:22 INFO - PROCESS | 25613 | |8;json-parse-financial;54;56;57;55;56;56;56;84;55;53 17:40:22 INFO - PROCESS | 25613 | |9;json-stringify-tinderbox;59;59;59;58;58;58;58;59;59;58 17:40:22 INFO - PROCESS | 25613 | |10;stanford-crypto-aes;73;75;75;74;77;76;76;82;74;76 17:40:22 INFO - PROCESS | 25613 | |11;stanford-crypto-ccm;118;113;117;118;119;115;111;114;130;132 17:40:22 INFO - PROCESS | 25613 | |12;stanford-crypto-pbkdf2;172;160;172;162;164;165;166;163;166;167 17:40:22 INFO - PROCESS | 25613 | |13;stanford-crypto-sha256-iterative;68;69;68;67;68;67;65;68;65;69 17:40:22 INFO - PROCESS | 25613 | __end_tp_report 17:40:22 INFO - PROCESS | 25613 | __start_cc_report 17:40:22 INFO - PROCESS | 25613 | _x_x_mozilla_cycle_collect,805 17:40:22 INFO - PROCESS | 25613 | __end_cc_report 17:40:22 INFO - PROCESS | 25613 | __startTimestamp1466815222823__endTimestamp 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | ------- Summary: start ------- 17:40:22 INFO - PROCESS | 25613 | Number of tests: 14 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:4.05 (3.7%) stddev-sans-first:4.29 17:40:22 INFO - PROCESS | 25613 | Values: 109.0 113.0 103.0 111.0 113.0 110.0 101.0 110.0 110.0 112.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:162.00 stddev:21.29 (13.1%) stddev-sans-first:22.40 17:40:22 INFO - PROCESS | 25613 | Values: 160.0 126.0 164.0 178.0 128.0 157.0 165.0 137.0 182.0 127.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 17:40:22 INFO - PROCESS | 25613 | Values: 163.0 162.0 163.0 163.0 162.0 163.0 162.0 162.0 164.0 163.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:42.13 (55.4%) stddev-sans-first:43.87 17:40:22 INFO - PROCESS | 25613 | Values: 73.0 77.0 76.0 171.0 75.0 77.0 76.0 76.0 180.0 76.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.00 stddev:28.17 (30.6%) stddev-sans-first:29.16 17:40:22 INFO - PROCESS | 25613 | Values: 92.0 93.0 150.0 91.0 92.0 92.0 144.0 93.0 91.0 156.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 17:40:22 INFO - PROCESS | 25613 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 116.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 17:40:22 INFO - PROCESS | 25613 | Values: 148.0 148.0 146.0 147.0 147.0 149.0 146.0 147.0 146.0 146.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 17:40:22 INFO - PROCESS | 25613 | Values: 95.0 95.0 95.0 97.0 94.0 95.0 95.0 95.0 95.0 95.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:56.00 stddev:9.14 (16.3%) stddev-sans-first:9.57 17:40:22 INFO - PROCESS | 25613 | Values: 54.0 56.0 57.0 55.0 56.0 56.0 56.0 84.0 55.0 53.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 17:40:22 INFO - PROCESS | 25613 | Values: 59.0 59.0 59.0 58.0 58.0 58.0 58.0 59.0 59.0 58.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:2.49 (3.3%) stddev-sans-first:2.42 17:40:22 INFO - PROCESS | 25613 | Values: 73.0 75.0 75.0 74.0 77.0 76.0 76.0 82.0 74.0 76.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:118.00 stddev:6.96 (5.9%) stddev-sans-first:7.38 17:40:22 INFO - PROCESS | 25613 | Values: 118.0 113.0 117.0 118.0 119.0 115.0 111.0 114.0 130.0 132.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.00 stddev:3.92 (2.4%) stddev-sans-first:3.43 17:40:22 INFO - PROCESS | 25613 | Values: 172.0 160.0 172.0 162.0 164.0 165.0 166.0 163.0 166.0 167.0 17:40:22 INFO - PROCESS | 25613 | 17:40:22 INFO - PROCESS | 25613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.50 17:40:22 INFO - PROCESS | 25613 | Values: 68.0 69.0 68.0 67.0 68.0 67.0 65.0 68.0 65.0 69.0 17:40:22 INFO - PROCESS | 25613 | -------- Summary: end -------- 17:40:22 INFO - PROCESS | 25613 | 17:40:23 INFO - TEST-INFO | 25613: exit 0 17:40:23 INFO - TEST-OK | kraken | took 60093ms 17:40:23 INFO - SUITE-END | took 1168s 17:40:23 INFO - Completed test suite (00:19:28) 17:40:23 INFO - javascript benchmark 17:40:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3280.1307653471827, 3351.5140304655843, 3357.999999999999, 3382.0699307690365, 3404.948925766114, 5470.234167216593, 5509.449055094488, 5512.283403157594, 5539.0, 5544.6673199608, 5474.069408200606, 5507.118860982244, 5530.751116199771, 5537.612367134292, 5561.77752889884, 4953.900921981558, 5013.871878827271, 5062.645614806965, 5171.818986335479, 5204.583633309327, 4874.756262186894, 4906.31311616374, 5077.796888124471, 5174.379074511064, 5230.790768369261, 5106.489351064883, 5126.231065340192, 5160.200168973815, 5175.844724658247, 5208.401033881114, 5023.773930173151, 5030.924536131961, 5030.924536131979, 5050.747462626872, 5064.290999260106, 4875.512448755132, 4966.950330496685, 4969.627277954131, 4977.402711674586, 5028.874278143039, 5312.256284120226, 5378.220158077096, 5402.297701298845, 5418.783248670048, 5460.699661518614, 5886.735096920649, 5888.558358123158, 5891.175235467038, 5916.763329466816, 5921.437463440966, 5795.681237531934, 5914.2902851657645, 5963.7912673056235, 5965.821025369246, 5999.490043346277, 5532.6680399175775, 5538.889222215533, 5540.030494663418, 5541.639793413416, 5543.667379957215, 6008.429199226067, 6009.939900601025, 6010.158577799111, 6016.067509535941, 6021.939780602138, 5723.885522289531, 5773.220615216976, 5837.270341207349, 5908.793192238251, 5951.434613711691, 5935.881282374328, 5966.492848107872, 5972.970135149297, 5974.85062873423, 5976.282846058414, 5873.853153671193, 5908.586398952032, 5921.0, 5933.376995415506, 5948.196993405835, 5764.538836893039, 5873.177755114288, 5899.911501327483, 5905.261842269716, 5928.614640048383, 4474.082813023322, 4477.1269602427865, 4489.19194544985, 4490.932636010462, 4522.050369422393, 4009.498812648419, 4044.474218351654, 4058.9594104058583, 4071.6742660587083, 4078.1028173801715, 5474.534664553478, 5615.073512870413, 5662.320521537442, 5696.572757043238, 5721.313442386857, 5949.167116603679, 5971.910421343683, 5977.282726072899, 5980.132880732356, 6011.218541589566, 5621.409751975983, 5625.943740562624, 5658.264425624642, 5660.5471562274915, 5680.005998950167, 5048.469910659402, 5050.873728156826, 5060.898782024339, 5072.137736584789, 5107.97446012775, 6100.481459076028, 6167.444929956326, 6180.5673602848265, 6187.474064704461, 6192.845178870564, 5833.270841144857, 5863.765449381977, 5906.173135761082, 5956.195913551615, 5986.102084687332, 6120.510359171345, 6129.908051379322, 6130.080487926668, 6140.539459540463, 6144.723487442986, 5814.418558144152, 5815.098659707752, 5816.883662326814, 5817.331006934257, 5826.475617194473, 5726.513246374105, 5916.230889984275, 5961.970190149195, 6047.909281360695, 6048.848778780566, 5799.4780469757925, 5845.41545845412, 5854.443827836349, 5855.151003104611, 5866.149408335853, 5756.280464941882, 5835.824925252249, 5840.795572154954, 5842.474177324061, 5843.824685259449, 5510.311211098613, 5686.34607020198, 5690.2887139107615, 5693.0, 5729.598928074995, 5795.1017592273265, 5803.0, 5858.179854820243, 5868.2077919480325, 5879.05935050407, 5426.891462170814, 5724.513416359489, 5733.340665823317, 5738.8278351649515, 5741.3971532988435], "value": 5467.869323500033, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.5152562866292, 678.4233401608633, 685.7565564224697, 723.486324709456, 736.9263073692631, 39982.40026399602, 40761.796191019006, 40762.592374076215, 40764.0, 40770.59229407705, 43787.12425751491, 44306.7784661077, 44349.77825110878, 44437.33343999842, 44505.33242001373, 8801.251893589053, 9110.86333704995, 9111.908880911205, 9115.95442022789, 9128.771780705501, 8882.289416846668, 8918.910810891874, 8924.286057115447, 8943.418677785923, 8963.775905602346, 9224.03147669495, 9273.0, 9289.256859451261, 9303.76740581484, 9354.766130846716, 9135.314851386172, 9177.816443671156, 9182.770430739218, 9201.539923003824, 9203.585838637244, 9180.081991800833, 9252.0, 9257.768555786091, 9285.0, 9286.489243091628, 42496.3625545617, 43157.13685726268, 43193.13613727739, 43294.13411731779, 43297.0, 3982.26328129297, 4020.9147208222535, 4081.9591804081874, 4145.7927103645, 4184.539700632928, 33056.28259175651, 33519.83240083784, 33691.15772105692, 33900.660993389996, 34087.3413368816, 4313.82744690212, 4334.176506463762, 4361.258586040381, 4411.27214009688, 4481.932771008437, 333777.0, 335302.0, 337525.561860953, 341477.0, 342970.0, 58647.41352586505, 59316.40683593195, 59375.10937335943, 59615.70192149098, 59670.70164649236, 70750.64624676947, 71030.64484677544, 71110.64444677744, 71137.0, 71582.0, 18967.62064758697, 19119.808801911804, 19120.23519059222, 19129.521761955784, 19132.713009304873, 14499.0, 14518.346674399678, 14586.927065364605, 14644.707105857824, 14684.559463216121, 20154.899225503777, 20575.485612859797, 20585.970701464867, 20638.0, 21726.674099888514, 7889.763307100796, 7952.284294413531, 8018.398620103399, 8185.918140818635, 8206.261436470746, 1088.8965548272902, 1157.2246594781516, 1176.3588844079998, 1212.5392350906775, 1269.2384569258556, 32882.3423531528, 32984.3403131936, 33365.83317083399, 33706.66293337084, 33830.323393531995, 1220.2068655374078, 1263.0, 1279.6480967733949, 1281.0648226794306, 1281.3657239666425, 17252.482425527254, 17414.0, 17605.911970440065, 17613.20740566652, 17673.502675392247, 489757.0, 543335.0, 544703.0, 566207.0, 585238.0, 63688.0, 65631.34368656347, 65702.0, 65738.0, 65765.0, 1523.8552337527917, 1569.1448160752418, 1577.8501042400953, 1579.9921000394925, 1584.6196912740859, 33441.33117337591, 33711.3257734839, 33847.3230535383, 34190.97427077192, 34432.82783586166, 55594.0, 56287.0, 56346.71826641005, 56611.15083273672, 56842.715786420806, 432249.0, 432289.0, 433634.0, 434482.0, 434497.0, 31382.68617313889, 32088.197795055312, 32132.19669508281, 32327.35345293128, 32357.35285294234, 50022.24966625576, 50269.74865125651, 50665.24002139897, 51225.133612306774, 51697.224541631156, 42422.0, 42855.35716964186, 43143.56856431396, 43527.78236108799, 43860.342094869244, 41557.0, 41745.0, 42562.57437425586, 42680.57319426766, 43692.0, 44445.55554444544, 44806.55193448024, 44811.10377792491, 45923.0, 46452.0, 33007.83496082504, 33363.33273334471, 33942.0, 34285.82857085699, 34555.481667774504, 26828.329291767863, 27215.183544493695, 29279.56080658749, 29303.41393172082, 29460.705392945798], "value": 21351.453078625596, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.27028160156505, 417.53444908926554, 419.6684619150871, 424.5160517010608, 432.3385220612464, 18698.53253668659, 19393.22427102916, 19425.12586933586, 19595.118219680113, 20903.0, 20191.697124543145, 20393.49016274594, 20451.079701413433, 20780.272690455837, 20786.376408707725, 5564.248826408434, 5664.26364572605, 5828.154917536955, 5906.645601263938, 5907.0548712206055, 5769.076947688371, 5792.073268277077, 5807.332156801958, 5813.709314534256, 5831.446012628793, 5576.302962129734, 5762.625429347079, 5807.680577568232, 5820.796272130477, 5836.6206196597295, 5765.682887441189, 5811.924793913139, 5821.650700957914, 5823.737931793079, 5852.180694702745, 5149.2791009258735, 5181.637285390024, 5185.429602743695, 5228.2680424740565, 5238.842834714965, 23559.646605300935, 23971.64042539346, 24274.0, 24329.87835060831, 24392.512149757084, 2549.4008907906627, 2615.8299710518754, 2623.252373073684, 2676.4111895382985, 2707.052531613939, 15386.0, 15519.456819011393, 15657.217139142997, 15907.522774316789, 15946.9202653986, 2039.653258945968, 2049.5286084200716, 2084.1871670048695, 2087.1964293746864, 2136.220279597951, 77179.0, 79363.99999999942, 79464.0, 79535.6023219886, 80392.59803700945, 10907.945460272647, 11015.614453494089, 11092.833607495893, 11104.056155226895, 11347.659570212907, 15408.15255160977, 15546.84453155454, 15548.455804047031, 15572.92213538925, 15633.452829150925, 8822.647094116164, 8850.690225842194, 8916.420432671855, 8964.372493925493, 9121.589528471102, 8900.643974241088, 8938.50838203905, 8941.150590693873, 9020.323475739346, 9023.909760902437, 6929.965350173217, 6943.444524438033, 6951.0, 6994.265602111806, 7105.076340075861, 1882.2753240002423, 1979.7723261824785, 1985.1959956217754, 1989.1645508886302, 1990.0298903686949, 1098.3300186885992, 1111.5053801058452, 1142.3260276436943, 1160.14729174057, 1197.4252358867793, 19249.0, 19270.0, 19843.206271749255, 20005.799942000394, 20113.39659810208, 1129.8757136714955, 1143.731223162556, 1147.0, 1181.0433548825479, 1227.490591404575, 10799.40603266828, 10917.727056823644, 11028.172887033505, 11067.612633557786, 11125.777484450266, 517683.0, 519760.0, 526027.0, 558055.0, 562297.0, 63981.0, 97946.5102674482, 103364.0, 103575.48212259042, 104841.47579262055, 1196.1447564991074, 1200.9519619215134, 1211.4245733276623, 1225.154643296123, 1258.087886282456, 18309.0, 18379.172937218125, 18570.350037749155, 18794.248230070643, 18948.43154705361, 26154.73845261523, 27253.0, 29563.85218073896, 40210.597894021856, 41505.37741933934, 56905.14642280286, 59719.70140149271, 60908.39091609027, 61499.0, 62723.37276627358, 12544.93727531393, 12695.301758403008, 12860.807087893501, 12860.935695321463, 12939.935300323437, 14088.0, 14118.50585229512, 14146.43414263459, 14302.141871487744, 14353.569392918229, 5918.408159184047, 8280.254777070093, 11136.0, 11895.405229738306, 12694.238345699288, 11897.40512974365, 12113.0, 12247.632571022526, 12465.688357791129, 12755.87244127547, 10732.248742587944, 11018.228723989243, 11174.66476005721, 11358.886411135783, 12263.202891812003, 13152.605421837361, 13160.144590601964, 13186.934065329611, 13233.0, 13265.66835829112, 10644.308119972176, 10726.624568140078, 10822.242443028912, 10882.238243322892, 10895.564177432814], "value": 9913.73584008763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1596.5609457399216, 1609.9839001609985, 1821.8542516598666, 1915.434946690727, 1941.5340318323606, 7352.669129889155, 8272.62773175207, 8384.706535271267, 8412.579371031446, 8431.07258201598, 8218.589070546464, 8466.619002144902, 8501.702440414587, 8701.825963480727, 8829.117088291168, 2422.115927686395, 2442.804575633945, 2447.7674620910984, 2449.081594402099, 2455.852648841066, 2455.373879660684, 2456.5946618807966, 2472.4066224106264, 2489.8132640051977, 2499.9750002499923, 2439.195065628347, 2456.4718585504115, 2483.962740558893, 2490.0288887333954, 2492.102842976527, 2478.9752102479106, 2481.47888943323, 2483.0688491815567, 2488.850668959868, 2497.3382053755768, 2467.3584867934287, 2472.25832250326, 2483.416397146669, 2486.925392238236, 2503.499300139961, 8632.309415246766, 8763.079876612992, 8818.86771698425, 8836.779080522974, 8841.513716745576, 5345.1714984177515, 5475.4524547544925, 5481.780728770845, 5515.751791169407, 5519.641223320471, 3477.1480987158056, 3516.226430185355, 3566.732495062855, 3580.373434648952, 3600.243948770761, 1099.1316859680842, 1115.983260251097, 1122.1467154556576, 1145.8453108830286, 1148.9655310340704, 12071.094667899943, 12177.756444871053, 12188.39058047103, 12238.694032649166, 12243.32661703606, 4598.287265473857, 4609.446866376056, 4644.651651126179, 4696.319033740088, 4710.952890471051, 9683.41899486033, 9718.514074296258, 9725.221982241404, 9725.951370243245, 9743.561539730728, 5328.094223981932, 5353.277307563507, 5355.49122833338, 5356.839294821161, 5369.3556773187465, 4680.180968330528, 4864.5621894029, 4867.318575399447, 4877.097736918681, 4897.338859254026, 3852.499175107218, 3910.0029492479803, 3930.0, 3940.7241493095207, 4036.233115708006, 1162.6802629277017, 1172.7771723372532, 1192.4812706472712, 1192.7316353820495, 1245.906557008228, 965.7778710896392, 1027.7225149209671, 1069.4545781651414, 1070.1652710885521, 1079.5735684404617, 5891.351951285355, 5910.438508341701, 5976.252968378953, 6057.18228039209, 6118.541109416722, 459.91001326855564, 462.5605674609135, 465.68566217802845, 486.14438588085227, 486.19534670121004, 3987.940180897289, 3988.3419235826345, 4001.6998725095737, 4010.598940106024, 4058.6955978301744, 10260.538275777459, 10799.67600971972, 10974.780504389868, 10987.835182472269, 11039.39283339408, 10546.894531054744, 10743.462826858626, 10764.78470430587, 10876.347419154876, 10880.0, 8144.633491492897, 8355.791105222417, 8382.79043023917, 8400.747977560683, 8482.194191551793, 5704.286964129484, 5828.970855145697, 5863.17915491823, 5864.266966629171, 5964.31410387811, 9488.620455181992, 9583.760405989906, 9612.1829644481, 9679.806403871742, 9715.36850104741, 9613.759656008655, 9701.320907536405, 9834.311598188058, 9867.506624668882, 9942.900570994198, 6204.658743769136, 7017.578945263301, 7206.963965180141, 7402.555846649218, 7461.179270280156, 8273.214044665747, 8459.111793261618, 8528.573571321533, 8548.700795472378, 8583.141685831368, 7578.507397019176, 7852.136265010959, 7861.017372828396, 7874.0, 7931.960340198262, 7442.1441534222095, 7610.0, 7715.189905059888, 7766.650500727594, 7834.020747406575, 7044.15470143586, 7052.365287124184, 7055.153381594241, 7099.680514376969, 7108.3602475777425, 5172.844814655567, 5205.6356055075785, 5267.209918512101, 5274.920876186937, 5310.150375939831, 5216.791328346975, 5227.843164705065, 5230.241614965885, 5253.185756207794, 5303.7082960436], "value": 4586.820708937421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.7434098766913, 351.84167124793845, 356.26431419119524, 361.6365552619617, 363.4040174114451, 6478.481721462277, 6580.8025759227185, 6715.7985260442265, 6716.361945615171, 6734.966325168367, 6536.607803531791, 6556.2132544094775, 6636.137302150713, 6697.765578204764, 6719.126513553243, 4802.159622066142, 4907.5583197512215, 4909.288153217782, 4927.0392273506595, 4941.135301322272, 4952.108620448318, 4961.702297862122, 4962.230854217584, 4962.925556116661, 4990.550850423461, 4883.609311255091, 4898.363212782333, 4912.803487860481, 4914.778834952435, 4915.950840491603, 4896.485868983759, 4899.583535399495, 4900.58345040672, 4903.950960490385, 4926.507349265081, 4247.87256382309, 4248.171606536726, 4251.702380833343, 4252.978735106305, 4258.084511829971, 6246.531510136758, 6264.874702505925, 6275.7175927082935, 6282.874342513124, 6283.465905398047, 5585.609007369486, 5662.745176467069, 5664.433556644344, 5677.063284558043, 5687.289088863892, 6808.38724514796, 6843.7604683836325, 6844.623545704984, 6845.4865885058325, 6856.41720453762, 4670.766461676936, 4675.228587283094, 4676.95323046772, 4677.2750223715375, 4678.157931572316, 7130.821729456753, 7153.713851445936, 7185.209626941085, 7199.604021778852, 7211.206767255598, 4715.481297057321, 4725.763711814464, 4727.149113159664, 4727.669063165546, 4734.952650473451, 4672.579467847842, 4789.688670236424, 4822.228443449031, 4822.276658501253, 4864.051509955595, 5647.49172574462, 5672.290963629546, 5686.545076393879, 5689.829305120853, 5701.629394089371, 6947.930520694728, 6948.374646281758, 6965.129358830146, 6969.616671083139, 6987.510874238857, 1678.9412370566972, 1709.9230534625972, 1715.5711072231943, 1719.5443207550009, 1721.0276193950378, 1082.9404382758867, 1111.4664960818852, 1120.8598925134359, 1123.095907794217, 1130.2822707580744, 6787.728490860409, 6794.592324460548, 6795.252522222551, 6805.6597170141295, 6809.591424514545, 7189.856202876018, 7192.0, 7198.496105272686, 7205.4595905307315, 7212.278772122746, 6561.212654481397, 6779.186497620219, 6787.287334829772, 6787.762428314985, 6792.592444453348, 3884.1454879926373, 3891.2995660780766, 3916.725829191986, 3920.1179734560064, 3926.2736393767245, 7607.391408687292, 7625.23747625233, 7627.046619172604, 7635.809104772425, 7639.04511936008, 7362.631868406558, 7403.074615673041, 7403.444741644398, 7419.109706835215, 7432.591207483641, 7444.367228785505, 7585.051868516435, 7591.164971853092, 7605.239476052461, 7606.467547271638, 7161.928380716126, 7216.530925489827, 7221.53060051095, 7226.819329516804, 7238.384737297178, 7080.291970803085, 7123.928760712327, 7145.785626431215, 7155.42756579462, 7156.677949492389, 7513.474056816189, 7530.811729706582, 7573.810654733676, 7574.431917606092, 7579.962100189464, 4676.251799712029, 4746.62027037843, 4773.069251495925, 4787.54518320759, 4793.976030119827, 7139.785806425608, 7207.423406127602, 7229.421646268391, 7234.131904171533, 7245.203027666847, 6959.7216111357, 7008.579485230903, 7009.1589009319205, 7009.719611215494, 7012.649367531705, 6954.095967524189, 6967.198772141066, 6981.441484681315, 6981.755638552626, 7014.68433920485, 6751.426128779109, 6830.21452532965, 6848.3494068063455, 6870.587764734132, 6886.139232595926, 6996.475264355092, 7037.7184912602925, 7048.577085374894, 7054.753083642048, 7080.398166155935, 6881.724731010703, 6886.827829304308, 6897.965510172417, 6903.723851045902, 6915.03189553473], "value": 5211.660556192023, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.7772379181419, 871.3464901324011, 899.3434792601402, 945.5414124149788, 961.5048250151169, 14054.859451405508, 14143.646408839772, 14170.787438188436, 14199.858001419983, 14255.928720356409, 14442.133471991689, 14573.489927852528, 14600.780988285183, 14606.415743370253, 16183.676326473464, 924.4591913730459, 940.0881145289059, 940.8306504829128, 942.0344147249056, 942.2885721280458, 915.9542022898828, 918.0865039285886, 924.4314746430964, 924.4407133684125, 929.1405449958795, 977.4184360305642, 977.9022097790236, 978.5058545434581, 978.872746542952, 979.304693667497, 955.9952200239023, 958.7603099225194, 965.8840939087285, 966.9951650241774, 968.4528241543505, 714.7998560403043, 718.4791026505794, 719.3238355945447, 721.2679130682361, 721.7942886277385, 15071.698566028728, 15163.09021458705, 15196.468123615621, 15229.0, 15318.463853765064, 14637.853621463863, 14909.179995100265, 15010.62473438162, 15040.924795375953, 15172.393104275816, 12208.206466579644, 12430.813537796941, 12437.0, 12555.686107847285, 12586.496540138383, 3959.604039596017, 3998.2490872372296, 4048.1296521247777, 4065.6747460203114, 4103.651189648884, 62894.37105628977, 63032.0, 63159.368406316265, 63525.36474635287, 63879.36120638827, 11368.090552755759, 11426.485808138654, 11917.284962902253, 12049.457774400173, 12200.389980500939, 20379.286724964553, 20564.280250191172, 20565.280215192695, 20573.279935202198, 20576.176952922015, 8871.852132474649, 9075.410098343587, 9140.085991400807, 9385.249180065579, 9650.0, 5079.08576456234, 5107.310513080686, 5136.5377116059735, 5211.2443695663915, 5228.424873263938, 3684.1894783147663, 3735.028892487973, 3741.9064523386587, 3751.306008388457, 3752.061984503874, 697.5953946710896, 701.7543859649082, 704.7920863345325, 718.3140101203338, 720.1106633307861, 669.387510427953, 746.0674157303371, 750.4671683104948, 788.4717239449583, 820.9261166495044, 9419.481928493999, 9895.554700038516, 9905.851412228822, 10031.175682967298, 10181.879655134688, 659.581165959619, 737.5574655206833, 800.087899794235, 810.3233799777252, 814.1329484099415, 4475.4181956345465, 4660.277656963176, 4853.733044682505, 4862.610991120772, 4868.853934381974, 66505.66747166234, 66722.66638666776, 67534.0, 67669.0, 72332.0, 53956.73021634945, 58552.707236463546, 61349.69325153435, 64028.359716403174, 66976.33023669798, 56572.868542628916, 57123.0, 58329.125063124084, 59166.40833591609, 59873.40126598765, 9950.701478955643, 10007.449590272605, 10052.44711540843, 10228.744281393025, 10265.794684106128, 41238.38142427806, 41294.58705413028, 41406.792966036184, 41807.37288940729, 41865.162696746505, 47675.0, 50777.23834142417, 52140.0, 52598.47401526089, 52925.47074529359, 13670.794938075738, 13684.52104176349, 13959.302034898012, 14036.578902632937, 14092.506762263272, 14061.648458788612, 14584.343704533108, 15219.0, 15368.538943831703, 15394.923025384802, 13031.348432578523, 13493.0, 13542.458301667823, 13571.050026498051, 13707.588772336845, 12253.877461225273, 12331.0, 13167.670808229488, 13580.185188888303, 13686.931565342109, 13004.154729942524, 13111.475540978254, 13426.395812188279, 13545.525906593222, 13684.93157534206, 10842.945785271339, 10923.563057477611, 11301.773964520498, 11447.599334023269, 11524.0, 10195.337303075275, 10894.509747061244, 11363.943180284046, 11587.246828956091, 11715.589954351557], "value": 7415.918290880686, "unit": "score"}], "name": "dromaeo_css", "value": 7680.027285194492, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 103.0, 111.0, 113.0, 110.0, 101.0, 110.0, 110.0, 112.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 164.0, 178.0, 128.0, 157.0, 165.0, 137.0, 182.0, 127.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 162.0, 163.0, 162.0, 162.0, 164.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 76.0, 171.0, 75.0, 77.0, 76.0, 76.0, 180.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 150.0, 91.0, 92.0, 92.0, 144.0, 93.0, 91.0, 156.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 147.0, 147.0, 149.0, 146.0, 147.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 57.0, 55.0, 56.0, 56.0, 56.0, 84.0, 55.0, 53.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 74.0, 77.0, 76.0, 76.0, 82.0, 74.0, 76.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 113.0, 117.0, 118.0, 119.0, 115.0, 111.0, 114.0, 130.0, 132.0], "value": 118.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 160.0, 172.0, 162.0, 164.0, 165.0, 166.0, 163.0, 166.0, 167.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 68.0, 67.0, 65.0, 68.0, 65.0, 69.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1533.1000000000001, "alertThreshold": 2.0}]} 17:40:24 INFO - Return code: 0 17:40:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:40:24 ERROR - # TBPL SUCCESS # 17:40:24 INFO - Running post-action listener: _resource_record_post_action 17:40:24 INFO - Running post-run listener: _resource_record_post_run 17:40:25 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323903488; Read time: 28; Write time: 154328 17:40:25 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 100093952; Read time: 0; Write time: 58956 17:40:25 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 223809536; Read time: 28; Write time: 95372 17:40:25 INFO - Running post-run listener: _upload_blobber_files 17:40:25 INFO - Blob upload gear active. 17:40:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:40:25 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 17:40:25 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:40:25 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:40:25 INFO - (blobuploader) - INFO - Open directory for files ... 17:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:40:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:26 INFO - (blobuploader) - INFO - Done attempting. 17:40:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:40:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:40:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:27 INFO - (blobuploader) - INFO - Done attempting. 17:40:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:40:27 INFO - Return code: 0 17:40:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:40:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:40:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb0356237f9a6d4210da16c6ca4fe8e7ffa1cef4788c1c9b0da274b218b116710d0bdbc01c174ad8f2d076e2d5d6c0525f9534b3d4e2cadf99697faba45789b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f990bd6737daee0ea3dbfb4d40c74faa0ea9e29d023129cd4fec0ae4fde581996d03848f5a11a808e56ce2d0d1f0c5393ca6b94106b893660e3e88d39bcfde9f"} 17:40:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:40:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:40:27 INFO - Contents: 17:40:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb0356237f9a6d4210da16c6ca4fe8e7ffa1cef4788c1c9b0da274b218b116710d0bdbc01c174ad8f2d076e2d5d6c0525f9534b3d4e2cadf99697faba45789b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f990bd6737daee0ea3dbfb4d40c74faa0ea9e29d023129cd4fec0ae4fde581996d03848f5a11a808e56ce2d0d1f0c5393ca6b94106b893660e3e88d39bcfde9f"} 17:40:27 INFO - Running post-run listener: copy_logs_to_upload_dir 17:40:27 INFO - Copying logs to upload dir... 17:40:27 INFO - mkdir: /builds/slave/test/build/upload/logs 17:40:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.544161 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-24 17:40:26.760574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 17:40:26.764539) ========= 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=1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324 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-Beta/sha512/eb0356237f9a6d4210da16c6ca4fe8e7ffa1cef4788c1c9b0da274b218b116710d0bdbc01c174ad8f2d076e2d5d6c0525f9534b3d4e2cadf99697faba45789b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f990bd6737daee0ea3dbfb4d40c74faa0ea9e29d023129cd4fec0ae4fde581996d03848f5a11a808e56ce2d0d1f0c5393ca6b94106b893660e3e88d39bcfde9f"} build_url:https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb0356237f9a6d4210da16c6ca4fe8e7ffa1cef4788c1c9b0da274b218b116710d0bdbc01c174ad8f2d076e2d5d6c0525f9534b3d4e2cadf99697faba45789b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f990bd6737daee0ea3dbfb4d40c74faa0ea9e29d023129cd4fec0ae4fde581996d03848f5a11a808e56ce2d0d1f0c5393ca6b94106b893660e3e88d39bcfde9f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 17:40:26.790591) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 17:40:26.790896) ========= 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=1f5564757af27664ca02d71f000001b0-1466812571.644856-1834286324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 17:40:26.876578) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 17:40:26.877128) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 17:40:26.877617) ========= ========= Total master_lag: 0.21 =========