builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1467032694.4 results: success (0) buildid: 20160624143557 builduid: 67b95f07284347e7aea2678b4c3b20e6 revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:54.403276) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:54.403854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:54.404263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:54.420687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:54.421100) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 06:04:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.5M=0s 2016-06-27 06:04:55 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116686 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:54.555742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:54.556455) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020570 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:54.611200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:54.611619) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 06:04:55,443 truncating revision to first 12 chars 2016-06-27 06:04:55,443 Setting DEBUG logging. 2016-06-27 06:04:55,443 attempt 1/10 2016-06-27 06:04:55,443 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-27 06:04:55,764 unpacking tar archive at: mozilla-beta-229741b7de04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.728118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:55.356055) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:55.356746) ========= script_repo_revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:55.357689) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:55.358315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:55.370014) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 19 secs) (at 2016-06-27 06:04:55.370341) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:04:56 INFO - MultiFileLogger online at 20160627 06:04:56 in /builds/slave/test 06:04:56 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 06:04:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:04:56 INFO - {'append_to_log': False, 06:04:56 INFO - 'base_work_dir': '/builds/slave/test', 06:04:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:04:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:04:56 INFO - 'branch': 'Mozilla-Beta', 06:04:56 INFO - 'buildbot_json_path': 'buildprops.json', 06:04:56 INFO - 'config_files': ('talos/linux_config.py',), 06:04:56 INFO - 'default_actions': ('clobber', 06:04:56 INFO - 'read-buildbot-config', 06:04:56 INFO - 'download-and-extract', 06:04:56 INFO - 'populate-webroot', 06:04:56 INFO - 'create-virtualenv', 06:04:56 INFO - 'install', 06:04:56 INFO - 'run-tests'), 06:04:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:04:56 INFO - 'download_minidump_stackwalk': True, 06:04:56 INFO - 'download_symbols': 'ondemand', 06:04:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:04:56 INFO - 'tooltool.py': '/tools/tooltool.py', 06:04:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:04:56 INFO - '/tools/misc-python/virtualenv.py')}, 06:04:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:04:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:04:56 INFO - 'installer_path': 'installer.exe', 06:04:56 INFO - 'log_level': 'info', 06:04:56 INFO - 'log_name': 'talos', 06:04:56 INFO - 'log_to_console': True, 06:04:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:04:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:04:56 INFO - 'opt_config_files': (), 06:04:56 INFO - 'pip_index': False, 06:04:56 INFO - 'sps_profile': False, 06:04:56 INFO - 'sps_profile_interval': 0, 06:04:56 INFO - 'suite': 'dromaeojs-e10s', 06:04:56 INFO - 'system_bits': '32', 06:04:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:04:56 INFO - 'title': 'talos-linux64-ix-012', 06:04:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:04:56 INFO - 'use_talos_json': True, 06:04:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:04:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:04:56 INFO - 'work_dir': 'build'} 06:04:56 INFO - ##### 06:04:56 INFO - ##### Running clobber step. 06:04:56 INFO - ##### 06:04:56 INFO - Running pre-action listener: _resource_record_pre_action 06:04:56 INFO - Running main action method: clobber 06:04:56 INFO - rmtree: /builds/slave/test/build 06:04:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:04:56 INFO - Running post-action listener: _resource_record_post_action 06:04:56 INFO - ##### 06:04:56 INFO - ##### Running read-buildbot-config step. 06:04:56 INFO - ##### 06:04:56 INFO - Running pre-action listener: _resource_record_pre_action 06:04:56 INFO - Running main action method: read_buildbot_config 06:04:56 INFO - Using buildbot properties: 06:04:56 INFO - { 06:04:56 INFO - "project": "", 06:04:56 INFO - "product": "firefox", 06:04:56 INFO - "script_repo_revision": "production", 06:04:56 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 06:04:56 INFO - "repository": "", 06:04:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 06:04:56 INFO - "buildid": "20160624143557", 06:04:56 INFO - "pgo_build": "True", 06:04:56 INFO - "basedir": "/builds/slave/test", 06:04:56 INFO - "buildnumber": 147, 06:04:56 INFO - "slavename": "talos-linux64-ix-012", 06:04:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:04:56 INFO - "platform": "ubuntu64_hw", 06:04:56 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:04:56 INFO - "branch": "mozilla-beta", 06:04:56 INFO - "repo_path": "releases/mozilla-beta", 06:04:56 INFO - "revision": "229741b7de0485ca56b91e0e657fe5d37dbbc98f", 06:04:56 INFO - "stage_platform": "linux64-pgo", 06:04:56 INFO - "builduid": "67b95f07284347e7aea2678b4c3b20e6", 06:04:56 INFO - "slavebuilddir": "test" 06:04:56 INFO - } 06:04:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 06:04:56 INFO - Running post-action listener: _resource_record_post_action 06:04:56 INFO - ##### 06:04:56 INFO - ##### Running download-and-extract step. 06:04:56 INFO - ##### 06:04:56 INFO - Running pre-action listener: _resource_record_pre_action 06:04:56 INFO - Running main action method: download_and_extract 06:04:56 INFO - mkdir: /builds/slave/test/build/tests 06:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:56 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 06:04:56 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 06:04:56 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 06:04:56 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 06:04:56 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 06:04:57 INFO - Downloaded 1327 bytes. 06:04:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:04:57 INFO - Using the following test package requirements: 06:04:57 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:04:57 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:57 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:04:57 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:57 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:04:57 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:57 INFO - u'jsshell-linux-x86_64.zip'], 06:04:57 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:57 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:04:57 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:04:57 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:57 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:04:57 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:57 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:04:57 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:57 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:04:57 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:57 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:04:57 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:57 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 06:04:57 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 06:04:57 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 06:04:57 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 06:04:57 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 06:04:58 INFO - Downloaded 24228390 bytes. 06:04:58 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'] 06:04:58 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 06:04:59 INFO - Return code: 0 06:04:59 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 06:04:59 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')]} 06:04:59 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 06:04:59 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 06:04:59 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 06:04:59 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 06:04:59 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 06:05:01 INFO - Downloaded 24228390 bytes. 06:05: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'] 06:05: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 06:05:02 INFO - Return code: 0 06:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:03 INFO - Downloaded 10840145 bytes. 06:05:03 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'] 06:05:03 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 06:05:03 INFO - Return code: 0 06:05: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')]} 06:05:03 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 06:05: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.tar.bz2 06:05: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.tar.bz2 06:05: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.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:05:03 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 06:05:04 INFO - Downloaded 56007799 bytes. 06:05:04 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 06:05:04 INFO - mkdir: /builds/slave/test/properties 06:05:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:05:04 INFO - Writing to file /builds/slave/test/properties/build_url 06:05:04 INFO - Contents: 06:05:04 INFO - build_url:https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:05:05 INFO - Running post-action listener: _resource_record_post_action 06:05:05 INFO - Running post-action listener: set_extra_try_arguments 06:05:05 INFO - ##### 06:05:05 INFO - ##### Running populate-webroot step. 06:05:05 INFO - ##### 06:05:05 INFO - Running pre-action listener: _resource_record_pre_action 06:05:05 INFO - Running main action method: populate_webroot 06:05:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:05:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:05:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:05:05 INFO - '--tppagecycles', 06:05:05 INFO - '7'], 06:05:05 INFO - 'tests': ['tsvgm']}}, 06:05:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:05:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:05:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:05:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:05:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:05:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:05:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:05 INFO - 'talos_options': ['--disable-e10s'], 06:05:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:05 INFO - 'talos_options': ['--disable-e10s'], 06:05:05 INFO - 'tests': ['damp', 'tps']}, 06:05:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:05 INFO - 'tests': ['damp', 'tps']}, 06:05:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:05:05 INFO - 'tests': ['dromaeo_dom']}, 06:05:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:05:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:05:05 INFO - 'tests': ['a11yr', 06:05:05 INFO - 'ts_paint', 06:05:05 INFO - 'tpaint', 06:05:05 INFO - 'sessionrestore', 06:05:05 INFO - 'sessionrestore_no_auto_restore', 06:05:05 INFO - 'tabpaint']}, 06:05:05 INFO - 'other-e10s': {'tests': ['a11yr', 06:05:05 INFO - 'ts_paint', 06:05:05 INFO - 'tpaint', 06:05:05 INFO - 'sessionrestore', 06:05:05 INFO - 'sessionrestore_no_auto_restore', 06:05:05 INFO - 'tabpaint']}, 06:05:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:05:05 INFO - 'ts_paint', 06:05:05 INFO - 'tpaint', 06:05:05 INFO - 'sessionrestore', 06:05:05 INFO - 'sessionrestore_no_auto_restore', 06:05:05 INFO - 'tabpaint']}, 06:05:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:05:05 INFO - 'ts_paint', 06:05:05 INFO - 'tpaint', 06:05:05 INFO - 'sessionrestore', 06:05:05 INFO - 'sessionrestore_no_auto_restore', 06:05:05 INFO - 'tabpaint']}, 06:05:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:05:05 INFO - 'tests': ['a11yr', 06:05:05 INFO - 'ts_paint', 06:05:05 INFO - 'tpaint', 06:05:05 INFO - 'sessionrestore', 06:05:05 INFO - 'sessionrestore_no_auto_restore', 06:05:05 INFO - 'tabpaint']}, 06:05:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:05:05 INFO - 'tests': ['a11yr', 06:05:05 INFO - 'ts_paint', 06:05:05 INFO - 'tpaint', 06:05:05 INFO - 'sessionrestore', 06:05:05 INFO - 'sessionrestore_no_auto_restore', 06:05:05 INFO - 'tabpaint']}, 06:05:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:05:05 INFO - 'tests': ['tsvgx', 06:05:05 INFO - 'tsvgr_opacity', 06:05:05 INFO - 'tart', 06:05:05 INFO - 'tscrollx', 06:05:05 INFO - 'cart']}, 06:05:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:05:05 INFO - 'tsvgr_opacity', 06:05:05 INFO - 'tart', 06:05:05 INFO - 'tscrollx', 06:05:05 INFO - 'cart']}, 06:05:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:05 INFO - 'talos_options': ['--disable-e10s'], 06:05:05 INFO - 'tests': ['tp5o']}, 06:05:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:05 INFO - 'tests': ['tp5o']}, 06:05:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:05 INFO - 'talos_options': ['--disable-e10s', 06:05:05 INFO - '--xperf_path', 06:05:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:05 INFO - 'tests': ['tp5n']}, 06:05:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:05 INFO - 'talos_options': ['--xperf_path', 06:05:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:05 INFO - 'tests': ['tp5n']}}, 06:05:05 INFO - 'talos.zip': {'path': '', 06:05:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:05:05 INFO - Running post-action listener: _resource_record_post_action 06:05:05 INFO - ##### 06:05:05 INFO - ##### Running create-virtualenv step. 06:05:05 INFO - ##### 06:05:05 INFO - Running pre-action listener: _resource_record_pre_action 06:05:05 INFO - Running main action method: create_virtualenv 06:05:05 INFO - Creating virtualenv /builds/slave/test/build/venv 06:05:05 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 06:05:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:05:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:05:05 INFO - Using real prefix '/usr' 06:05:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:05:06 INFO - Installing distribute.............................................................................................................................................................................................done. 06:05:08 INFO - Installing pip.................done. 06:05:08 INFO - Return code: 0 06:05:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f541b39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd410>, '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 0x24be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', '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 06:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:05:08 INFO - Using env: {'DISPLAY': ':0', 06:05:08 INFO - 'HOME': '/home/cltbld', 06:05:08 INFO - 'LANG': 'en_US.UTF-8', 06:05:08 INFO - 'LANGUAGE': 'en_US:en', 06:05:08 INFO - 'LOGNAME': 'cltbld', 06:05:08 INFO - 'MAIL': '/var/mail/cltbld', 06:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:08 INFO - 'MOZ_NO_REMOTE': '1', 06:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:08 INFO - 'NO_EM_RESTART': '1', 06:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:08 INFO - 'PWD': '/builds/slave/test', 06:05:08 INFO - 'SHELL': '/bin/bash', 06:05:08 INFO - 'SHLVL': '1', 06:05:08 INFO - 'TERM': 'linux', 06:05:08 INFO - 'TMOUT': '86400', 06:05:08 INFO - 'USER': 'cltbld', 06:05:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', 06:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:08 INFO - '_': '/tools/buildbot/bin/python'} 06:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:08 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 06:05:08 INFO - Cleaning up... 06:05:08 INFO - Return code: 0 06:05:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f541b39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd410>, '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 0x24be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', '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 06:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:05:08 INFO - Using env: {'DISPLAY': ':0', 06:05:08 INFO - 'HOME': '/home/cltbld', 06:05:08 INFO - 'LANG': 'en_US.UTF-8', 06:05:08 INFO - 'LANGUAGE': 'en_US:en', 06:05:08 INFO - 'LOGNAME': 'cltbld', 06:05:08 INFO - 'MAIL': '/var/mail/cltbld', 06:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:08 INFO - 'MOZ_NO_REMOTE': '1', 06:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:08 INFO - 'NO_EM_RESTART': '1', 06:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:08 INFO - 'PWD': '/builds/slave/test', 06:05:08 INFO - 'SHELL': '/bin/bash', 06:05:08 INFO - 'SHLVL': '1', 06:05:08 INFO - 'TERM': 'linux', 06:05:08 INFO - 'TMOUT': '86400', 06:05:08 INFO - 'USER': 'cltbld', 06:05:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', 06:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:08 INFO - '_': '/tools/buildbot/bin/python'} 06:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:08 INFO - Downloading/unpacking psutil>=0.7.1 06:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:05:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:10 INFO - Installing collected packages: psutil 06:05:10 INFO - Running setup.py install for psutil 06:05:10 INFO - building 'psutil._psutil_linux' extension 06:05:10 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 06:05:10 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 06:05:10 INFO - building 'psutil._psutil_posix' extension 06:05:10 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 06:05:11 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 06:05:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:11 INFO - Successfully installed psutil 06:05:11 INFO - Cleaning up... 06:05:11 INFO - Return code: 0 06:05:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:05: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')]} 06:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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')]} 06:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f541b39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd410>, '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 0x24be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', '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 06:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:05:11 INFO - Using env: {'DISPLAY': ':0', 06:05:11 INFO - 'HOME': '/home/cltbld', 06:05:11 INFO - 'LANG': 'en_US.UTF-8', 06:05:11 INFO - 'LANGUAGE': 'en_US:en', 06:05:11 INFO - 'LOGNAME': 'cltbld', 06:05:11 INFO - 'MAIL': '/var/mail/cltbld', 06:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:11 INFO - 'MOZ_NO_REMOTE': '1', 06:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:11 INFO - 'NO_EM_RESTART': '1', 06:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:11 INFO - 'PWD': '/builds/slave/test', 06:05:11 INFO - 'SHELL': '/bin/bash', 06:05:11 INFO - 'SHLVL': '1', 06:05:11 INFO - 'TERM': 'linux', 06:05:11 INFO - 'TMOUT': '86400', 06:05:11 INFO - 'USER': 'cltbld', 06:05:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', 06:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:11 INFO - '_': '/tools/buildbot/bin/python'} 06:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:05:13 INFO - Installing collected packages: mozsystemmonitor 06:05:13 INFO - Running setup.py install for mozsystemmonitor 06:05:13 INFO - Successfully installed mozsystemmonitor 06:05:13 INFO - Cleaning up... 06:05:13 INFO - Return code: 0 06:05:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:05:13 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')]} 06:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:13 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')]} 06:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:13 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 0x7f541b39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd410>, '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 0x24be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', '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 06:05:13 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 06:05:13 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 06:05:13 INFO - Using env: {'DISPLAY': ':0', 06:05:13 INFO - 'HOME': '/home/cltbld', 06:05:13 INFO - 'LANG': 'en_US.UTF-8', 06:05:13 INFO - 'LANGUAGE': 'en_US:en', 06:05:13 INFO - 'LOGNAME': 'cltbld', 06:05:13 INFO - 'MAIL': '/var/mail/cltbld', 06:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:13 INFO - 'MOZ_NO_REMOTE': '1', 06:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:13 INFO - 'NO_EM_RESTART': '1', 06:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:13 INFO - 'PWD': '/builds/slave/test', 06:05:13 INFO - 'SHELL': '/bin/bash', 06:05:13 INFO - 'SHLVL': '1', 06:05:13 INFO - 'TERM': 'linux', 06:05:13 INFO - 'TMOUT': '86400', 06:05:13 INFO - 'USER': 'cltbld', 06:05:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', 06:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:13 INFO - '_': '/tools/buildbot/bin/python'} 06:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:05:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:05:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:16 INFO - Downloading docopt-0.6.1.tar.gz 06:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:05:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:05:16 INFO - Running setup.py install for blobuploader 06:05:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:05:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:05:16 INFO - Running setup.py install for requests 06:05:16 INFO - Running setup.py install for docopt 06:05:16 INFO - Successfully installed blobuploader requests docopt 06:05:16 INFO - Cleaning up... 06:05:17 INFO - Return code: 0 06:05:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:17 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 0x7f541b39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd410>, '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 0x24be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', '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 06:05:17 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 06:05:17 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 06:05:17 INFO - Using env: {'DISPLAY': ':0', 06:05:17 INFO - 'HOME': '/home/cltbld', 06:05:17 INFO - 'LANG': 'en_US.UTF-8', 06:05:17 INFO - 'LANGUAGE': 'en_US:en', 06:05:17 INFO - 'LOGNAME': 'cltbld', 06:05:17 INFO - 'MAIL': '/var/mail/cltbld', 06:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:17 INFO - 'MOZ_NO_REMOTE': '1', 06:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:17 INFO - 'NO_EM_RESTART': '1', 06:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:17 INFO - 'PWD': '/builds/slave/test', 06:05:17 INFO - 'SHELL': '/bin/bash', 06:05:17 INFO - 'SHLVL': '1', 06:05:17 INFO - 'TERM': 'linux', 06:05:17 INFO - 'TMOUT': '86400', 06:05:17 INFO - 'USER': 'cltbld', 06:05:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', 06:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:17 INFO - '_': '/tools/buildbot/bin/python'} 06:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:17 INFO - Running setup.py (path:/tmp/pip-Zc9lVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:17 INFO - Running setup.py (path:/tmp/pip-Rjj5OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:17 INFO - Running setup.py (path:/tmp/pip-wH4Rt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:17 INFO - Running setup.py (path:/tmp/pip-4ZWH8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:17 INFO - Running setup.py (path:/tmp/pip-Vb5hUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:17 INFO - Running setup.py (path:/tmp/pip-NWemR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:17 INFO - Running setup.py (path:/tmp/pip-jb1zGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:17 INFO - Running setup.py (path:/tmp/pip-wCutxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:17 INFO - Running setup.py (path:/tmp/pip-32XpsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:17 INFO - Running setup.py (path:/tmp/pip-DwdI0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:17 INFO - Running setup.py (path:/tmp/pip-9ie27s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:18 INFO - Running setup.py (path:/tmp/pip-Tjq_vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:18 INFO - Running setup.py (path:/tmp/pip-OgQZW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:18 INFO - Running setup.py (path:/tmp/pip-NLLUrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:18 INFO - Running setup.py (path:/tmp/pip-OoUJ2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:18 INFO - Running setup.py (path:/tmp/pip-6Fp8fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:18 INFO - Running setup.py (path:/tmp/pip-Tmmn8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:05:18 INFO - Running setup.py install for manifestparser 06:05:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Running setup.py install for mozcrash 06:05:18 INFO - Running setup.py install for mozdebug 06:05:18 INFO - Running setup.py install for mozdevice 06:05:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Running setup.py install for mozfile 06:05:18 INFO - Running setup.py install for mozhttpd 06:05:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for mozinfo 06:05:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for mozInstall 06:05:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for mozleak 06:05:19 INFO - Running setup.py install for mozlog 06:05:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for moznetwork 06:05:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for mozprocess 06:05:19 INFO - Running setup.py install for mozprofile 06:05:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for mozrunner 06:05:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for mozscreenshot 06:05:20 INFO - Running setup.py install for moztest 06:05:20 INFO - Running setup.py install for mozversion 06:05:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:05:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:05:20 INFO - Cleaning up... 06:05:20 INFO - Return code: 0 06:05:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:20 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 0x7f541b39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd410>, '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 0x24be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', '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 06:05:20 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 06:05:20 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 06:05:20 INFO - Using env: {'DISPLAY': ':0', 06:05:20 INFO - 'HOME': '/home/cltbld', 06:05:20 INFO - 'LANG': 'en_US.UTF-8', 06:05:20 INFO - 'LANGUAGE': 'en_US:en', 06:05:20 INFO - 'LOGNAME': 'cltbld', 06:05:20 INFO - 'MAIL': '/var/mail/cltbld', 06:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:20 INFO - 'MOZ_NO_REMOTE': '1', 06:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:20 INFO - 'NO_EM_RESTART': '1', 06:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:20 INFO - 'PWD': '/builds/slave/test', 06:05:20 INFO - 'SHELL': '/bin/bash', 06:05:20 INFO - 'SHLVL': '1', 06:05:20 INFO - 'TERM': 'linux', 06:05:20 INFO - 'TMOUT': '86400', 06:05:20 INFO - 'USER': 'cltbld', 06:05:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', 06:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:20 INFO - '_': '/tools/buildbot/bin/python'} 06:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:20 INFO - Running setup.py (path:/tmp/pip-lmt0wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:20 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)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:20 INFO - Running setup.py (path:/tmp/pip-uWnEmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:20 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)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:20 INFO - Running setup.py (path:/tmp/pip-mbClRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:20 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)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:20 INFO - Running setup.py (path:/tmp/pip-ISH0NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:20 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)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:20 INFO - Running setup.py (path:/tmp/pip-C4qREJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:20 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)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:20 INFO - Running setup.py (path:/tmp/pip-6dO8yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:20 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)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:20 INFO - Running setup.py (path:/tmp/pip-33yqCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:21 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)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:21 INFO - Running setup.py (path:/tmp/pip-pDsGVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:21 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)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:21 INFO - Running setup.py (path:/tmp/pip-efcocc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:21 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)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:21 INFO - Running setup.py (path:/tmp/pip-fxvCrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:21 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)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:21 INFO - Running setup.py (path:/tmp/pip-3fTlek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:21 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)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:21 INFO - Running setup.py (path:/tmp/pip-bGJYN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:21 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)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:21 INFO - Running setup.py (path:/tmp/pip-M3VGm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:21 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)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:21 INFO - Running setup.py (path:/tmp/pip-22APeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:21 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)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:21 INFO - Running setup.py (path:/tmp/pip-lzTeTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:21 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)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:21 INFO - Running setup.py (path:/tmp/pip-KuNK6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:21 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)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:21 INFO - Running setup.py (path:/tmp/pip-eZ5zcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:21 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)) 06:05:21 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)) 06:05:21 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)) 06:05:21 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)) 06:05:21 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)) 06:05:21 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)) 06:05:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:23 INFO - Downloading blessings-1.6.tar.gz 06:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:05:23 INFO - Installing collected packages: blessings 06:05:23 INFO - Running setup.py install for blessings 06:05:23 INFO - Successfully installed blessings 06:05:23 INFO - Cleaning up... 06:05:23 INFO - Return code: 0 06:05:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:24 INFO - Reading from file tmpfile_stdout 06:05:24 INFO - Current package versions: 06:05:24 INFO - argparse == 1.2.1 06:05:24 INFO - blessings == 1.6 06:05:24 INFO - blobuploader == 1.2.4 06:05:24 INFO - docopt == 0.6.1 06:05:24 INFO - manifestparser == 1.1 06:05:24 INFO - mozInstall == 1.12 06:05:24 INFO - mozcrash == 0.17 06:05:24 INFO - mozdebug == 0.1 06:05:24 INFO - mozdevice == 0.48 06:05:24 INFO - mozfile == 1.2 06:05:24 INFO - mozhttpd == 0.7 06:05:24 INFO - mozinfo == 0.9 06:05:24 INFO - mozleak == 0.1 06:05:24 INFO - mozlog == 3.1 06:05:24 INFO - moznetwork == 0.27 06:05:24 INFO - mozprocess == 0.22 06:05:24 INFO - mozprofile == 0.28 06:05:24 INFO - mozrunner == 6.11 06:05:24 INFO - mozscreenshot == 0.1 06:05:24 INFO - mozsystemmonitor == 0.0 06:05:24 INFO - moztest == 0.7 06:05:24 INFO - mozversion == 1.4 06:05:24 INFO - psutil == 3.1.1 06:05:24 INFO - requests == 1.2.3 06:05:24 INFO - wsgiref == 0.1.2 06:05:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05: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')]} 06:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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')]} 06:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:24 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 0x7f541b39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd410>, '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 0x24be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', '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 06:05:24 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 06:05:24 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 06:05:24 INFO - Using env: {'DISPLAY': ':0', 06:05:24 INFO - 'HOME': '/home/cltbld', 06:05:24 INFO - 'LANG': 'en_US.UTF-8', 06:05:24 INFO - 'LANGUAGE': 'en_US:en', 06:05:24 INFO - 'LOGNAME': 'cltbld', 06:05:24 INFO - 'MAIL': '/var/mail/cltbld', 06:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:24 INFO - 'MOZ_NO_REMOTE': '1', 06:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:24 INFO - 'NO_EM_RESTART': '1', 06:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:24 INFO - 'PWD': '/builds/slave/test', 06:05:24 INFO - 'SHELL': '/bin/bash', 06:05:24 INFO - 'SHLVL': '1', 06:05:24 INFO - 'TERM': 'linux', 06:05:24 INFO - 'TMOUT': '86400', 06:05:24 INFO - 'USER': 'cltbld', 06:05:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', 06:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:24 INFO - '_': '/tools/buildbot/bin/python'} 06:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:24 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)) 06:05:24 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)) 06:05:24 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)) 06:05:24 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)) 06:05:24 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)) 06:05:24 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)) 06:05:24 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)) 06:05:24 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)) 06:05:24 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)) 06:05:24 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)) 06:05:24 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)) 06:05:24 INFO - Cleaning up... 06:05:24 INFO - Return code: 0 06:05:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:05: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')]} 06:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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')]} 06:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f541b39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd410>, '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 0x24be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', '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 06:05: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', 'jsonschema'] in /builds/slave/test/build 06:05: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 jsonschema 06:05:24 INFO - Using env: {'DISPLAY': ':0', 06:05:24 INFO - 'HOME': '/home/cltbld', 06:05:24 INFO - 'LANG': 'en_US.UTF-8', 06:05:24 INFO - 'LANGUAGE': 'en_US:en', 06:05:24 INFO - 'LOGNAME': 'cltbld', 06:05:24 INFO - 'MAIL': '/var/mail/cltbld', 06:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:24 INFO - 'MOZ_NO_REMOTE': '1', 06:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:24 INFO - 'NO_EM_RESTART': '1', 06:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:24 INFO - 'PWD': '/builds/slave/test', 06:05:24 INFO - 'SHELL': '/bin/bash', 06:05:24 INFO - 'SHLVL': '1', 06:05:24 INFO - 'TERM': 'linux', 06:05:24 INFO - 'TMOUT': '86400', 06:05:24 INFO - 'USER': 'cltbld', 06:05:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', 06:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:24 INFO - '_': '/tools/buildbot/bin/python'} 06:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:24 INFO - Downloading/unpacking jsonschema 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:05:26 INFO - Downloading/unpacking functools32 (from jsonschema) 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:26 INFO - Downloading functools32-3.2.3-2.tar.gz 06:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:05:26 INFO - warning: no files found matching '*.txt' 06:05:26 INFO - no previously-included directories found matching 'build' 06:05:26 INFO - no previously-included directories found matching 'dist' 06:05:26 INFO - no previously-included directories found matching '.git*' 06:05:26 INFO - Installing collected packages: jsonschema, functools32 06:05:26 INFO - Running setup.py install for functools32 06:05:26 INFO - warning: no files found matching '*.txt' 06:05:26 INFO - no previously-included directories found matching 'build' 06:05:26 INFO - no previously-included directories found matching 'dist' 06:05:26 INFO - no previously-included directories found matching '.git*' 06:05:26 INFO - Successfully installed jsonschema functools32 06:05:26 INFO - Cleaning up... 06:05:26 INFO - Return code: 0 06:05:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:05:26 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')]} 06:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:26 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')]} 06:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:26 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 0x7f541b39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd410>, '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 0x24be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', '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 06:05:26 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 06:05:26 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 06:05:26 INFO - Using env: {'DISPLAY': ':0', 06:05:26 INFO - 'HOME': '/home/cltbld', 06:05:26 INFO - 'LANG': 'en_US.UTF-8', 06:05:26 INFO - 'LANGUAGE': 'en_US:en', 06:05:26 INFO - 'LOGNAME': 'cltbld', 06:05:26 INFO - 'MAIL': '/var/mail/cltbld', 06:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:26 INFO - 'MOZ_NO_REMOTE': '1', 06:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:26 INFO - 'NO_EM_RESTART': '1', 06:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:26 INFO - 'PWD': '/builds/slave/test', 06:05:26 INFO - 'SHELL': '/bin/bash', 06:05:26 INFO - 'SHLVL': '1', 06:05:26 INFO - 'TERM': 'linux', 06:05:26 INFO - 'TMOUT': '86400', 06:05:26 INFO - 'USER': 'cltbld', 06:05:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', 06:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:26 INFO - '_': '/tools/buildbot/bin/python'} 06:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:27 INFO - Downloading/unpacking flake8 06:05:27 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 06:05:27 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 06:05:27 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 06:05:27 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 06:05:27 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 06:05:27 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 06:05:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:05:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:05:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 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 06:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:05:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:29 INFO - no previously-included directories found matching 'docs/_build' 06:05:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:05:29 INFO - Running setup.py install for pep8 06:05:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:29 INFO - no previously-included directories found matching 'docs/_build' 06:05:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:05:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:05:29 INFO - Cleaning up... 06:05:29 INFO - Return code: 0 06:05:29 INFO - Running post-action listener: _resource_record_post_action 06:05:29 INFO - Running post-action listener: _start_resource_monitoring 06:05:30 INFO - Starting resource monitoring. 06:05:30 INFO - ##### 06:05:30 INFO - ##### Running install step. 06:05:30 INFO - ##### 06:05:30 INFO - Running pre-action listener: _resource_record_pre_action 06:05:30 INFO - Running main action method: install 06:05:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:30 INFO - Reading from file tmpfile_stdout 06:05:30 INFO - Detecting whether we're running mozinstall >=1.0... 06:05:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:05:30 INFO - Reading from file tmpfile_stdout 06:05:30 INFO - Output received: 06:05:30 INFO - Usage: mozinstall [options] installer 06:05:30 INFO - Options: 06:05:30 INFO - -h, --help show this help message and exit 06:05:30 INFO - -d DEST, --destination=DEST 06:05:30 INFO - Directory to install application into. [default: 06:05:30 INFO - "/builds/slave/test"] 06:05:30 INFO - --app=APP Application being installed. [default: firefox] 06:05:30 INFO - mkdir: /builds/slave/test/build/application 06:05:30 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'] 06:05:30 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 06:05:43 INFO - Reading from file tmpfile_stdout 06:05:43 INFO - Output received: 06:05:43 INFO - /builds/slave/test/build/application/firefox/firefox 06:05:43 INFO - Running post-action listener: _resource_record_post_action 06:05:43 INFO - ##### 06:05:43 INFO - ##### Running run-tests step. 06:05:43 INFO - ##### 06:05:43 INFO - Running pre-action listener: _resource_record_pre_action 06:05:43 INFO - Running main action method: run_tests 06:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:05:43 INFO - Python 2.7.3 06:05:43 INFO - Return code: 0 06:05:43 INFO - grabbing minidump binary from tooltool 06:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:43 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 0x24bd410>, '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 0x24be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:05:43 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 06:05:43 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 06:05:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:05:43 INFO - Return code: 0 06:05:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:05:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:05:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:05:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:05:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:05:44 INFO - Return code: 0 06:05:44 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-012', '--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 06:05:44 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-012 --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 06:05:44 INFO - Using env: {'DISPLAY': ':0', 06:05:44 INFO - 'HOME': '/home/cltbld', 06:05:44 INFO - 'LANG': 'en_US.UTF-8', 06:05:44 INFO - 'LANGUAGE': 'en_US:en', 06:05:44 INFO - 'LOGNAME': 'cltbld', 06:05:44 INFO - 'MAIL': '/var/mail/cltbld', 06:05:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:05:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:44 INFO - 'MOZ_NO_REMOTE': '1', 06:05:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:44 INFO - 'NO_EM_RESTART': '1', 06:05:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:44 INFO - 'PWD': '/builds/slave/test', 06:05:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:05:44 INFO - 'SHELL': '/bin/bash', 06:05:44 INFO - 'SHLVL': '1', 06:05:44 INFO - 'TERM': 'linux', 06:05:44 INFO - 'TMOUT': '86400', 06:05:44 INFO - 'USER': 'cltbld', 06:05:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643', 06:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:44 INFO - '_': '/tools/buildbot/bin/python'} 06:05:44 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-012', '--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 06:05:44 INFO - mozversion application_buildid: 20160624143557 06:05:44 INFO - mozversion application_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 06:05:44 INFO - mozversion application_display_name: Firefox 06:05:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:05:44 INFO - mozversion application_name: Firefox 06:05:44 INFO - mozversion application_remotingname: firefox 06:05:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:05:44 INFO - mozversion application_vendor: Mozilla 06:05:44 INFO - mozversion application_version: 48.0 06:05:44 INFO - mozversion platform_buildid: 20160624143557 06:05:44 INFO - mozversion platform_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 06:05:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:05:44 INFO - mozversion platform_version: 48.0 06:05:44 INFO - using testdate: 1467032744 06:05:44 INFO - actual date: 1467032744 06:05:44 INFO - starting webserver on 'localhost:58010' 06:05:44 INFO - SUITE-START | Running 2 tests 06:05:44 INFO - TEST-START | dromaeo_css 06:05:44 INFO - operating with platform_type : linux_ 06:05:44 INFO - Initialising browser for dromaeo_css test... 06:05:44 INFO - TEST-INFO | started process 30819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSgVOvJ/profile http://localhost:58010/getInfo.html) 06:05:47 INFO - PROCESS | 30819 | 06:05:47 INFO - PROCESS | 30819 | (process:30898): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:05:48 INFO - PROCESS | 30819 | __metrics Screen width/height:1600/1200 06:05:48 INFO - PROCESS | 30819 | colorDepth:24 06:05:48 INFO - PROCESS | 30819 | Browser inner width/height: 1024/697 06:05:48 INFO - PROCESS | 30819 | __metrics 06:05:49 ERROR - PROCESS | 30819 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:05:49 INFO - TEST-INFO | 30819: exit 0 06:05:49 INFO - Browser initialized. 06:05:49 INFO - Running cycle 1/1 for dromaeo_css test... 06:05:49 INFO - TEST-INFO | started process 30948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSgVOvJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:51 INFO - PROCESS | 30948 | 06:05:51 INFO - PROCESS | 30948 | (process:31015): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:06:01 INFO - PROCESS | 30948 | RSS: Main: 150720512 06:06:01 INFO - PROCESS | 30948 | 06:06:51 INFO - PROCESS | 30948 | 1467032811235 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] 06:08:58 INFO - PROCESS | 30948 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58010/tests/dromaeo/cssquery-ext.html) 06:08:59 INFO - PROCESS | 30948 | RSS: Main: 154763264 06:08:59 INFO - PROCESS | 30948 | 06:12:01 INFO - PROCESS | 30948 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-ext.html (next: http://localhost:58010/tests/dromaeo/cssquery-jquery.html) 06:12:02 INFO - PROCESS | 30948 | RSS: Main: 152039424 06:12:02 INFO - PROCESS | 30948 | 06:15:03 INFO - PROCESS | 30948 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58010/tests/dromaeo/cssquery-mootools.html) 06:15:04 INFO - PROCESS | 30948 | RSS: Main: 152387584 06:15:04 INFO - PROCESS | 30948 | 06:18:05 INFO - PROCESS | 30948 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58010/tests/dromaeo/cssquery-prototype.html) 06:18:06 INFO - PROCESS | 30948 | RSS: Main: 153231360 06:18:06 INFO - PROCESS | 30948 | 06:21:08 INFO - PROCESS | 30948 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58010/tests/dromaeo/cssquery-yui.html) 06:21:09 INFO - PROCESS | 30948 | RSS: Main: 151994368 06:21:09 INFO - PROCESS | 30948 | 06:24:11 INFO - PROCESS | 30948 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-yui.html (next: http://localhost:58010/tests/dromaeo/cssquery-dojo.html) 06:24:11 INFO - PROCESS | 30948 | RSS: Main: 155676672 06:24:11 INFO - PROCESS | 30948 | 06:24:11 INFO - PROCESS | 30948 | __start_tp_report 06:24:11 INFO - PROCESS | 30948 | _x_x_mozilla_page_load 06:24:11 INFO - PROCESS | 30948 | _x_x_mozilla_page_load_details 06:24:11 INFO - PROCESS | 30948 | |i|pagename|runs| 06:24:11 INFO - PROCESS | 30948 | |0;dojo.html;3256.7883087599307;3344.481605351171;3345.1971526833568;3372.6121496027963;3403.1662242750513;5524.4199359067325;5545.3622833374175;5562.443755624446;5582.078956972095;5590.18942253373;5532.723363831802;5580.302462192226;5586.916196257049;5605.7197140142935;5610.831675049745;5067.569256613192;5100.642954993134;5166.354205724285;5175.042617115827;5179.792808287664;5065.848024559251;5125.615578831584;5212.635115541913;5257.316548848664;5283.339582552181;5093.159628661267;5110.488951104897;5155.690658560479;5168.147255702824;5196.740162991854;5105.132127538309;5110.974445127769;5123.974380128076;5124.769385377667;5163.8192663256605;4917.557419832232;5018.774155163026;5036.294918711384;5084;5095.235714642796;5348.598855085884;5363.115086010804;5410;5441.863953401157;5485.341758988907;5838.970805145947;5871.530277577784;5882.147088672162;5886.852828679274;5890.145928840337;5820.592558520905;5924.703764811785;5948.40515948406;5960.552958528085;5961.195238642771;5578.107502799573;5612.102063669793;5615.7472913718575;5623.0721930881355;5649.209110724501;6078.969605151946;6104.298005729398;6110.114033465212;6110.419510146529;6115.4801841843055;5638.126090455986;5819.388964158787;5842.065269556935;5865.530757539386;5876.970615146897;5947.256592925884;5952.464278214981;5954.07711804671;5958.165856779968;5961.731722072517;5846.8538286542325;5897.734601942923;5900.557458190653;5904;5904.675242861598;5770.394108618535;5865.237519122572;5869.530437564985;5943.435373639497;5993.0710739835395;4565.246734288805;4574;4584.564466375689;4588.311753237042;4613.354130421743;4093.3041382964966;4113.91772164561;4115.0741083256025;4119.526254480713;4144.8134833932545;5573.052581061148;5750.194972703741;5782.306123265235;5792.88414231713;5817.0401883689565;5957.821265362046;6012.759489620366;6041.093835924558;6053.334133245339;6068.757249709962;5578.944210557843;5734.996375634248;5743.597948143673;5744.052231381859;5761.5102716269585;4961.875953101129;5005.849824505271;5021.196608542616;5021.573166280834;5051.040302342617;6114.174586430864;6146.200993870768;6168.414000670019;6171.352008039181;6173.876522469525;5876.6180198286975;5887.882242355044;5936.5844390892225;5938.792142275172;5975.462208401352;6098.414412252935;6113.658745237643;6159.846003849761;6161.4146656067605;6170.012797952306;5818.650880947157;5828.825135245949;5828.94171058284;5834.416558344302;5888.293404791452;5841.94158058431;5935.109733539831;5935.554833387427;6005.3694362091355;6057.4851137653795;5841.299044114733;5848.385919478394;5850.23946886919;5851.385604511465;5853.414658534283;5793.217915581511;5815.854603634943;5818.679972601548;5831.35855055952;5832.883342333214;5578.888422231614;5669.489745922887;5677.5457963362005;5727.8568035799435;5782.913256301074;5842.5325973921135;5876.6180198286975;5906.822795316148;5910.349861515316;5911.645301281937;5749.080147176432;5749.195112684144;5759.65442073477;5760.337561180518;5761.596688231783 06:24:11 INFO - PROCESS | 30948 | |1;ext.html;657.5692921136654;669.2003056347663;673.946084313255;681.3867519232693;681.9249882512926;38734.41898371523;39529.80235098828;39530.802345988304;39658.20683586327;39675.603243967555;43116;43858.342124868155;43869.903252418706;43939.3409098863;43969;8845.24815390691;9000.099990001014;9009.864852027193;9016.098390160996;9038.819223615557;8756.649734010633;8862.512561809099;8905.821883562325;9092.727218183465;9109.316801239933;9082.409643373192;9147.765051717999;9164.991850896396;9176.678816241432;9191.1727944485;8996.955015224914;9047.185753282203;9069.31980101495;9107.63569457221;9115.81768364629;9001.909980900238;9069.319801014884;9091.31815113869;9105.271578273789;9151.222146117589;44089.11821763579;44524.554754452365;44667.10665786666;44824.327635085174;44827.32759008618;3964.5638979712207;4078.796060197008;4283.721558098714;4470.932936005963;4674.298855171717;32966.34067318664;33095.6690433095;33692;34009.489857651904;35231.471527927104;4292.1415716856445;4386.517483076859;4394.538573449806;4405.8237670493145;4425.380446737459;218695;221088;221978;224166;225135;40747.59252407438;41695.374569381485;57221.42778572161;58226;58409;38463.423048654295;38464;38486.61513384886;38499;38564.22871542553;16252.349906003863;16545.25546350417;16551.83448165527;16622.667546648998;16627.83372166287;13609.931950340186;13708.314584270747;13713.588592342247;13756.243406612732;13814.861851381558;9366.157045865904;9633.855492167622;9649.228061755042;9676.56455459492;9695.127438530426;3611.9819400903352;3689.538807649044;3740.2893450244364;3742.55089389275;3769.754965927206;1158.3513232589776;1169.9415029248673;1201.2372143688647;1217.4825699077855;1285.794272916329;34689;35162.824185878904;37766.24467510689;37807.243855122746;38268.42597361042;1220.1946715168124;1245.0848626259692;1245.7197130645532;1250.46230121047;1299.3353859643923;17197.828021719622;17271.222794974256;17336.826631733522;17353.2191051403;17558.122093895254;514109;522623;571626;588460;589336;57285;57826.4217357821;57885.71057144687;58096;58141;1506.4877941499942;1539.8229203641501;1561.1725785333792;1581.2251996521622;1586.1672621873608;30546.541801872547;32987;33550.83224583959;33739;33819.830900846326;54386.45613543814;54644.45355546394;54796.45203547914;54860.451395485536;55024;426110;429236;430635;432212;433108;31406.842965785025;31520.52719209168;31827.20431989219;32333;32553.186170345933;50778;51262.74368628133;51336.486635134665;51900.22149667682;52155.73922130365;43434;43451.34822977721;43480.34779478374;43520.34719479147;44334.55665443304;42408.15183696247;42830.35754463623;42848.35727464153;43229;43776.56223437852;44426.55573444354;44718.3292250623;50373.24440133474;50500.49499505105;51233.48766512287;39669.404958925064;40953.79523102365;41152.38271425991;43060.56939430691;43997;33915.98252052344;34293.82853085719;34587.4811877817;34663.48004779981;35261.82369088138 06:24:11 INFO - PROCESS | 30948 | |2;jquery.html;410.18782810036134;411.2782067471585;414.0745433955108;426.2880988748789;429.32595824555443;13835.861641383583;18675.71986420203;19296.324628638016;19334.419967400983;19385.515362115955;18585;19416.22335106594;20071.799282007174;20073.297434589793;20204;5832.416758324176;5834.066549352105;5934.762609495615;5996.910046349309;6046.576739628205;5891.587588868781;5950.404959504037;5963.165156878041;5995.160677505153;5996.040633498641;5764.308283006024;5933.614315069507;5940.405959404068;5969.074793407029;6012.699365031753;5910.67491287979;5939.792107276225;5945.137954996501;5956.612820166697;5969.015112506453;5122.974385128088;5301.7084060376665;5328.147496400557;5331.920021199685;5395.0558652236095;17940.730889036677;23066.65400019001;23070.42323941915;23320.65019024716;23641.645375319385;2546.847189168637;2584.806139539542;2590.6891173059353;2879.3521457671854;3276.3611095836322;14418.711625767532;14592;14697.77953330701;14713.337899794535;14721.55835324942;1932.4492519631838;1979.6436641404541;2029.5636438165718;2043.1214577731569;2094.1937354118622;73577.89633155454;78441.60779196124;79834;82594;83505;10660;11050.447477626087;11534.423278836024;11561.479733412016;11737.06103511717;15903.04581725077;15903.284352204179;15907.284172212278;15972.520824375288;16040.43858464948;8722.433041852259;8765.561721913879;8866.246369058703;8934.240589549961;8951.820963580822;8562.229399354088;8605.397622166389;8641.913580864237;8667.566621668891;8710.259627931697;4930.556249937451;5040.873978150576;5041.621878359138;5074.188129899198;5101.642884998015;1997.9600407991759;2010.7587089549347;2033.8677985930867;2114.883681397507;2136.198925402974;985.3693636072919;1060.226034994443;1063.1176123817368;1126.4424110065406;1155.364549497773;18212.726809097872;18379.90810045968;18948.14733337003;19613.41159765209;20629.381118566467;1097.8737445193744;1130.8190689489807;1132.7394699219226;1144.8168293073068;1147.1683029803492;10662.466876656135;10826.67519974402;10922.836157457645;10930.781384372269;10951;504311;513859;515890;536447;540649;85703;85866;85936.57031714801;94156;99338.503307483;1192.2369683402628;1196.3719047500133;1198.2750435986277;1226.1294480918468;1268.207370393504;16344.427945021867;16419.671606567565;16523;17073.658526829146;17441;40132.79933600313;40235;40489.79755101206;41311.793441033806;41491;57692.423075770384;58900.70549647224;58934.70532647309;59145.40854591399;59235.703821480616;8544.444611100258;8878.911210887809;8909.242714369091;8975.640974360953;9052.864207036768;13461.528846490326;13537.1200871943;13836.308184590931;14038.719225615634;14293.785593216318;11766.941165294118;12145.089118315986;12404.689882753004;12617.558385456465;12651.620451386472;11211.55153793839;11428.657140285804;11831.11266654987;11948.283103013848;12192.939035304767;6253.030780229072;8852.822943541221;11957.043436524884;11999.64001079969;12552.43514041852;8612.612432440681;8881.156290152425;8914.821703566022;9010.32422568323;9255.398399104037;10935.671929842118;11896.167268291483;12035.518579257083;12091.032717382412;12250.019998400285 06:24:11 INFO - PROCESS | 30948 | |3;mootools.html;1605.8233594304625;1621.327149233068;1852.6016906365128;1940.301491463073;1960.2649006622516;7232.674529646165;8303.792405189859;8395.370347223952;8606.311495080394;8626.43928144671;8091.4740541864885;8106.513609183438;8122.837543249131;8183.508989460636;8186.467879587823;2420.9515809683794;2425.405775584984;2433.1362366359863;2435.3424575364643;2439.6706444629926;2407.6990376202975;2415.915442959497;2434.75652434756;2438.0247900839718;2444.0712529238954;2321.3268152235833;2376.66726658268;2378.3340664613934;2411.5297516984197;2420.7942324902315;2430.0158435833514;2432.2338463383976;2432.6107822748363;2433.452473193535;2465.963010554843;2365.5387199496104;2379.845310054841;2387.570237357275;2389.9522009559887;2398.4723360860585;8380.622871970776;8406;8415.200555947236;8416;8423.578821058984;5341.679499230058;5375.059364611177;5441.755121019563;5447.319085114361;5449.100898351767;3478.5999610044914;3494.143934736006;3527.8412471438846;3618.113562177257;3621.1490299779794;1122.8708698499613;1201.8677945425995;1210.152892974921;1237.665830225834;1259.3262604506544;11657.650270491898;11729.120315976335;11745.29528228309;11745.823812642817;11758;4668.626509879202;4672.322513235562;4742.5020372861045;4765.547273009059;4866.245731911559;10085.848712269322;10100.949495252476;10208;10209.132223760915;10214.131798797185;5405.540529055074;5428.565714742811;5455.34535855692;5462.562994960394;5469.753861076261;4805.663603547788;4895.363602731622;4949.57928576075;5000.1249781288125;5000.799968001239;3872.8063596820048;4013.7391069580385;4017.0961533655277;4022.9798851005557;4031.5162180538523;999.2106236073421;1005.9396436213705;1006.3006210683651;1010.9292349535461;1201.8978386837216;1049.9107575856137;1061.3843970497094;1069.4064794039382;1079.6599071292517;1085.4355735017746;5514.696691681996;5643.633163844337;5675.744591493392;5756.136579513107;5811.854703632358;472.65260033875074;475.1708269070494;481.0907385042273;481.1771870102095;485.66246458710856;4058.512978442606;4064.1058967027207;4067.8576249831112;4106.117184805281;4106.9441880653085;10407.167426605853;10702.732431689114;10783.946080269548;10794.190435717353;10804.783904322027;10486.05625493694;10556;10556.577736890438;10560;10576.36541807494;8233.217844304781;8342.332613391036;8351.123132071045;8393.916060839436;8419.621117049748;5737.655740655574;5825.533957283323;5843.211166492639;5904.734286957183;5962.165296858357;9306.208972237435;9308.674196403093;9310.627574897198;9327.300452466228;9546.284028698014;9492.477913714813;9542.904570954202;9583.904160958302;9674.08096230857;10021.949890250502;7265.818354540967;7319.194888562148;7403.037605111301;7444.330010299099;7482.476226664081;8147.10381858007;8175.305099066408;8217.917820821714;8239.835203295781;8266.669333226604;7244.637768111468;7323.304286092813;7567.054118235221;7589.241075892367;7659.195784442553;7094.503384763017;7138.714451422093;7144.106986626672;7233.891491627735;7263.34629883313;6575.342465753386;6576.177977752781;6616.735330586723;6636.336366363518;6642.4021838034805;4947.777350019186;4995.350604421402;4996.450390457119;5009.8747531310555;5024.246363045426;4995.950040499549;5089.9056702809075;5108.719020453911;5152.690838549699;5291.232771248225 06:24:11 INFO - PROCESS | 30948 | |4;prototype.html;346.3851663297646;356.1381456874364;357.2658187424841;362.7732667083073;365.08364006344067;6562.9015564766505;6653;6684.030815531745;6694.330566943303;6723.529352945296;6617.040529123286;6641.701123449444;6644.601323920569;6661.63361015144;6665.733370665168;4753.358296629954;4860.756962151878;4944.283078953549;4951.752412379366;4962.40451145863;4917.385326834145;4922.286268491084;4936.864521160135;4939.28380384844;4946.233333833262;4899.706017638953;4957.603391728653;4981.277714731362;4983.72589507577;4991.326170966928;4986.177280748672;4995.875103122451;4997.700137991714;4998.825041123543;5000.0999820032375;4380.671449641258;4388.319810429389;4390.407295015196;4398.64810815134;4399.252127138394;6211.099390588384;6306.558540902139;6309.873802523924;6355.633538789182;6357.17356743625;5791.855203619901;5831.183634291203;5834.5915785895;5838.5329173666005;5852;6860.245373008965;6888.483363747739;6900.585964842076;6917.654117294165;6923.653817309114;4831.05794370098;4831.782569784368;4832.226843705025;4836.032793441291;4857.708537487762;7163.10461192351;7210.53131546453;7218.097737782829;7241.963790181068;7246.5289756165685;4829.5653391194965;4964.578010869117;4964.925526117111;5002.799888004512;5038.571721403721;5078.796848126108;5090.2364645303505;5092.159793634009;5101;5103.948960510347;5849.268841394825;5857.7656893724625;5862.237909071793;5865.384134665884;5872.031114865999;6980.092587963633;7040.225575186725;7045.68294426752;7052.188998265266;7066.611336376446;1769.9469015929542;1778.2531336838558;1788.6333301673126;1794.676958147546;1797.3709201779272;1154.1516985016005;1183.0594677231622;1187.9049676025897;1189.6906804230962;1195.623378635727;6679.031540426611;6683.097781799394;6716.932830671729;6717.328267173341;6720.193576770721;7034.753783617652;7112.786616401516;7132.607706576188;7148.642567871586;7158.749443769443;6763.12079429671;6835;6840.6921688524135;6845.212800527904;6846.554973926679;3886.96113038866;3911.5697273299916;3913.158670885773;3918.0204948762807;3924.843006279774;7645.044369453818;7646.311831935152;7656.655450504741;7662.4253181011645;7674.040744906887;7274.381677557467;7429.36850367714;7429.851402972018;7443.292887175709;7443.776686699408;7610.9238907610215;7620.961895190489;7629.923700763033;7630.2751238632245;7636.618169091523;7248.456365772483;7256.1655409628565;7258.346748792634;7267.818304542428;7268.709251629875;7175.748848790267;7183.928160718326;7189.604571748604;7192.4246060314;7193.748218812317;7460.962695186489;7578;7629.809254768676;7631.809204769926;7671.194524574839;4796.424429068534;4816.301636262792;4836.516348365135;4838.395200599925;4842.709437433765;7272.381847543018;7274.381677557467;7279.381252593589;7279.490435669452;7317.817054573678;6982.441404687715;6989.47578931572;6997.930020699728;7001.054857594159;7011.719531218694;6880.69036893331;6991.706534291173;6996.860062798817;7025.68384422692;7028.98079778419;6836.897446538405;6875.5530890491955;6877.65611719402;6880.9655951721925;6889.035535025;7065.364117229474;7065.717371305296;7080.185778635317;7084.25615310385;7099.503034787722;6809.38715515606;6872.759453419107;6895.75864844728;6896.069030680794;6911.827204319932 06:24:11 INFO - PROCESS | 30948 | |5;yui.html;877.3025444771407;940.4122423485321;944.1738478831023;965.565495527013;973.0998826085873;14168.645783855409;14492;14538.636534086652;14544;14561.78157327641;14657.486987955424;14779.334929928153;14781.482648107318;14794.408223671067;14800.777988330183;742.5767312631802;902.5983437370372;927.4342650982895;929.1359036096428;931.2038207332735;905.6377449020379;916.1845957098154;918.7243826851951;919.0992827029515;920.0385597051064;970.1995853420921;972.5088830140769;974.2790335151972;974.6978436684615;974.8683927669745;957.9473128977903;968.2060710217625;970.6602689058808;974.1573538888811;977.0376179463223;712.796852896927;712.8396110875063;714.6605362452846;717.7846646006229;718.6370882704201;14933.477328293458;14957.027793193407;14999.700005999819;15062.096274223582;15065.548033559011;15069;15269.160196189205;15351.923240383838;15365.154916479589;15398.384064637401;11233.21367504275;11417.828732569018;11445.94277028618;11462.656120316404;11650.300981941025;4033.596640335972;4114.629683328515;4172.061286210609;4249.213895429324;4292.699511034229;57055;57328.42671573273;58292.12561811576;59533.702331488064;59739.701301493216;11816.527338906519;11854.348010859314;11862.169648124549;11969.521219151136;12004.879951200377;21553.461163471038;21816.236431724814;21993.560128797333;22061.889690551765;22062;9161.221296189766;9167.770805729777;9287.535623218811;9290.814183716288;9482.857757133648;5001.699898006059;5003.74981250936;5036.722980236123;5092.465291144376;5124.769385377667;3532.682058614737;3624.293262813726;3641.9089522761615;3650.233450975272;3663.4871118043493;666.1939053745023;679.6499802601664;681.0601370109217;681.536555142498;686.8694947959972;732.4470025131099;740.6148802622606;748.2031636307315;812.7196117339508;818.5702506184301;10344.482775861177;10367.481625918674;10749.408782517037;10822.56709731602;11114.833277500844;746.3394895517506;752.499587774135;836.6736972580699;848.8896443462311;870.6299822575506;4664.55686709762;4714.175019371596;4836.347093142451;4887.242477416006;4895.510448955076;66995.66502167458;67212.3278767206;67481.32518674848;67621.66189169022;67977.66011169912;56737.71631141818;57668.71165644145;57847.710761445924;58486.41513584895;58816;48618.27072593914;49150.50849491531;51237.231441528405;52111;52131;10099.949500252746;10190.796184076129;10206.183505319408;10256.48717564104;10345.793084138124;39345.80327098346;39444.60555394524;39605.40591891066;39727.60272397355;40235.1952960945;46023.76988115038;46373.536264636925;51026.489735103656;52033;52953.20570191373;12907.354632268161;12918.547850825553;13120;13265.403056862271;13333.866661333263;13929;13981.580552583438;14049.157050576998;14421.927890360901;14682.706345873235;13660.248686322348;13688.863111368759;13991.860081399056;14070.507532236323;14565.781513277521;12968.416421260878;13295.601131966056;13460.192388456724;13792.379342929793;14193.503227386991;12092.75814483723;13179.40692668813;13203.933980330037;13591.932040339734;13846;11231.775364492827;11382.715432114263;11385.487653055798;11545.711357216136;11801.114916381477;11236.550537978716;11484.138689598147;11507.769844603228;11602.245854019462;11782.116341274268 06:24:11 INFO - PROCESS | 30948 | __end_tp_report 06:24:11 INFO - PROCESS | 30948 | __start_cc_report 06:24:11 INFO - PROCESS | 30948 | _x_x_mozilla_cycle_collect,332 06:24:11 INFO - PROCESS | 30948 | __end_cc_report 06:24:11 INFO - PROCESS | 30948 | __startTimestamp1467033851899__endTimestamp 06:24:11 INFO - PROCESS | 30948 | 06:24:11 INFO - PROCESS | 30948 | ------- Summary: start ------- 06:24:11 INFO - PROCESS | 30948 | Number of tests: 6 06:24:11 INFO - PROCESS | 30948 | 06:24:11 INFO - PROCESS | 30948 | [#0] dojo.html Cycles:165 Average:5539.27 Median:5770.39 stddev:601.92 (10.4%) stddev-sans-first:576.52 06:24:11 INFO - PROCESS | 30948 | Values: 3256.8 3344.5 3345.2 3372.6 3403.2 5524.4 5545.4 5562.4 5582.1 5590.2 5532.7 5580.3 5586.9 5605.7 5610.8 5067.6 5100.6 5166.4 5175.0 5179.8 5065.8 5125.6 5212.6 5257.3 5283.3 5093.2 5110.5 5155.7 5168.1 5196.7 5105.1 5111.0 5124.0 5124.8 5163.8 4917.6 5018.8 5036.3 5084.0 5095.2 5348.6 5363.1 5410.0 5441.9 5485.3 5839.0 5871.5 5882.1 5886.9 5890.1 5820.6 5924.7 5948.4 5960.6 5961.2 5578.1 5612.1 5615.7 5623.1 5649.2 6079.0 6104.3 6110.1 6110.4 6115.5 5638.1 5819.4 5842.1 5865.5 5877.0 5947.3 5952.5 5954.1 5958.2 5961.7 5846.9 5897.7 5900.6 5904.0 5904.7 5770.4 5865.2 5869.5 5943.4 5993.1 4565.2 4574.0 4584.6 4588.3 4613.4 4093.3 4113.9 4115.1 4119.5 4144.8 5573.1 5750.2 5782.3 5792.9 5817.0 5957.8 6012.8 6041.1 6053.3 6068.8 5578.9 5735.0 5743.6 5744.1 5761.5 4961.9 5005.8 5021.2 5021.6 5051.0 6114.2 6146.2 6168.4 6171.4 6173.9 5876.6 5887.9 5936.6 5938.8 5975.5 6098.4 6113.7 6159.8 6161.4 6170.0 5818.7 5828.8 5828.9 5834.4 5888.3 5841.9 5935.1 5935.6 6005.4 6057.5 5841.3 5848.4 5850.2 5851.4 5853.4 5793.2 5815.9 5818.7 5831.4 5832.9 5578.9 5669.5 5677.5 5727.9 5782.9 5842.5 5876.6 5906.8 5910.3 5911.6 5749.1 5749.2 5759.7 5760.3 5761.6 06:24:11 INFO - PROCESS | 30948 | 06:24:11 INFO - PROCESS | 30948 | [#1] ext.html Cycles:180 Average:57150.23 Median:236875.50 stddev:113609.50 (48.0%) stddev-sans-first:113849.03 06:24:11 INFO - PROCESS | 30948 | Values: 657.6 669.2 673.9 681.4 681.9 38734.4 39529.8 39530.8 39658.2 39675.6 43116.0 43858.3 43869.9 43939.3 43969.0 8845.2 9000.1 9009.9 9016.1 9038.8 8756.6 8862.5 8905.8 9092.7 9109.3 9082.4 9147.8 9165.0 9176.7 9191.2 8997.0 9047.2 9069.3 9107.6 9115.8 9001.9 9069.3 9091.3 9105.3 9151.2 44089.1 44524.6 44667.1 44824.3 44827.3 3964.6 4078.8 4283.7 4470.9 4674.3 32966.3 33095.7 33692.0 34009.5 35231.5 4292.1 4386.5 4394.5 4405.8 4425.4 218695.0 221088.0 221978.0 224166.0 225135.0 40747.6 41695.4 57221.4 58226.0 58409.0 38463.4 38464.0 38486.6 38499.0 38564.2 16252.3 16545.3 16551.8 16622.7 16627.8 13609.9 13708.3 13713.6 13756.2 13814.9 9366.2 9633.9 9649.2 9676.6 9695.1 3612.0 3689.5 3740.3 3742.6 3769.8 1158.4 1169.9 1201.2 1217.5 1285.8 34689.0 35162.8 37766.2 37807.2 38268.4 1220.2 1245.1 1245.7 1250.5 1299.3 17197.8 17271.2 17336.8 17353.2 17558.1 514109.0 522623.0 571626.0 588460.0 589336.0 57285.0 57826.4 57885.7 58096.0 58141.0 1506.5 1539.8 1561.2 1581.2 1586.2 30546.5 32987.0 33550.8 33739.0 33819.8 54386.5 54644.5 54796.5 54860.5 55024.0 426110.0 429236.0 430635.0 432212.0 433108.0 31406.8 31520.5 31827.2 32333.0 32553.2 50778.0 51262.7 51336.5 51900.2 52155.7 43434.0 43451.3 43480.3 43520.3 44334.6 42408.2 42830.4 42848.4 43229.0 43776.6 44426.6 44718.3 50373.2 50500.5 51233.5 39669.4 40953.8 41152.4 43060.6 43997.0 33916.0 34293.8 34587.5 34663.5 35261.8 06:24:11 INFO - PROCESS | 30948 | 06:24:11 INFO - PROCESS | 30948 | [#2] jquery.html Cycles:180 Average:30008.11 Median:23481.15 stddev:85869.26 (365.7%) stddev-sans-first:86081.38 06:24:11 INFO - PROCESS | 30948 | Values: 410.2 411.3 414.1 426.3 429.3 13835.9 18675.7 19296.3 19334.4 19385.5 18585.0 19416.2 20071.8 20073.3 20204.0 5832.4 5834.1 5934.8 5996.9 6046.6 5891.6 5950.4 5963.2 5995.2 5996.0 5764.3 5933.6 5940.4 5969.1 6012.7 5910.7 5939.8 5945.1 5956.6 5969.0 5123.0 5301.7 5328.1 5331.9 5395.1 17940.7 23066.7 23070.4 23320.7 23641.6 2546.8 2584.8 2590.7 2879.4 3276.4 14418.7 14592.0 14697.8 14713.3 14721.6 1932.4 1979.6 2029.6 2043.1 2094.2 73577.9 78441.6 79834.0 82594.0 83505.0 10660.0 11050.4 11534.4 11561.5 11737.1 15903.0 15903.3 15907.3 15972.5 16040.4 8722.4 8765.6 8866.2 8934.2 8951.8 8562.2 8605.4 8641.9 8667.6 8710.3 4930.6 5040.9 5041.6 5074.2 5101.6 1998.0 2010.8 2033.9 2114.9 2136.2 985.4 1060.2 1063.1 1126.4 1155.4 18212.7 18379.9 18948.1 19613.4 20629.4 1097.9 1130.8 1132.7 1144.8 1147.2 10662.5 10826.7 10922.8 10930.8 10951.0 504311.0 513859.0 515890.0 536447.0 540649.0 85703.0 85866.0 85936.6 94156.0 99338.5 1192.2 1196.4 1198.3 1226.1 1268.2 16344.4 16419.7 16523.0 17073.7 17441.0 40132.8 40235.0 40489.8 41311.8 41491.0 57692.4 58900.7 58934.7 59145.4 59235.7 8544.4 8878.9 8909.2 8975.6 9052.9 13461.5 13537.1 13836.3 14038.7 14293.8 11766.9 12145.1 12404.7 12617.6 12651.6 11211.6 11428.7 11831.1 11948.3 12192.9 6253.0 8852.8 11957.0 11999.6 12552.4 8612.6 8881.2 8914.8 9010.3 9255.4 10935.7 11896.2 12035.5 12091.0 12250.0 06:24:11 INFO - PROCESS | 30948 | 06:24:11 INFO - PROCESS | 30948 | [#3] mootools.html Cycles:180 Average:5655.72 Median:4880.80 stddev:3121.09 (63.9%) stddev-sans-first:3115.01 06:24:11 INFO - PROCESS | 30948 | Values: 1605.8 1621.3 1852.6 1940.3 1960.3 7232.7 8303.8 8395.4 8606.3 8626.4 8091.5 8106.5 8122.8 8183.5 8186.5 2421.0 2425.4 2433.1 2435.3 2439.7 2407.7 2415.9 2434.8 2438.0 2444.1 2321.3 2376.7 2378.3 2411.5 2420.8 2430.0 2432.2 2432.6 2433.5 2466.0 2365.5 2379.8 2387.6 2390.0 2398.5 8380.6 8406.0 8415.2 8416.0 8423.6 5341.7 5375.1 5441.8 5447.3 5449.1 3478.6 3494.1 3527.8 3618.1 3621.1 1122.9 1201.9 1210.2 1237.7 1259.3 11657.7 11729.1 11745.3 11745.8 11758.0 4668.6 4672.3 4742.5 4765.5 4866.2 10085.8 10100.9 10208.0 10209.1 10214.1 5405.5 5428.6 5455.3 5462.6 5469.8 4805.7 4895.4 4949.6 5000.1 5000.8 3872.8 4013.7 4017.1 4023.0 4031.5 999.2 1005.9 1006.3 1010.9 1201.9 1049.9 1061.4 1069.4 1079.7 1085.4 5514.7 5643.6 5675.7 5756.1 5811.9 472.7 475.2 481.1 481.2 485.7 4058.5 4064.1 4067.9 4106.1 4106.9 10407.2 10702.7 10783.9 10794.2 10804.8 10486.1 10556.0 10556.6 10560.0 10576.4 8233.2 8342.3 8351.1 8393.9 8419.6 5737.7 5825.5 5843.2 5904.7 5962.2 9306.2 9308.7 9310.6 9327.3 9546.3 9492.5 9542.9 9583.9 9674.1 10021.9 7265.8 7319.2 7403.0 7444.3 7482.5 8147.1 8175.3 8217.9 8239.8 8266.7 7244.6 7323.3 7567.1 7589.2 7659.2 7094.5 7138.7 7144.1 7233.9 7263.3 6575.3 6576.2 6616.7 6636.3 6642.4 4947.8 4995.4 4996.5 5009.9 5024.2 4996.0 5089.9 5108.7 5152.7 5291.2 06:24:11 INFO - PROCESS | 30948 | 06:24:11 INFO - PROCESS | 30948 | [#4] prototype.html Cycles:180 Average:5862.76 Median:6705.63 stddev:1786.01 (26.6%) stddev-sans-first:1742.37 06:24:11 INFO - PROCESS | 30948 | Values: 346.4 356.1 357.3 362.8 365.1 6562.9 6653.0 6684.0 6694.3 6723.5 6617.0 6641.7 6644.6 6661.6 6665.7 4753.4 4860.8 4944.3 4951.8 4962.4 4917.4 4922.3 4936.9 4939.3 4946.2 4899.7 4957.6 4981.3 4983.7 4991.3 4986.2 4995.9 4997.7 4998.8 5000.1 4380.7 4388.3 4390.4 4398.6 4399.3 6211.1 6306.6 6309.9 6355.6 6357.2 5791.9 5831.2 5834.6 5838.5 5852.0 6860.2 6888.5 6900.6 6917.7 6923.7 4831.1 4831.8 4832.2 4836.0 4857.7 7163.1 7210.5 7218.1 7242.0 7246.5 4829.6 4964.6 4964.9 5002.8 5038.6 5078.8 5090.2 5092.2 5101.0 5103.9 5849.3 5857.8 5862.2 5865.4 5872.0 6980.1 7040.2 7045.7 7052.2 7066.6 1769.9 1778.3 1788.6 1794.7 1797.4 1154.2 1183.1 1187.9 1189.7 1195.6 6679.0 6683.1 6716.9 6717.3 6720.2 7034.8 7112.8 7132.6 7148.6 7158.7 6763.1 6835.0 6840.7 6845.2 6846.6 3887.0 3911.6 3913.2 3918.0 3924.8 7645.0 7646.3 7656.7 7662.4 7674.0 7274.4 7429.4 7429.9 7443.3 7443.8 7610.9 7621.0 7629.9 7630.3 7636.6 7248.5 7256.2 7258.3 7267.8 7268.7 7175.7 7183.9 7189.6 7192.4 7193.7 7461.0 7578.0 7629.8 7631.8 7671.2 4796.4 4816.3 4836.5 4838.4 4842.7 7272.4 7274.4 7279.4 7279.5 7317.8 6982.4 6989.5 6997.9 7001.1 7011.7 6880.7 6991.7 6996.9 7025.7 7029.0 6836.9 6875.6 6877.7 6881.0 6889.0 7065.4 7065.7 7080.2 7084.3 7099.5 6809.4 6872.8 6895.8 6896.1 6911.8 06:24:11 INFO - PROCESS | 30948 | 06:24:11 INFO - PROCESS | 30948 | [#5] yui.html Cycles:180 Average:15973.35 Median:4074.11 stddev:18284.73 (448.8%) stddev-sans-first:18300.88 06:24:11 INFO - PROCESS | 30948 | Values: 877.3 940.4 944.2 965.6 973.1 14168.6 14492.0 14538.6 14544.0 14561.8 14657.5 14779.3 14781.5 14794.4 14800.8 742.6 902.6 927.4 929.1 931.2 905.6 916.2 918.7 919.1 920.0 970.2 972.5 974.3 974.7 974.9 957.9 968.2 970.7 974.2 977.0 712.8 712.8 714.7 717.8 718.6 14933.5 14957.0 14999.7 15062.1 15065.5 15069.0 15269.2 15351.9 15365.2 15398.4 11233.2 11417.8 11445.9 11462.7 11650.3 4033.6 4114.6 4172.1 4249.2 4292.7 57055.0 57328.4 58292.1 59533.7 59739.7 11816.5 11854.3 11862.2 11969.5 12004.9 21553.5 21816.2 21993.6 22061.9 22062.0 9161.2 9167.8 9287.5 9290.8 9482.9 5001.7 5003.7 5036.7 5092.5 5124.8 3532.7 3624.3 3641.9 3650.2 3663.5 666.2 679.6 681.1 681.5 686.9 732.4 740.6 748.2 812.7 818.6 10344.5 10367.5 10749.4 10822.6 11114.8 746.3 752.5 836.7 848.9 870.6 4664.6 4714.2 4836.3 4887.2 4895.5 66995.7 67212.3 67481.3 67621.7 67977.7 56737.7 57668.7 57847.7 58486.4 58816.0 48618.3 49150.5 51237.2 52111.0 52131.0 10099.9 10190.8 10206.2 10256.5 10345.8 39345.8 39444.6 39605.4 39727.6 40235.2 46023.8 46373.5 51026.5 52033.0 52953.2 12907.4 12918.5 13120.0 13265.4 13333.9 13929.0 13981.6 14049.2 14421.9 14682.7 13660.2 13688.9 13991.9 14070.5 14565.8 12968.4 13295.6 13460.2 13792.4 14193.5 12092.8 13179.4 13203.9 13591.9 13846.0 11231.8 11382.7 11385.5 11545.7 11801.1 11236.6 11484.1 11507.8 11602.2 11782.1 06:24:11 INFO - PROCESS | 30948 | -------- Summary: end -------- 06:24:11 INFO - PROCESS | 30948 | 06:24:12 INFO - TEST-INFO | 30948: exit 0 06:24:12 INFO - TEST-OK | dromaeo_css | took 1107806ms 06:24:12 INFO - TEST-START | kraken 06:24:12 INFO - operating with platform_type : linux_ 06:24:12 INFO - Initialising browser for kraken test... 06:24:12 INFO - TEST-INFO | started process 31186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOny9x/profile http://localhost:58010/getInfo.html) 06:24:15 INFO - PROCESS | 31186 | 06:24:15 INFO - PROCESS | 31186 | (process:31263): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:24:16 INFO - PROCESS | 31186 | __metrics Screen width/height:1600/1200 06:24:16 INFO - PROCESS | 31186 | colorDepth:24 06:24:16 INFO - PROCESS | 31186 | Browser inner width/height: 1024/697 06:24:16 INFO - PROCESS | 31186 | __metrics 06:24:16 ERROR - PROCESS | 31186 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:24:17 INFO - TEST-INFO | 31186: exit 0 06:24:17 INFO - Browser initialized. 06:24:17 INFO - Running cycle 1/1 for kraken test... 06:24:17 INFO - TEST-INFO | started process 31313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOny9x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:19 INFO - PROCESS | 31313 | 06:24:19 INFO - PROCESS | 31313 | (process:31382): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:24:29 INFO - PROCESS | 31313 | RSS: Main: 150810624 06:24:29 INFO - PROCESS | 31313 | 06:24:31 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58010/tests/kraken/driver.html?testName=audio-beat-detection) 06:24:32 INFO - PROCESS | 31313 | RSS: Main: 156327936 06:24:32 INFO - PROCESS | 31313 | 06:24:35 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58010/tests/kraken/driver.html?testName=audio-dft) 06:24:36 INFO - PROCESS | 31313 | RSS: Main: 156049408 06:24:36 INFO - PROCESS | 31313 | 06:24:38 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58010/tests/kraken/driver.html?testName=audio-fft) 06:24:39 INFO - PROCESS | 31313 | RSS: Main: 156192768 06:24:39 INFO - PROCESS | 31313 | 06:24:41 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58010/tests/kraken/driver.html?testName=audio-oscillator) 06:24:42 INFO - PROCESS | 31313 | RSS: Main: 156729344 06:24:42 INFO - PROCESS | 31313 | 06:24:44 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58010/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:24:45 INFO - PROCESS | 31313 | RSS: Main: 156282880 06:24:45 INFO - PROCESS | 31313 | 06:24:48 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58010/tests/kraken/driver.html?testName=imaging-darkroom) 06:24:48 INFO - PROCESS | 31313 | RSS: Main: 156733440 06:24:48 INFO - PROCESS | 31313 | 06:24:52 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58010/tests/kraken/driver.html?testName=imaging-desaturate) 06:24:52 INFO - PROCESS | 31313 | RSS: Main: 156844032 06:24:52 INFO - PROCESS | 31313 | 06:24:55 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58010/tests/kraken/driver.html?testName=json-parse-financial) 06:24:56 INFO - PROCESS | 31313 | RSS: Main: 156590080 06:24:56 INFO - PROCESS | 31313 | 06:24:57 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58010/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:24:58 INFO - PROCESS | 31313 | RSS: Main: 156307456 06:24:58 INFO - PROCESS | 31313 | 06:24:59 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:25:00 INFO - PROCESS | 31313 | RSS: Main: 156168192 06:25:00 INFO - PROCESS | 31313 | 06:25:02 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:25:03 INFO - PROCESS | 31313 | RSS: Main: 156561408 06:25:03 INFO - PROCESS | 31313 | 06:25:05 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:25:06 INFO - PROCESS | 31313 | RSS: Main: 157224960 06:25:06 INFO - PROCESS | 31313 | 06:25:08 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:25:09 INFO - PROCESS | 31313 | RSS: Main: 157364224 06:25:09 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58010/tests/kraken/driver.html?testName=ai-astar) 06:25:11 INFO - PROCESS | 31313 | RSS: Main: 158961664 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | __start_tp_report 06:25:11 INFO - PROCESS | 31313 | _x_x_mozilla_page_load 06:25:11 INFO - PROCESS | 31313 | _x_x_mozilla_page_load_details 06:25:11 INFO - PROCESS | 31313 | |i|pagename|runs| 06:25:11 INFO - PROCESS | 31313 | |0;ai-astar;107;113;103;109;112;115;101;111;116;110 06:25:11 INFO - PROCESS | 31313 | |1;audio-beat-detection;161;128;154;175;127;161;156;132;173;127 06:25:11 INFO - PROCESS | 31313 | |2;audio-dft;161;162;163;163;164;166;161;162;162;165 06:25:11 INFO - PROCESS | 31313 | |3;audio-fft;76;76;74;172;77;77;75;74;166;77 06:25:11 INFO - PROCESS | 31313 | |4;audio-oscillator;93;91;152;92;96;93;157;93;93;150 06:25:11 INFO - PROCESS | 31313 | |5;imaging-gaussian-blur;118;118;118;119;119;118;117;117;117;117 06:25:11 INFO - PROCESS | 31313 | |6;imaging-darkroom;145;147;145;147;147;148;146;147;147;146 06:25:11 INFO - PROCESS | 31313 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;96 06:25:11 INFO - PROCESS | 31313 | |8;json-parse-financial;56;69;55;56;56;56;58;69;56;54 06:25:11 INFO - PROCESS | 31313 | |9;json-stringify-tinderbox;58;59;58;59;59;59;59;58;58;59 06:25:11 INFO - PROCESS | 31313 | |10;stanford-crypto-aes;74;73;74;74;74;75;75;76;78;75 06:25:11 INFO - PROCESS | 31313 | |11;stanford-crypto-ccm;116;119;116;116;124;113;116;113;129;127 06:25:11 INFO - PROCESS | 31313 | |12;stanford-crypto-pbkdf2;163;166;165;167;159;162;160;160;166;160 06:25:11 INFO - PROCESS | 31313 | |13;stanford-crypto-sha256-iterative;68;68;66;66;76;69;71;67;66;69 06:25:11 INFO - PROCESS | 31313 | __end_tp_report 06:25:11 INFO - PROCESS | 31313 | __start_cc_report 06:25:11 INFO - PROCESS | 31313 | _x_x_mozilla_cycle_collect,843 06:25:11 INFO - PROCESS | 31313 | __end_cc_report 06:25:11 INFO - PROCESS | 31313 | __startTimestamp1467033911567__endTimestamp 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | ------- Summary: start ------- 06:25:11 INFO - PROCESS | 31313 | Number of tests: 14 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:4.88 (4.4%) stddev-sans-first:5.07 06:25:11 INFO - PROCESS | 31313 | Values: 107.0 113.0 103.0 109.0 112.0 115.0 101.0 111.0 116.0 110.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:158.50 stddev:19.18 (12.1%) stddev-sans-first:19.88 06:25:11 INFO - PROCESS | 31313 | Values: 161.0 128.0 154.0 175.0 127.0 161.0 156.0 132.0 173.0 127.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.66 (1.0%) stddev-sans-first:1.62 06:25:11 INFO - PROCESS | 31313 | Values: 161.0 162.0 163.0 163.0 164.0 166.0 161.0 162.0 162.0 165.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:39.36 (51.8%) stddev-sans-first:41.18 06:25:11 INFO - PROCESS | 31313 | Values: 76.0 76.0 74.0 172.0 77.0 77.0 75.0 74.0 166.0 77.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:93.00 stddev:29.06 (31.2%) stddev-sans-first:30.08 06:25:11 INFO - PROCESS | 31313 | Values: 93.0 91.0 152.0 92.0 96.0 93.0 157.0 93.0 93.0 150.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 06:25:11 INFO - PROCESS | 31313 | Values: 118.0 118.0 118.0 119.0 119.0 118.0 117.0 117.0 117.0 117.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:0.87 06:25:11 INFO - PROCESS | 31313 | Values: 145.0 147.0 145.0 147.0 147.0 148.0 146.0 147.0 147.0 146.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:25:11 INFO - PROCESS | 31313 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:56.00 stddev:5.62 (10.0%) stddev-sans-first:5.89 06:25:11 INFO - PROCESS | 31313 | Values: 56.0 69.0 55.0 56.0 56.0 56.0 58.0 69.0 56.0 54.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 06:25:11 INFO - PROCESS | 31313 | Values: 58.0 59.0 58.0 59.0 59.0 59.0 59.0 58.0 58.0 59.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:1.40 (1.9%) stddev-sans-first:1.45 06:25:11 INFO - PROCESS | 31313 | Values: 74.0 73.0 74.0 74.0 74.0 75.0 75.0 76.0 78.0 75.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:117.50 stddev:5.74 (4.9%) stddev-sans-first:6.00 06:25:11 INFO - PROCESS | 31313 | Values: 116.0 119.0 116.0 116.0 124.0 113.0 116.0 113.0 129.0 127.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:164.00 stddev:3.01 (1.8%) stddev-sans-first:3.19 06:25:11 INFO - PROCESS | 31313 | Values: 163.0 166.0 165.0 167.0 159.0 162.0 160.0 160.0 166.0 160.0 06:25:11 INFO - PROCESS | 31313 | 06:25:11 INFO - PROCESS | 31313 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:3.06 (4.5%) stddev-sans-first:3.24 06:25:11 INFO - PROCESS | 31313 | Values: 68.0 68.0 66.0 66.0 76.0 69.0 71.0 67.0 66.0 69.0 06:25:11 INFO - PROCESS | 31313 | -------- Summary: end -------- 06:25:11 INFO - PROCESS | 31313 | 06:25:12 INFO - TEST-INFO | 31313: exit 0 06:25:12 INFO - TEST-OK | kraken | took 59872ms 06:25:12 INFO - SUITE-END | took 1167s 06:25:12 INFO - Completed test suite (00:19:27) 06:25:12 INFO - javascript benchmark 06:25:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.7883087599307, 3344.481605351171, 3345.1971526833568, 3372.6121496027963, 3403.1662242750513, 5524.4199359067325, 5545.3622833374175, 5562.443755624446, 5582.078956972095, 5590.18942253373, 5532.723363831802, 5580.302462192226, 5586.916196257049, 5605.7197140142935, 5610.831675049745, 5067.569256613192, 5100.642954993134, 5166.354205724285, 5175.042617115827, 5179.792808287664, 5065.848024559251, 5125.615578831584, 5212.635115541913, 5257.316548848664, 5283.339582552181, 5093.159628661267, 5110.488951104897, 5155.690658560479, 5168.147255702824, 5196.740162991854, 5105.132127538309, 5110.974445127769, 5123.974380128076, 5124.769385377667, 5163.8192663256605, 4917.557419832232, 5018.774155163026, 5036.294918711384, 5084.0, 5095.235714642796, 5348.598855085884, 5363.115086010804, 5410.0, 5441.863953401157, 5485.341758988907, 5838.970805145947, 5871.530277577784, 5882.147088672162, 5886.852828679274, 5890.145928840337, 5820.592558520905, 5924.703764811785, 5948.40515948406, 5960.552958528085, 5961.195238642771, 5578.107502799573, 5612.102063669793, 5615.7472913718575, 5623.0721930881355, 5649.209110724501, 6078.969605151946, 6104.298005729398, 6110.114033465212, 6110.419510146529, 6115.4801841843055, 5638.126090455986, 5819.388964158787, 5842.065269556935, 5865.530757539386, 5876.970615146897, 5947.256592925884, 5952.464278214981, 5954.07711804671, 5958.165856779968, 5961.731722072517, 5846.8538286542325, 5897.734601942923, 5900.557458190653, 5904.0, 5904.675242861598, 5770.394108618535, 5865.237519122572, 5869.530437564985, 5943.435373639497, 5993.0710739835395, 4565.246734288805, 4574.0, 4584.564466375689, 4588.311753237042, 4613.354130421743, 4093.3041382964966, 4113.91772164561, 4115.0741083256025, 4119.526254480713, 4144.8134833932545, 5573.052581061148, 5750.194972703741, 5782.306123265235, 5792.88414231713, 5817.0401883689565, 5957.821265362046, 6012.759489620366, 6041.093835924558, 6053.334133245339, 6068.757249709962, 5578.944210557843, 5734.996375634248, 5743.597948143673, 5744.052231381859, 5761.5102716269585, 4961.875953101129, 5005.849824505271, 5021.196608542616, 5021.573166280834, 5051.040302342617, 6114.174586430864, 6146.200993870768, 6168.414000670019, 6171.352008039181, 6173.876522469525, 5876.6180198286975, 5887.882242355044, 5936.5844390892225, 5938.792142275172, 5975.462208401352, 6098.414412252935, 6113.658745237643, 6159.846003849761, 6161.4146656067605, 6170.012797952306, 5818.650880947157, 5828.825135245949, 5828.94171058284, 5834.416558344302, 5888.293404791452, 5841.94158058431, 5935.109733539831, 5935.554833387427, 6005.3694362091355, 6057.4851137653795, 5841.299044114733, 5848.385919478394, 5850.23946886919, 5851.385604511465, 5853.414658534283, 5793.217915581511, 5815.854603634943, 5818.679972601548, 5831.35855055952, 5832.883342333214, 5578.888422231614, 5669.489745922887, 5677.5457963362005, 5727.8568035799435, 5782.913256301074, 5842.5325973921135, 5876.6180198286975, 5906.822795316148, 5910.349861515316, 5911.645301281937, 5749.080147176432, 5749.195112684144, 5759.65442073477, 5760.337561180518, 5761.596688231783], "value": 5500.797123996697, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.5692921136654, 669.2003056347663, 673.946084313255, 681.3867519232693, 681.9249882512926, 38734.41898371523, 39529.80235098828, 39530.802345988304, 39658.20683586327, 39675.603243967555, 43116.0, 43858.342124868155, 43869.903252418706, 43939.3409098863, 43969.0, 8845.24815390691, 9000.099990001014, 9009.864852027193, 9016.098390160996, 9038.819223615557, 8756.649734010633, 8862.512561809099, 8905.821883562325, 9092.727218183465, 9109.316801239933, 9082.409643373192, 9147.765051717999, 9164.991850896396, 9176.678816241432, 9191.1727944485, 8996.955015224914, 9047.185753282203, 9069.31980101495, 9107.63569457221, 9115.81768364629, 9001.909980900238, 9069.319801014884, 9091.31815113869, 9105.271578273789, 9151.222146117589, 44089.11821763579, 44524.554754452365, 44667.10665786666, 44824.327635085174, 44827.32759008618, 3964.5638979712207, 4078.796060197008, 4283.721558098714, 4470.932936005963, 4674.298855171717, 32966.34067318664, 33095.6690433095, 33692.0, 34009.489857651904, 35231.471527927104, 4292.1415716856445, 4386.517483076859, 4394.538573449806, 4405.8237670493145, 4425.380446737459, 218695.0, 221088.0, 221978.0, 224166.0, 225135.0, 40747.59252407438, 41695.374569381485, 57221.42778572161, 58226.0, 58409.0, 38463.423048654295, 38464.0, 38486.61513384886, 38499.0, 38564.22871542553, 16252.349906003863, 16545.25546350417, 16551.83448165527, 16622.667546648998, 16627.83372166287, 13609.931950340186, 13708.314584270747, 13713.588592342247, 13756.243406612732, 13814.861851381558, 9366.157045865904, 9633.855492167622, 9649.228061755042, 9676.56455459492, 9695.127438530426, 3611.9819400903352, 3689.538807649044, 3740.2893450244364, 3742.55089389275, 3769.754965927206, 1158.3513232589776, 1169.9415029248673, 1201.2372143688647, 1217.4825699077855, 1285.794272916329, 34689.0, 35162.824185878904, 37766.24467510689, 37807.243855122746, 38268.42597361042, 1220.1946715168124, 1245.0848626259692, 1245.7197130645532, 1250.46230121047, 1299.3353859643923, 17197.828021719622, 17271.222794974256, 17336.826631733522, 17353.2191051403, 17558.122093895254, 514109.0, 522623.0, 571626.0, 588460.0, 589336.0, 57285.0, 57826.4217357821, 57885.71057144687, 58096.0, 58141.0, 1506.4877941499942, 1539.8229203641501, 1561.1725785333792, 1581.2251996521622, 1586.1672621873608, 30546.541801872547, 32987.0, 33550.83224583959, 33739.0, 33819.830900846326, 54386.45613543814, 54644.45355546394, 54796.45203547914, 54860.451395485536, 55024.0, 426110.0, 429236.0, 430635.0, 432212.0, 433108.0, 31406.842965785025, 31520.52719209168, 31827.20431989219, 32333.0, 32553.186170345933, 50778.0, 51262.74368628133, 51336.486635134665, 51900.22149667682, 52155.73922130365, 43434.0, 43451.34822977721, 43480.34779478374, 43520.34719479147, 44334.55665443304, 42408.15183696247, 42830.35754463623, 42848.35727464153, 43229.0, 43776.56223437852, 44426.55573444354, 44718.3292250623, 50373.24440133474, 50500.49499505105, 51233.48766512287, 39669.404958925064, 40953.79523102365, 41152.38271425991, 43060.56939430691, 43997.0, 33915.98252052344, 34293.82853085719, 34587.4811877817, 34663.48004779981, 35261.82369088138], "value": 19896.26220771595, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.18782810036134, 411.2782067471585, 414.0745433955108, 426.2880988748789, 429.32595824555443, 13835.861641383583, 18675.71986420203, 19296.324628638016, 19334.419967400983, 19385.515362115955, 18585.0, 19416.22335106594, 20071.799282007174, 20073.297434589793, 20204.0, 5832.416758324176, 5834.066549352105, 5934.762609495615, 5996.910046349309, 6046.576739628205, 5891.587588868781, 5950.404959504037, 5963.165156878041, 5995.160677505153, 5996.040633498641, 5764.308283006024, 5933.614315069507, 5940.405959404068, 5969.074793407029, 6012.699365031753, 5910.67491287979, 5939.792107276225, 5945.137954996501, 5956.612820166697, 5969.015112506453, 5122.974385128088, 5301.7084060376665, 5328.147496400557, 5331.920021199685, 5395.0558652236095, 17940.730889036677, 23066.65400019001, 23070.42323941915, 23320.65019024716, 23641.645375319385, 2546.847189168637, 2584.806139539542, 2590.6891173059353, 2879.3521457671854, 3276.3611095836322, 14418.711625767532, 14592.0, 14697.77953330701, 14713.337899794535, 14721.55835324942, 1932.4492519631838, 1979.6436641404541, 2029.5636438165718, 2043.1214577731569, 2094.1937354118622, 73577.89633155454, 78441.60779196124, 79834.0, 82594.0, 83505.0, 10660.0, 11050.447477626087, 11534.423278836024, 11561.479733412016, 11737.06103511717, 15903.04581725077, 15903.284352204179, 15907.284172212278, 15972.520824375288, 16040.43858464948, 8722.433041852259, 8765.561721913879, 8866.246369058703, 8934.240589549961, 8951.820963580822, 8562.229399354088, 8605.397622166389, 8641.913580864237, 8667.566621668891, 8710.259627931697, 4930.556249937451, 5040.873978150576, 5041.621878359138, 5074.188129899198, 5101.642884998015, 1997.9600407991759, 2010.7587089549347, 2033.8677985930867, 2114.883681397507, 2136.198925402974, 985.3693636072919, 1060.226034994443, 1063.1176123817368, 1126.4424110065406, 1155.364549497773, 18212.726809097872, 18379.90810045968, 18948.14733337003, 19613.41159765209, 20629.381118566467, 1097.8737445193744, 1130.8190689489807, 1132.7394699219226, 1144.8168293073068, 1147.1683029803492, 10662.466876656135, 10826.67519974402, 10922.836157457645, 10930.781384372269, 10951.0, 504311.0, 513859.0, 515890.0, 536447.0, 540649.0, 85703.0, 85866.0, 85936.57031714801, 94156.0, 99338.503307483, 1192.2369683402628, 1196.3719047500133, 1198.2750435986277, 1226.1294480918468, 1268.207370393504, 16344.427945021867, 16419.671606567565, 16523.0, 17073.658526829146, 17441.0, 40132.79933600313, 40235.0, 40489.79755101206, 41311.793441033806, 41491.0, 57692.423075770384, 58900.70549647224, 58934.70532647309, 59145.40854591399, 59235.703821480616, 8544.444611100258, 8878.911210887809, 8909.242714369091, 8975.640974360953, 9052.864207036768, 13461.528846490326, 13537.1200871943, 13836.308184590931, 14038.719225615634, 14293.785593216318, 11766.941165294118, 12145.089118315986, 12404.689882753004, 12617.558385456465, 12651.620451386472, 11211.55153793839, 11428.657140285804, 11831.11266654987, 11948.283103013848, 12192.939035304767, 6253.030780229072, 8852.822943541221, 11957.043436524884, 11999.64001079969, 12552.43514041852, 8612.612432440681, 8881.156290152425, 8914.821703566022, 9010.32422568323, 9255.398399104037, 10935.671929842118, 11896.167268291483, 12035.518579257083, 12091.032717382412, 12250.019998400285], "value": 9600.19068108489, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1605.8233594304625, 1621.327149233068, 1852.6016906365128, 1940.301491463073, 1960.2649006622516, 7232.674529646165, 8303.792405189859, 8395.370347223952, 8606.311495080394, 8626.43928144671, 8091.4740541864885, 8106.513609183438, 8122.837543249131, 8183.508989460636, 8186.467879587823, 2420.9515809683794, 2425.405775584984, 2433.1362366359863, 2435.3424575364643, 2439.6706444629926, 2407.6990376202975, 2415.915442959497, 2434.75652434756, 2438.0247900839718, 2444.0712529238954, 2321.3268152235833, 2376.66726658268, 2378.3340664613934, 2411.5297516984197, 2420.7942324902315, 2430.0158435833514, 2432.2338463383976, 2432.6107822748363, 2433.452473193535, 2465.963010554843, 2365.5387199496104, 2379.845310054841, 2387.570237357275, 2389.9522009559887, 2398.4723360860585, 8380.622871970776, 8406.0, 8415.200555947236, 8416.0, 8423.578821058984, 5341.679499230058, 5375.059364611177, 5441.755121019563, 5447.319085114361, 5449.100898351767, 3478.5999610044914, 3494.143934736006, 3527.8412471438846, 3618.113562177257, 3621.1490299779794, 1122.8708698499613, 1201.8677945425995, 1210.152892974921, 1237.665830225834, 1259.3262604506544, 11657.650270491898, 11729.120315976335, 11745.29528228309, 11745.823812642817, 11758.0, 4668.626509879202, 4672.322513235562, 4742.5020372861045, 4765.547273009059, 4866.245731911559, 10085.848712269322, 10100.949495252476, 10208.0, 10209.132223760915, 10214.131798797185, 5405.540529055074, 5428.565714742811, 5455.34535855692, 5462.562994960394, 5469.753861076261, 4805.663603547788, 4895.363602731622, 4949.57928576075, 5000.1249781288125, 5000.799968001239, 3872.8063596820048, 4013.7391069580385, 4017.0961533655277, 4022.9798851005557, 4031.5162180538523, 999.2106236073421, 1005.9396436213705, 1006.3006210683651, 1010.9292349535461, 1201.8978386837216, 1049.9107575856137, 1061.3843970497094, 1069.4064794039382, 1079.6599071292517, 1085.4355735017746, 5514.696691681996, 5643.633163844337, 5675.744591493392, 5756.136579513107, 5811.854703632358, 472.65260033875074, 475.1708269070494, 481.0907385042273, 481.1771870102095, 485.66246458710856, 4058.512978442606, 4064.1058967027207, 4067.8576249831112, 4106.117184805281, 4106.9441880653085, 10407.167426605853, 10702.732431689114, 10783.946080269548, 10794.190435717353, 10804.783904322027, 10486.05625493694, 10556.0, 10556.577736890438, 10560.0, 10576.36541807494, 8233.217844304781, 8342.332613391036, 8351.123132071045, 8393.916060839436, 8419.621117049748, 5737.655740655574, 5825.533957283323, 5843.211166492639, 5904.734286957183, 5962.165296858357, 9306.208972237435, 9308.674196403093, 9310.627574897198, 9327.300452466228, 9546.284028698014, 9492.477913714813, 9542.904570954202, 9583.904160958302, 9674.08096230857, 10021.949890250502, 7265.818354540967, 7319.194888562148, 7403.037605111301, 7444.330010299099, 7482.476226664081, 8147.10381858007, 8175.305099066408, 8217.917820821714, 8239.835203295781, 8266.669333226604, 7244.637768111468, 7323.304286092813, 7567.054118235221, 7589.241075892367, 7659.195784442553, 7094.503384763017, 7138.714451422093, 7144.106986626672, 7233.891491627735, 7263.34629883313, 6575.342465753386, 6576.177977752781, 6616.735330586723, 6636.336366363518, 6642.4021838034805, 4947.777350019186, 4995.350604421402, 4996.450390457119, 5009.8747531310555, 5024.246363045426, 4995.950040499549, 5089.9056702809075, 5108.719020453911, 5152.690838549699, 5291.232771248225], "value": 4523.877325191371, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.3851663297646, 356.1381456874364, 357.2658187424841, 362.7732667083073, 365.08364006344067, 6562.9015564766505, 6653.0, 6684.030815531745, 6694.330566943303, 6723.529352945296, 6617.040529123286, 6641.701123449444, 6644.601323920569, 6661.63361015144, 6665.733370665168, 4753.358296629954, 4860.756962151878, 4944.283078953549, 4951.752412379366, 4962.40451145863, 4917.385326834145, 4922.286268491084, 4936.864521160135, 4939.28380384844, 4946.233333833262, 4899.706017638953, 4957.603391728653, 4981.277714731362, 4983.72589507577, 4991.326170966928, 4986.177280748672, 4995.875103122451, 4997.700137991714, 4998.825041123543, 5000.0999820032375, 4380.671449641258, 4388.319810429389, 4390.407295015196, 4398.64810815134, 4399.252127138394, 6211.099390588384, 6306.558540902139, 6309.873802523924, 6355.633538789182, 6357.17356743625, 5791.855203619901, 5831.183634291203, 5834.5915785895, 5838.5329173666005, 5852.0, 6860.245373008965, 6888.483363747739, 6900.585964842076, 6917.654117294165, 6923.653817309114, 4831.05794370098, 4831.782569784368, 4832.226843705025, 4836.032793441291, 4857.708537487762, 7163.10461192351, 7210.53131546453, 7218.097737782829, 7241.963790181068, 7246.5289756165685, 4829.5653391194965, 4964.578010869117, 4964.925526117111, 5002.799888004512, 5038.571721403721, 5078.796848126108, 5090.2364645303505, 5092.159793634009, 5101.0, 5103.948960510347, 5849.268841394825, 5857.7656893724625, 5862.237909071793, 5865.384134665884, 5872.031114865999, 6980.092587963633, 7040.225575186725, 7045.68294426752, 7052.188998265266, 7066.611336376446, 1769.9469015929542, 1778.2531336838558, 1788.6333301673126, 1794.676958147546, 1797.3709201779272, 1154.1516985016005, 1183.0594677231622, 1187.9049676025897, 1189.6906804230962, 1195.623378635727, 6679.031540426611, 6683.097781799394, 6716.932830671729, 6717.328267173341, 6720.193576770721, 7034.753783617652, 7112.786616401516, 7132.607706576188, 7148.642567871586, 7158.749443769443, 6763.12079429671, 6835.0, 6840.6921688524135, 6845.212800527904, 6846.554973926679, 3886.96113038866, 3911.5697273299916, 3913.158670885773, 3918.0204948762807, 3924.843006279774, 7645.044369453818, 7646.311831935152, 7656.655450504741, 7662.4253181011645, 7674.040744906887, 7274.381677557467, 7429.36850367714, 7429.851402972018, 7443.292887175709, 7443.776686699408, 7610.9238907610215, 7620.961895190489, 7629.923700763033, 7630.2751238632245, 7636.618169091523, 7248.456365772483, 7256.1655409628565, 7258.346748792634, 7267.818304542428, 7268.709251629875, 7175.748848790267, 7183.928160718326, 7189.604571748604, 7192.4246060314, 7193.748218812317, 7460.962695186489, 7578.0, 7629.809254768676, 7631.809204769926, 7671.194524574839, 4796.424429068534, 4816.301636262792, 4836.516348365135, 4838.395200599925, 4842.709437433765, 7272.381847543018, 7274.381677557467, 7279.381252593589, 7279.490435669452, 7317.817054573678, 6982.441404687715, 6989.47578931572, 6997.930020699728, 7001.054857594159, 7011.719531218694, 6880.69036893331, 6991.706534291173, 6996.860062798817, 7025.68384422692, 7028.98079778419, 6836.897446538405, 6875.5530890491955, 6877.65611719402, 6880.9655951721925, 6889.035535025, 7065.364117229474, 7065.717371305296, 7080.185778635317, 7084.25615310385, 7099.503034787722, 6809.38715515606, 6872.759453419107, 6895.75864844728, 6896.069030680794, 6911.827204319932], "value": 5277.8369270705325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.3025444771407, 940.4122423485321, 944.1738478831023, 965.565495527013, 973.0998826085873, 14168.645783855409, 14492.0, 14538.636534086652, 14544.0, 14561.78157327641, 14657.486987955424, 14779.334929928153, 14781.482648107318, 14794.408223671067, 14800.777988330183, 742.5767312631802, 902.5983437370372, 927.4342650982895, 929.1359036096428, 931.2038207332735, 905.6377449020379, 916.1845957098154, 918.7243826851951, 919.0992827029515, 920.0385597051064, 970.1995853420921, 972.5088830140769, 974.2790335151972, 974.6978436684615, 974.8683927669745, 957.9473128977903, 968.2060710217625, 970.6602689058808, 974.1573538888811, 977.0376179463223, 712.796852896927, 712.8396110875063, 714.6605362452846, 717.7846646006229, 718.6370882704201, 14933.477328293458, 14957.027793193407, 14999.700005999819, 15062.096274223582, 15065.548033559011, 15069.0, 15269.160196189205, 15351.923240383838, 15365.154916479589, 15398.384064637401, 11233.21367504275, 11417.828732569018, 11445.94277028618, 11462.656120316404, 11650.300981941025, 4033.596640335972, 4114.629683328515, 4172.061286210609, 4249.213895429324, 4292.699511034229, 57055.0, 57328.42671573273, 58292.12561811576, 59533.702331488064, 59739.701301493216, 11816.527338906519, 11854.348010859314, 11862.169648124549, 11969.521219151136, 12004.879951200377, 21553.461163471038, 21816.236431724814, 21993.560128797333, 22061.889690551765, 22062.0, 9161.221296189766, 9167.770805729777, 9287.535623218811, 9290.814183716288, 9482.857757133648, 5001.699898006059, 5003.74981250936, 5036.722980236123, 5092.465291144376, 5124.769385377667, 3532.682058614737, 3624.293262813726, 3641.9089522761615, 3650.233450975272, 3663.4871118043493, 666.1939053745023, 679.6499802601664, 681.0601370109217, 681.536555142498, 686.8694947959972, 732.4470025131099, 740.6148802622606, 748.2031636307315, 812.7196117339508, 818.5702506184301, 10344.482775861177, 10367.481625918674, 10749.408782517037, 10822.56709731602, 11114.833277500844, 746.3394895517506, 752.499587774135, 836.6736972580699, 848.8896443462311, 870.6299822575506, 4664.55686709762, 4714.175019371596, 4836.347093142451, 4887.242477416006, 4895.510448955076, 66995.66502167458, 67212.3278767206, 67481.32518674848, 67621.66189169022, 67977.66011169912, 56737.71631141818, 57668.71165644145, 57847.710761445924, 58486.41513584895, 58816.0, 48618.27072593914, 49150.50849491531, 51237.231441528405, 52111.0, 52131.0, 10099.949500252746, 10190.796184076129, 10206.183505319408, 10256.48717564104, 10345.793084138124, 39345.80327098346, 39444.60555394524, 39605.40591891066, 39727.60272397355, 40235.1952960945, 46023.76988115038, 46373.536264636925, 51026.489735103656, 52033.0, 52953.20570191373, 12907.354632268161, 12918.547850825553, 13120.0, 13265.403056862271, 13333.866661333263, 13929.0, 13981.580552583438, 14049.157050576998, 14421.927890360901, 14682.706345873235, 13660.248686322348, 13688.863111368759, 13991.860081399056, 14070.507532236323, 14565.781513277521, 12968.416421260878, 13295.601131966056, 13460.192388456724, 13792.379342929793, 14193.503227386991, 12092.75814483723, 13179.40692668813, 13203.933980330037, 13591.932040339734, 13846.0, 11231.775364492827, 11382.715432114263, 11385.487653055798, 11545.711357216136, 11801.114916381477, 11236.550537978716, 11484.138689598147, 11507.769844603228, 11602.245854019462, 11782.116341274268], "value": 7367.636758448366, "unit": "score"}], "name": "dromaeo_css", "value": 7547.474616389086, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 103.0, 109.0, 112.0, 115.0, 101.0, 111.0, 116.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 154.0, 175.0, 127.0, 161.0, 156.0, 132.0, 173.0, 127.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 163.0, 164.0, 166.0, 161.0, 162.0, 162.0, 165.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 172.0, 77.0, 77.0, 75.0, 74.0, 166.0, 77.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 152.0, 92.0, 96.0, 93.0, 157.0, 93.0, 93.0, 150.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 69.0, 55.0, 56.0, 56.0, 56.0, 58.0, 69.0, 56.0, 54.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 74.0, 74.0, 75.0, 75.0, 76.0, 78.0, 75.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 116.0, 116.0, 124.0, 113.0, 116.0, 113.0, 129.0, 127.0], "value": 118.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 165.0, 167.0, 159.0, 162.0, 160.0, 160.0, 166.0, 160.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 66.0, 76.0, 69.0, 71.0, 67.0, 66.0, 69.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1529.1, "alertThreshold": 2.0}]} 06:25:12 INFO - Return code: 0 06:25:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:25:12 ERROR - # TBPL SUCCESS # 06:25:12 INFO - Running post-action listener: _resource_record_post_action 06:25:12 INFO - Running post-run listener: _resource_record_post_run 06:25:13 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 477130752; Read time: 8; Write time: 411760 06:25:13 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 249585664; Read time: 0; Write time: 265780 06:25:13 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 223653888; Read time: 8; Write time: 145284 06:25:13 INFO - Running post-run listener: _upload_blobber_files 06:25:13 INFO - Blob upload gear active. 06:25:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:25:13 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 06:25:13 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'] 06:25:13 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 06:25:14 INFO - (blobuploader) - INFO - Open directory for files ... 06:25:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:25:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:25:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:15 INFO - (blobuploader) - INFO - Done attempting. 06:25:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:25:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:25:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:15 INFO - (blobuploader) - INFO - Done attempting. 06:25:15 INFO - (blobuploader) - INFO - Iteration through files over. 06:25:15 INFO - Return code: 0 06:25:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:25:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:25:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab42fd880921e255a28781a08d712a062631f10286910ae34689f4fe05d7cfe2f37b773cba34b1f825c7dfee7c5e8db16d0372da652fd5004becaac912219eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe79679919680bdf506cc1e6f399f8666793837c1ac25f2d1760e1d66adae88e73b45a9420a7568db160c8f2e99cdbd78bdb7ad1fe19364f7fcc0512abe06916"} 06:25:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:25:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:25:15 INFO - Contents: 06:25:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab42fd880921e255a28781a08d712a062631f10286910ae34689f4fe05d7cfe2f37b773cba34b1f825c7dfee7c5e8db16d0372da652fd5004becaac912219eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe79679919680bdf506cc1e6f399f8666793837c1ac25f2d1760e1d66adae88e73b45a9420a7568db160c8f2e99cdbd78bdb7ad1fe19364f7fcc0512abe06916"} 06:25:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:25:15 INFO - Copying logs to upload dir... 06:25:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:25:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1219.856515 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 19 secs) (at 2016-06-27 06:25:15.247911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:15.251486) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643 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/ab42fd880921e255a28781a08d712a062631f10286910ae34689f4fe05d7cfe2f37b773cba34b1f825c7dfee7c5e8db16d0372da652fd5004becaac912219eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe79679919680bdf506cc1e6f399f8666793837c1ac25f2d1760e1d66adae88e73b45a9420a7568db160c8f2e99cdbd78bdb7ad1fe19364f7fcc0512abe06916"} 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.011290 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/ab42fd880921e255a28781a08d712a062631f10286910ae34689f4fe05d7cfe2f37b773cba34b1f825c7dfee7c5e8db16d0372da652fd5004becaac912219eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe79679919680bdf506cc1e6f399f8666793837c1ac25f2d1760e1d66adae88e73b45a9420a7568db160c8f2e99cdbd78bdb7ad1fe19364f7fcc0512abe06916"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:15.278093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:15.278473) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467032694.463657-292185643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:15.360248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:25:15.360631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:25:15.360949) ========= ========= Total master_lag: 0.18 =========