builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1461368953.32 results: success (0) buildid: 20160422141954 builduid: a8fa92f486c841e2a62a6cc39bf9290a revision: c0be14550a2b77f8f8b4aab158fc3525ffc82828 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.320803) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.321216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.321501) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.352956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.353220) ========= 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=6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 16:49:13-- 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% 221M=0s 2016-04-22 16:49:14 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.272237 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.640927) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.641250) ========= 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=6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017669 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.693837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 16:49:13.694144) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c0be14550a2b77f8f8b4aab158fc3525ffc82828 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c0be14550a2b77f8f8b4aab158fc3525ffc82828 --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=6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 16:49:14,211 truncating revision to first 12 chars 2016-04-22 16:49:14,211 Setting DEBUG logging. 2016-04-22 16:49:14,211 attempt 1/10 2016-04-22 16:49:14,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c0be14550a2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 16:49:15,055 unpacking tar archive at: mozilla-aurora-c0be14550a2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.137408 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 16:49:14.843976) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:14.844253) ========= script_repo_revision: c0be14550a2b77f8f8b4aab158fc3525ffc82828 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:14.844921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:14.845202) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:14.855792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-22 16:49:14.856066) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:49:15 INFO - MultiFileLogger online at 20160422 16:49:15 in /builds/slave/test 16:49:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:49:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:49:15 INFO - {'append_to_log': False, 16:49:15 INFO - 'base_work_dir': '/builds/slave/test', 16:49:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:49:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:49:15 INFO - 'branch': 'Mozilla-Aurora', 16:49:15 INFO - 'buildbot_json_path': 'buildprops.json', 16:49:15 INFO - 'config_files': ('talos/linux_config.py',), 16:49:15 INFO - 'default_actions': ('clobber', 16:49:15 INFO - 'read-buildbot-config', 16:49:15 INFO - 'download-and-extract', 16:49:15 INFO - 'populate-webroot', 16:49:15 INFO - 'create-virtualenv', 16:49:15 INFO - 'install', 16:49:15 INFO - 'run-tests'), 16:49:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:49:15 INFO - 'download_minidump_stackwalk': True, 16:49:15 INFO - 'download_symbols': 'ondemand', 16:49:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:49:15 INFO - 'tooltool.py': '/tools/tooltool.py', 16:49:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:49:15 INFO - '/tools/misc-python/virtualenv.py')}, 16:49:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:49:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:49:15 INFO - 'installer_path': 'installer.exe', 16:49:15 INFO - 'log_level': 'info', 16:49:15 INFO - 'log_name': 'talos', 16:49:15 INFO - 'log_to_console': True, 16:49:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:49:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:49:15 INFO - 'opt_config_files': (), 16:49:15 INFO - 'pip_index': False, 16:49:15 INFO - 'sps_profile': False, 16:49:15 INFO - 'sps_profile_interval': 0, 16:49:15 INFO - 'suite': 'dromaeojs-e10s', 16:49:15 INFO - 'system_bits': '32', 16:49:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:49:15 INFO - 'title': 'talos-linux64-ix-050', 16:49:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:49:15 INFO - 'use_talos_json': True, 16:49:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:49:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:49:15 INFO - 'work_dir': 'build'} 16:49:15 INFO - ##### 16:49:15 INFO - ##### Running clobber step. 16:49:15 INFO - ##### 16:49:15 INFO - Running pre-action listener: _resource_record_pre_action 16:49:15 INFO - Running main action method: clobber 16:49:15 INFO - rmtree: /builds/slave/test/build 16:49:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:49:15 INFO - Running post-action listener: _resource_record_post_action 16:49:15 INFO - ##### 16:49:15 INFO - ##### Running read-buildbot-config step. 16:49:15 INFO - ##### 16:49:15 INFO - Running pre-action listener: _resource_record_pre_action 16:49:15 INFO - Running main action method: read_buildbot_config 16:49:15 INFO - Using buildbot properties: 16:49:15 INFO - { 16:49:15 INFO - "project": "", 16:49:15 INFO - "product": "firefox", 16:49:15 INFO - "script_repo_revision": "production", 16:49:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:49:15 INFO - "repository": "", 16:49:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:49:15 INFO - "buildid": "20160422141954", 16:49:15 INFO - "pgo_build": "True", 16:49:15 INFO - "basedir": "/builds/slave/test", 16:49:15 INFO - "buildnumber": 310, 16:49:15 INFO - "slavename": "talos-linux64-ix-050", 16:49:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:49:15 INFO - "platform": "ubuntu64_hw", 16:49:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:49:15 INFO - "branch": "mozilla-aurora", 16:49:15 INFO - "repo_path": "releases/mozilla-aurora", 16:49:15 INFO - "revision": "c0be14550a2b77f8f8b4aab158fc3525ffc82828", 16:49:15 INFO - "stage_platform": "linux64-pgo", 16:49:15 INFO - "builduid": "a8fa92f486c841e2a62a6cc39bf9290a", 16:49:15 INFO - "slavebuilddir": "test" 16:49:15 INFO - } 16:49:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 16:49:15 INFO - Running post-action listener: _resource_record_post_action 16:49:15 INFO - ##### 16:49:15 INFO - ##### Running download-and-extract step. 16:49:15 INFO - ##### 16:49:15 INFO - Running pre-action listener: _resource_record_pre_action 16:49:15 INFO - Running main action method: download_and_extract 16:49:15 INFO - mkdir: /builds/slave/test/build/tests 16:49:15 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')]} 16:49:15 INFO - https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:49:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:49:29 INFO - Downloaded 1448 bytes. 16:49:29 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:29 INFO - Using the following test package requirements: 16:49:29 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:49:29 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:49:29 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:49:29 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:29 INFO - u'jsshell-linux-x86_64.zip'], 16:49:29 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:49:29 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:49:29 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:49:29 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:49:29 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:49:29 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:49:29 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:49:29 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:49:29 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')]} 16:49:29 INFO - https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:49:31 INFO - Downloaded 23358968 bytes. 16:49:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:49:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:49:32 INFO - Return code: 0 16:49:32 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:49:32 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')]} 16:49:32 INFO - https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:49:35 INFO - Downloaded 23358968 bytes. 16:49:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:49:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:49:37 INFO - Return code: 0 16:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:37 INFO - https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:49:38 INFO - Downloaded 10845198 bytes. 16:49:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:49:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:49:38 INFO - Return code: 0 16:49:38 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')]} 16:49:38 INFO - https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:49:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:49:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:49:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:49:39 INFO - Downloaded 60837874 bytes. 16:49:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:49:39 INFO - mkdir: /builds/slave/test/properties 16:49:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:49:39 INFO - Writing to file /builds/slave/test/properties/build_url 16:49:39 INFO - Contents: 16:49:39 INFO - build_url:https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:49:40 INFO - Running post-action listener: _resource_record_post_action 16:49:40 INFO - Running post-action listener: set_extra_try_arguments 16:49:40 INFO - ##### 16:49:40 INFO - ##### Running populate-webroot step. 16:49:40 INFO - ##### 16:49:40 INFO - Running pre-action listener: _resource_record_pre_action 16:49:40 INFO - Running main action method: populate_webroot 16:49:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:49:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:49:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:49:40 INFO - '--tppagecycles', 16:49:40 INFO - '7'], 16:49:40 INFO - 'tests': ['tsvgm']}}, 16:49:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:49:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:49:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:49:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:49:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:49:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:49:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:40 INFO - 'talos_options': ['--e10s'], 16:49:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:40 INFO - 'tests': ['damp', 'tps']}, 16:49:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:40 INFO - 'talos_options': ['--e10s'], 16:49:40 INFO - 'tests': ['damp', 'tps']}, 16:49:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:49:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:49:40 INFO - 'other': {'tests': ['a11yr', 16:49:40 INFO - 'ts_paint', 16:49:40 INFO - 'tpaint', 16:49:40 INFO - 'sessionrestore', 16:49:40 INFO - 'sessionrestore_no_auto_restore', 16:49:40 INFO - 'tabpaint']}, 16:49:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:49:40 INFO - 'tests': ['a11yr', 16:49:40 INFO - 'ts_paint', 16:49:40 INFO - 'tpaint', 16:49:40 INFO - 'sessionrestore', 16:49:40 INFO - 'sessionrestore_no_auto_restore', 16:49:40 INFO - 'tabpaint']}, 16:49:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:49:40 INFO - 'tests': ['a11yr', 16:49:40 INFO - 'ts_paint', 16:49:40 INFO - 'tpaint', 16:49:40 INFO - 'sessionrestore', 16:49:40 INFO - 'sessionrestore_no_auto_restore', 16:49:40 INFO - 'tabpaint']}, 16:49:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:49:40 INFO - 'tests': ['a11yr', 16:49:40 INFO - 'ts_paint', 16:49:40 INFO - 'tpaint', 16:49:40 INFO - 'sessionrestore', 16:49:40 INFO - 'sessionrestore_no_auto_restore', 16:49:40 INFO - 'tabpaint']}, 16:49:40 INFO - 'other_l64': {'tests': ['a11yr', 16:49:40 INFO - 'ts_paint', 16:49:40 INFO - 'tpaint', 16:49:40 INFO - 'sessionrestore', 16:49:40 INFO - 'sessionrestore_no_auto_restore', 16:49:40 INFO - 'tabpaint']}, 16:49:40 INFO - 'other_nol64': {'tests': ['a11yr', 16:49:40 INFO - 'ts_paint', 16:49:40 INFO - 'tpaint', 16:49:40 INFO - 'sessionrestore', 16:49:40 INFO - 'sessionrestore_no_auto_restore', 16:49:40 INFO - 'tabpaint']}, 16:49:40 INFO - 'svgr': {'tests': ['tsvgx', 16:49:40 INFO - 'tsvgr_opacity', 16:49:40 INFO - 'tart', 16:49:40 INFO - 'tscrollx', 16:49:40 INFO - 'cart']}, 16:49:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:49:40 INFO - 'tests': ['tsvgx', 16:49:40 INFO - 'tsvgr_opacity', 16:49:40 INFO - 'tart', 16:49:40 INFO - 'tscrollx', 16:49:40 INFO - 'cart']}, 16:49:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:40 INFO - 'tests': ['tp5o']}, 16:49:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:40 INFO - 'talos_options': ['--e10s'], 16:49:40 INFO - 'tests': ['tp5o']}, 16:49:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:40 INFO - 'talos_options': ['--xperf_path', 16:49:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:40 INFO - 'tests': ['tp5n']}, 16:49:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:40 INFO - 'talos_options': ['--e10s', 16:49:40 INFO - '--xperf_path', 16:49:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:40 INFO - 'tests': ['tp5n']}}, 16:49:40 INFO - 'talos.zip': {'path': '', 16:49:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:49:40 INFO - Running post-action listener: _resource_record_post_action 16:49:40 INFO - ##### 16:49:40 INFO - ##### Running create-virtualenv step. 16:49:40 INFO - ##### 16:49:40 INFO - Running pre-action listener: _resource_record_pre_action 16:49:40 INFO - Running main action method: create_virtualenv 16:49:40 INFO - Creating virtualenv /builds/slave/test/build/venv 16:49:40 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 16:49:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:49:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:49:40 INFO - Using real prefix '/usr' 16:49:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:49:41 INFO - Installing distribute.............................................................................................................................................................................................done. 16:49:43 INFO - Installing pip.................done. 16:49:43 INFO - Return code: 0 16:49:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:49: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')]} 16:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:43 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 0x7f7d39c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1777410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1806160>, '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 0x1807060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18074f0>, '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': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', '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 16:49:43 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 16:49:43 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 16:49:43 INFO - Using env: {'DISPLAY': ':0', 16:49:43 INFO - 'HOME': '/home/cltbld', 16:49:43 INFO - 'LANG': 'en_US.UTF-8', 16:49:43 INFO - 'LANGUAGE': 'en_US:en', 16:49:43 INFO - 'LOGNAME': 'cltbld', 16:49:43 INFO - 'MAIL': '/var/mail/cltbld', 16:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:43 INFO - 'MOZ_NO_REMOTE': '1', 16:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:43 INFO - 'NO_EM_RESTART': '1', 16:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:43 INFO - 'PWD': '/builds/slave/test', 16:49:43 INFO - 'SHELL': '/bin/bash', 16:49:43 INFO - 'SHLVL': '1', 16:49:43 INFO - 'TERM': 'linux', 16:49:43 INFO - 'TMOUT': '86400', 16:49:43 INFO - 'USER': 'cltbld', 16:49:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', 16:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:43 INFO - '_': '/tools/buildbot/bin/python'} 16:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:43 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 16:49:43 INFO - Cleaning up... 16:49:43 INFO - Return code: 0 16:49:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:49: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')]} 16:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:43 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 0x7f7d39c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1777410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1806160>, '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 0x1807060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18074f0>, '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': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', '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 16:49:43 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 16:49:43 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 16:49:43 INFO - Using env: {'DISPLAY': ':0', 16:49:43 INFO - 'HOME': '/home/cltbld', 16:49:43 INFO - 'LANG': 'en_US.UTF-8', 16:49:43 INFO - 'LANGUAGE': 'en_US:en', 16:49:43 INFO - 'LOGNAME': 'cltbld', 16:49:43 INFO - 'MAIL': '/var/mail/cltbld', 16:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:43 INFO - 'MOZ_NO_REMOTE': '1', 16:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:43 INFO - 'NO_EM_RESTART': '1', 16:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:43 INFO - 'PWD': '/builds/slave/test', 16:49:43 INFO - 'SHELL': '/bin/bash', 16:49:43 INFO - 'SHLVL': '1', 16:49:43 INFO - 'TERM': 'linux', 16:49:43 INFO - 'TMOUT': '86400', 16:49:43 INFO - 'USER': 'cltbld', 16:49:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', 16:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:43 INFO - '_': '/tools/buildbot/bin/python'} 16:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:43 INFO - Downloading/unpacking psutil>=0.7.1 16:49:43 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 16:49:43 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 16:49:43 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 16:49:43 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 16:49:43 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 16:49:43 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 16:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:49:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:45 INFO - Installing collected packages: psutil 16:49:45 INFO - Running setup.py install for psutil 16:49:45 INFO - building 'psutil._psutil_linux' extension 16:49:45 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 16:49:45 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 16:49:45 INFO - building 'psutil._psutil_posix' extension 16:49:45 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 16:49:45 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 16:49:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:46 INFO - Successfully installed psutil 16:49:46 INFO - Cleaning up... 16:49:46 INFO - Return code: 0 16:49:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d39c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1777410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1806160>, '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 0x1807060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18074f0>, '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': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', '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 16:49:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:49:46 INFO - Using env: {'DISPLAY': ':0', 16:49:46 INFO - 'HOME': '/home/cltbld', 16:49:46 INFO - 'LANG': 'en_US.UTF-8', 16:49:46 INFO - 'LANGUAGE': 'en_US:en', 16:49:46 INFO - 'LOGNAME': 'cltbld', 16:49:46 INFO - 'MAIL': '/var/mail/cltbld', 16:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:46 INFO - 'MOZ_NO_REMOTE': '1', 16:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:46 INFO - 'NO_EM_RESTART': '1', 16:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:46 INFO - 'PWD': '/builds/slave/test', 16:49:46 INFO - 'SHELL': '/bin/bash', 16:49:46 INFO - 'SHLVL': '1', 16:49:46 INFO - 'TERM': 'linux', 16:49:46 INFO - 'TMOUT': '86400', 16:49:46 INFO - 'USER': 'cltbld', 16:49:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', 16:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:46 INFO - '_': '/tools/buildbot/bin/python'} 16:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:49:48 INFO - Installing collected packages: mozsystemmonitor 16:49:48 INFO - Running setup.py install for mozsystemmonitor 16:49:48 INFO - Successfully installed mozsystemmonitor 16:49:48 INFO - Cleaning up... 16:49:48 INFO - Return code: 0 16:49:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d39c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1777410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1806160>, '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 0x1807060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18074f0>, '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': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', '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 16:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:49:48 INFO - Using env: {'DISPLAY': ':0', 16:49:48 INFO - 'HOME': '/home/cltbld', 16:49:48 INFO - 'LANG': 'en_US.UTF-8', 16:49:48 INFO - 'LANGUAGE': 'en_US:en', 16:49:48 INFO - 'LOGNAME': 'cltbld', 16:49:48 INFO - 'MAIL': '/var/mail/cltbld', 16:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:48 INFO - 'MOZ_NO_REMOTE': '1', 16:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:48 INFO - 'NO_EM_RESTART': '1', 16:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:48 INFO - 'PWD': '/builds/slave/test', 16:49:48 INFO - 'SHELL': '/bin/bash', 16:49:48 INFO - 'SHLVL': '1', 16:49:48 INFO - 'TERM': 'linux', 16:49:48 INFO - 'TMOUT': '86400', 16:49:48 INFO - 'USER': 'cltbld', 16:49:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', 16:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:48 INFO - '_': '/tools/buildbot/bin/python'} 16:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:48 INFO - Downloading/unpacking blobuploader==1.2.4 16:49:48 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 16:49:48 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 16:49:48 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 16:49:48 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 16:49:48 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 16:49:48 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 16:49:50 INFO - Downloading blobuploader-1.2.4.tar.gz 16:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:49:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:49:50 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 16:49:50 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 16:49:50 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 16:49:50 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 16:49:50 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 16:49:50 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 16:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:49:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:49:50 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 16:49:50 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 16:49:50 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 16:49:50 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 16:49:50 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 16:49:50 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 16:49:51 INFO - Downloading docopt-0.6.1.tar.gz 16:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:49:51 INFO - Installing collected packages: blobuploader, requests, docopt 16:49:51 INFO - Running setup.py install for blobuploader 16:49:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:49:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:49:51 INFO - Running setup.py install for requests 16:49:51 INFO - Running setup.py install for docopt 16:49:51 INFO - Successfully installed blobuploader requests docopt 16:49:51 INFO - Cleaning up... 16:49:51 INFO - Return code: 0 16:49:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:51 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 0x7f7d39c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1777410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1806160>, '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 0x1807060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18074f0>, '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': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', '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 16:49:51 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 16:49:51 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 16:49:51 INFO - Using env: {'DISPLAY': ':0', 16:49:51 INFO - 'HOME': '/home/cltbld', 16:49:51 INFO - 'LANG': 'en_US.UTF-8', 16:49:51 INFO - 'LANGUAGE': 'en_US:en', 16:49:51 INFO - 'LOGNAME': 'cltbld', 16:49:51 INFO - 'MAIL': '/var/mail/cltbld', 16:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:51 INFO - 'MOZ_NO_REMOTE': '1', 16:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:51 INFO - 'NO_EM_RESTART': '1', 16:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:51 INFO - 'PWD': '/builds/slave/test', 16:49:51 INFO - 'SHELL': '/bin/bash', 16:49:51 INFO - 'SHLVL': '1', 16:49:51 INFO - 'TERM': 'linux', 16:49:51 INFO - 'TMOUT': '86400', 16:49:51 INFO - 'USER': 'cltbld', 16:49:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', 16:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:51 INFO - '_': '/tools/buildbot/bin/python'} 16:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:51 INFO - Running setup.py (path:/tmp/pip-EnnQ_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:52 INFO - Running setup.py (path:/tmp/pip-WV5dpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:52 INFO - Running setup.py (path:/tmp/pip-rMkpzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:52 INFO - Running setup.py (path:/tmp/pip-difUUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:52 INFO - Running setup.py (path:/tmp/pip-8HSoTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:52 INFO - Running setup.py (path:/tmp/pip-DSgz_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:52 INFO - Running setup.py (path:/tmp/pip-XGikAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:52 INFO - Running setup.py (path:/tmp/pip-9PzF17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:52 INFO - Running setup.py (path:/tmp/pip-swaoPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:52 INFO - Running setup.py (path:/tmp/pip-1u9GOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:52 INFO - Running setup.py (path:/tmp/pip-xDsUBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:52 INFO - Running setup.py (path:/tmp/pip-RImvmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:52 INFO - Running setup.py (path:/tmp/pip-ssbhUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:52 INFO - Running setup.py (path:/tmp/pip-UnH1Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:52 INFO - Running setup.py (path:/tmp/pip-CefArM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:53 INFO - Running setup.py (path:/tmp/pip-JbfKge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:53 INFO - Running setup.py (path:/tmp/pip-2Xyith-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:49:53 INFO - Running setup.py install for manifestparser 16:49:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:49:53 INFO - Running setup.py install for mozcrash 16:49:53 INFO - Running setup.py install for mozdebug 16:49:53 INFO - Running setup.py install for mozdevice 16:49:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:49:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:49:53 INFO - Running setup.py install for mozfile 16:49:53 INFO - Running setup.py install for mozhttpd 16:49:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:49:53 INFO - Running setup.py install for mozinfo 16:49:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:49:53 INFO - Running setup.py install for mozInstall 16:49:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:49:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:49:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:49:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:49:54 INFO - Running setup.py install for mozleak 16:49:54 INFO - Running setup.py install for mozlog 16:49:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:49:54 INFO - Running setup.py install for moznetwork 16:49:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:49:54 INFO - Running setup.py install for mozprocess 16:49:54 INFO - Running setup.py install for mozprofile 16:49:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:49:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:49:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:49:54 INFO - Running setup.py install for mozrunner 16:49:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:49:54 INFO - Running setup.py install for mozscreenshot 16:49:54 INFO - Running setup.py install for moztest 16:49:54 INFO - Running setup.py install for mozversion 16:49:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:49:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:49:54 INFO - Cleaning up... 16:49:54 INFO - Return code: 0 16:49:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:55 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 0x7f7d39c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1777410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1806160>, '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 0x1807060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18074f0>, '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': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', '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 16:49:55 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 16:49:55 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 16:49:55 INFO - Using env: {'DISPLAY': ':0', 16:49:55 INFO - 'HOME': '/home/cltbld', 16:49:55 INFO - 'LANG': 'en_US.UTF-8', 16:49:55 INFO - 'LANGUAGE': 'en_US:en', 16:49:55 INFO - 'LOGNAME': 'cltbld', 16:49:55 INFO - 'MAIL': '/var/mail/cltbld', 16:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:55 INFO - 'MOZ_NO_REMOTE': '1', 16:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:55 INFO - 'NO_EM_RESTART': '1', 16:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:55 INFO - 'PWD': '/builds/slave/test', 16:49:55 INFO - 'SHELL': '/bin/bash', 16:49:55 INFO - 'SHLVL': '1', 16:49:55 INFO - 'TERM': 'linux', 16:49:55 INFO - 'TMOUT': '86400', 16:49:55 INFO - 'USER': 'cltbld', 16:49:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', 16:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:55 INFO - '_': '/tools/buildbot/bin/python'} 16:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:55 INFO - Running setup.py (path:/tmp/pip-h8Pu0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:55 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)) 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:55 INFO - Running setup.py (path:/tmp/pip-H0sbl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:55 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)) 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:55 INFO - Running setup.py (path:/tmp/pip-hss19t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:55 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)) 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:55 INFO - Running setup.py (path:/tmp/pip-Wjyn6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:55 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)) 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:55 INFO - Running setup.py (path:/tmp/pip-yNXgmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:55 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)) 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:55 INFO - Running setup.py (path:/tmp/pip-sZ76ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:55 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)) 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:55 INFO - Running setup.py (path:/tmp/pip-0dCsfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:55 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)) 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:55 INFO - Running setup.py (path:/tmp/pip-RqR51M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:55 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)) 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:55 INFO - Running setup.py (path:/tmp/pip-8HYriF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:55 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)) 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:55 INFO - Running setup.py (path:/tmp/pip-8nBbcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:55 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)) 16:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:55 INFO - Running setup.py (path:/tmp/pip-84w3M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:55 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)) 16:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:56 INFO - Running setup.py (path:/tmp/pip-ETQmPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:56 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)) 16:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:56 INFO - Running setup.py (path:/tmp/pip-9XlJy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:56 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)) 16:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:56 INFO - Running setup.py (path:/tmp/pip-sB0iSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:56 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)) 16:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:56 INFO - Running setup.py (path:/tmp/pip-UjJ5Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:56 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)) 16:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:56 INFO - Running setup.py (path:/tmp/pip-emvOXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:56 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)) 16:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:56 INFO - Running setup.py (path:/tmp/pip-VkSbnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:56 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)) 16:49:56 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)) 16:49:56 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)) 16:49:56 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)) 16:49:56 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)) 16:49:56 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)) 16:49:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:49:56 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 16:49:56 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 16:49:56 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 16:49:56 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 16:49:56 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 16:49:56 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 16:49:58 INFO - Downloading blessings-1.6.tar.gz 16:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:49:58 INFO - Installing collected packages: blessings 16:49:58 INFO - Running setup.py install for blessings 16:49:58 INFO - Successfully installed blessings 16:49:58 INFO - Cleaning up... 16:49:58 INFO - Return code: 0 16:49:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:49:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:58 INFO - Reading from file tmpfile_stdout 16:49:58 INFO - Current package versions: 16:49:58 INFO - argparse == 1.2.1 16:49:58 INFO - blessings == 1.6 16:49:58 INFO - blobuploader == 1.2.4 16:49:58 INFO - docopt == 0.6.1 16:49:58 INFO - manifestparser == 1.1 16:49:58 INFO - mozInstall == 1.12 16:49:58 INFO - mozcrash == 0.17 16:49:58 INFO - mozdebug == 0.1 16:49:58 INFO - mozdevice == 0.48 16:49:58 INFO - mozfile == 1.2 16:49:58 INFO - mozhttpd == 0.7 16:49:58 INFO - mozinfo == 0.9 16:49:58 INFO - mozleak == 0.1 16:49:58 INFO - mozlog == 3.1 16:49:58 INFO - moznetwork == 0.27 16:49:58 INFO - mozprocess == 0.22 16:49:58 INFO - mozprofile == 0.28 16:49:58 INFO - mozrunner == 6.11 16:49:58 INFO - mozscreenshot == 0.1 16:49:58 INFO - mozsystemmonitor == 0.0 16:49:58 INFO - moztest == 0.7 16:49:58 INFO - mozversion == 1.4 16:49:58 INFO - psutil == 3.1.1 16:49:58 INFO - requests == 1.2.3 16:49:58 INFO - wsgiref == 0.1.2 16:49:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:58 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')]} 16:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:58 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')]} 16:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:58 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 0x7f7d39c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1777410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1806160>, '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 0x1807060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18074f0>, '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': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', '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 16:49:58 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 16:49:58 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 16:49:58 INFO - Using env: {'DISPLAY': ':0', 16:49:58 INFO - 'HOME': '/home/cltbld', 16:49:58 INFO - 'LANG': 'en_US.UTF-8', 16:49:58 INFO - 'LANGUAGE': 'en_US:en', 16:49:58 INFO - 'LOGNAME': 'cltbld', 16:49:58 INFO - 'MAIL': '/var/mail/cltbld', 16:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:58 INFO - 'MOZ_NO_REMOTE': '1', 16:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:58 INFO - 'NO_EM_RESTART': '1', 16:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:58 INFO - 'PWD': '/builds/slave/test', 16:49:58 INFO - 'SHELL': '/bin/bash', 16:49:58 INFO - 'SHLVL': '1', 16:49:58 INFO - 'TERM': 'linux', 16:49:58 INFO - 'TMOUT': '86400', 16:49:58 INFO - 'USER': 'cltbld', 16:49:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', 16:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:58 INFO - '_': '/tools/buildbot/bin/python'} 16:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:58 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)) 16:49:58 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)) 16:49:58 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)) 16:49:58 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)) 16:49:58 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)) 16:49:58 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)) 16:49:58 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)) 16:49:58 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)) 16:49:58 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)) 16:49:58 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)) 16:49:58 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)) 16:49:58 INFO - Cleaning up... 16:49:58 INFO - Return code: 0 16:49:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:49:58 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')]} 16:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:59 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 0x7f7d39c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1777410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1806160>, '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 0x1807060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18074f0>, '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': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', '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 16:49:59 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 16:49:59 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 16:49:59 INFO - Using env: {'DISPLAY': ':0', 16:49:59 INFO - 'HOME': '/home/cltbld', 16:49:59 INFO - 'LANG': 'en_US.UTF-8', 16:49:59 INFO - 'LANGUAGE': 'en_US:en', 16:49:59 INFO - 'LOGNAME': 'cltbld', 16:49:59 INFO - 'MAIL': '/var/mail/cltbld', 16:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:59 INFO - 'MOZ_NO_REMOTE': '1', 16:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:59 INFO - 'NO_EM_RESTART': '1', 16:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:59 INFO - 'PWD': '/builds/slave/test', 16:49:59 INFO - 'SHELL': '/bin/bash', 16:49:59 INFO - 'SHLVL': '1', 16:49:59 INFO - 'TERM': 'linux', 16:49:59 INFO - 'TMOUT': '86400', 16:49:59 INFO - 'USER': 'cltbld', 16:49:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', 16:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:59 INFO - '_': '/tools/buildbot/bin/python'} 16:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:59 INFO - Downloading/unpacking jsonschema 16:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:50:01 INFO - Downloading/unpacking functools32 (from jsonschema) 16:50:01 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 16:50:01 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 16:50:01 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 16:50:01 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 16:50:01 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 16:50:01 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 16:50:01 INFO - Downloading functools32-3.2.3-2.tar.gz 16:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:50:01 INFO - warning: no files found matching '*.txt' 16:50:01 INFO - no previously-included directories found matching 'build' 16:50:01 INFO - no previously-included directories found matching 'dist' 16:50:01 INFO - no previously-included directories found matching '.git*' 16:50:01 INFO - Installing collected packages: jsonschema, functools32 16:50:01 INFO - Running setup.py install for functools32 16:50:01 INFO - warning: no files found matching '*.txt' 16:50:01 INFO - no previously-included directories found matching 'build' 16:50:01 INFO - no previously-included directories found matching 'dist' 16:50:01 INFO - no previously-included directories found matching '.git*' 16:50:01 INFO - Successfully installed jsonschema functools32 16:50:01 INFO - Cleaning up... 16:50:01 INFO - Return code: 0 16:50:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d39c41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1777410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1806160>, '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 0x1807060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18074f0>, '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': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', '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 16:50:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:50:01 INFO - Using env: {'DISPLAY': ':0', 16:50:01 INFO - 'HOME': '/home/cltbld', 16:50:01 INFO - 'LANG': 'en_US.UTF-8', 16:50:01 INFO - 'LANGUAGE': 'en_US:en', 16:50:01 INFO - 'LOGNAME': 'cltbld', 16:50:01 INFO - 'MAIL': '/var/mail/cltbld', 16:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:01 INFO - 'MOZ_NO_REMOTE': '1', 16:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:01 INFO - 'NO_EM_RESTART': '1', 16:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:01 INFO - 'PWD': '/builds/slave/test', 16:50:01 INFO - 'SHELL': '/bin/bash', 16:50:01 INFO - 'SHLVL': '1', 16:50:01 INFO - 'TERM': 'linux', 16:50:01 INFO - 'TMOUT': '86400', 16:50:01 INFO - 'USER': 'cltbld', 16:50:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', 16:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:01 INFO - '_': '/tools/buildbot/bin/python'} 16:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:01 INFO - Downloading/unpacking flake8 16:50:01 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 16:50:01 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 16:50:01 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 16:50:01 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 16:50:01 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 16:50:01 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 16:50:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:50:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:50:03 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 16:50:03 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 16:50:03 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 16:50:03 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 16:50:03 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 16:50:03 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 16:50:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:50:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:04 INFO - no previously-included directories found matching 'docs/_build' 16:50:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:50:04 INFO - Running setup.py install for pep8 16:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:04 INFO - no previously-included directories found matching 'docs/_build' 16:50:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:50:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:50:04 INFO - Cleaning up... 16:50:04 INFO - Return code: 0 16:50:04 INFO - Running post-action listener: _resource_record_post_action 16:50:04 INFO - Running post-action listener: _start_resource_monitoring 16:50:04 INFO - Starting resource monitoring. 16:50:04 INFO - ##### 16:50:04 INFO - ##### Running install step. 16:50:04 INFO - ##### 16:50:04 INFO - Running pre-action listener: _resource_record_pre_action 16:50:04 INFO - Running main action method: install 16:50:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:50:05 INFO - Reading from file tmpfile_stdout 16:50:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:50:05 INFO - Reading from file tmpfile_stdout 16:50:05 INFO - Output received: 16:50:05 INFO - Usage: mozinstall [options] installer 16:50:05 INFO - Options: 16:50:05 INFO - -h, --help show this help message and exit 16:50:05 INFO - -d DEST, --destination=DEST 16:50:05 INFO - Directory to install application into. [default: 16:50:05 INFO - "/builds/slave/test"] 16:50:05 INFO - --app=APP Application being installed. [default: firefox] 16:50:05 INFO - mkdir: /builds/slave/test/build/application 16:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:50:20 INFO - Reading from file tmpfile_stdout 16:50:20 INFO - Output received: 16:50:20 INFO - /builds/slave/test/build/application/firefox/firefox 16:50:20 INFO - Running post-action listener: _resource_record_post_action 16:50:20 INFO - ##### 16:50:20 INFO - ##### Running run-tests step. 16:50:20 INFO - ##### 16:50:20 INFO - Running pre-action listener: _resource_record_pre_action 16:50:20 INFO - Running main action method: run_tests 16:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:50:20 INFO - Python 2.7.3 16:50:20 INFO - Return code: 0 16:50:20 INFO - grabbing minidump binary from tooltool 16:50: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')]} 16:50:20 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 0x1806160>, '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 0x1807060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18074f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:50:20 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 16:50:20 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 16:50:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:50:20 INFO - Return code: 0 16:50:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:50:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:50:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:50:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:50:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:50:21 INFO - Return code: 0 16:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 16:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 16:50:21 INFO - Using env: {'DISPLAY': ':0', 16:50:21 INFO - 'HOME': '/home/cltbld', 16:50:21 INFO - 'LANG': 'en_US.UTF-8', 16:50:21 INFO - 'LANGUAGE': 'en_US:en', 16:50:21 INFO - 'LOGNAME': 'cltbld', 16:50:21 INFO - 'MAIL': '/var/mail/cltbld', 16:50:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:50:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:21 INFO - 'MOZ_NO_REMOTE': '1', 16:50:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:21 INFO - 'NO_EM_RESTART': '1', 16:50:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:21 INFO - 'PWD': '/builds/slave/test', 16:50:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:50:21 INFO - 'SHELL': '/bin/bash', 16:50:21 INFO - 'SHLVL': '1', 16:50:21 INFO - 'TERM': 'linux', 16:50:21 INFO - 'TMOUT': '86400', 16:50:21 INFO - 'USER': 'cltbld', 16:50:21 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943', 16:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:21 INFO - '_': '/tools/buildbot/bin/python'} 16:50:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 16:50:21 INFO - mozversion application_buildid: 20160422141954 16:50:21 INFO - mozversion application_changeset: c0be14550a2b77f8f8b4aab158fc3525ffc82828 16:50:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:50:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:50:21 INFO - mozversion application_name: Firefox 16:50:21 INFO - mozversion application_remotingname: firefox-dev 16:50:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:50:21 INFO - mozversion application_vendor: Mozilla 16:50:21 INFO - mozversion application_version: 47.0a2 16:50:21 INFO - mozversion platform_buildid: 20160422141954 16:50:21 INFO - mozversion platform_changeset: c0be14550a2b77f8f8b4aab158fc3525ffc82828 16:50:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:50:21 INFO - mozversion platform_version: 47.0a2 16:50:21 INFO - using testdate: 1461369021 16:50:21 INFO - actual date: 1461369021 16:50:21 INFO - starting webserver on 'localhost:60150' 16:50:21 INFO - SUITE-START | Running 2 tests 16:50:21 INFO - TEST-START | dromaeo_css 16:50:21 INFO - operating with platform_type : linux_ 16:50:21 INFO - Initialising browser for dromaeo_css test... 16:50:21 INFO - TEST-INFO | started process 19205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnGL1i0/profile http://localhost:60150/getInfo.html) 16:50:25 INFO - PROCESS | 19205 | 16:50:25 INFO - PROCESS | 19205 | (process:19281): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:50:26 INFO - PROCESS | 19205 | __metrics Screen width/height:1600/1200 16:50:26 INFO - PROCESS | 19205 | colorDepth:24 16:50:26 INFO - PROCESS | 19205 | Browser inner width/height: 1024/697 16:50:26 INFO - PROCESS | 19205 | __metrics 16:50:26 ERROR - PROCESS | 19205 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:50:27 INFO - TEST-INFO | 19205: exit 0 16:50:27 INFO - Browser initialized. 16:50:27 INFO - Running cycle 1/1 for dromaeo_css test... 16:50:27 INFO - TEST-INFO | started process 19332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnGL1i0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:29 INFO - PROCESS | 19332 | 16:50:29 INFO - PROCESS | 19332 | (process:19398): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:50:39 INFO - PROCESS | 19332 | RSS: Main: 151236608 16:50:39 INFO - PROCESS | 19332 | 16:51:29 INFO - PROCESS | 19332 | 1461369089110 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] 16:53:37 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:60150/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60150/tests/dromaeo/cssquery-ext.html) 16:53:38 INFO - PROCESS | 19332 | RSS: Main: 155516928 16:53:38 INFO - PROCESS | 19332 | 16:56:40 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:60150/tests/dromaeo/cssquery-ext.html (next: http://localhost:60150/tests/dromaeo/cssquery-jquery.html) 16:56:41 INFO - PROCESS | 19332 | RSS: Main: 153169920 16:56:41 INFO - PROCESS | 19332 | 16:59:42 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:60150/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60150/tests/dromaeo/cssquery-mootools.html) 16:59:43 INFO - PROCESS | 19332 | RSS: Main: 153292800 16:59:43 INFO - PROCESS | 19332 | 17:02:45 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:60150/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60150/tests/dromaeo/cssquery-prototype.html) 17:02:45 INFO - PROCESS | 19332 | RSS: Main: 152600576 17:02:45 INFO - PROCESS | 19332 | 17:05:47 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:60150/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60150/tests/dromaeo/cssquery-yui.html) 17:05:48 INFO - PROCESS | 19332 | RSS: Main: 153767936 17:05:48 INFO - PROCESS | 19332 | 17:08:50 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:60150/tests/dromaeo/cssquery-yui.html (next: http://localhost:60150/tests/dromaeo/cssquery-dojo.html) 17:08:51 INFO - PROCESS | 19332 | RSS: Main: 155070464 17:08:51 INFO - PROCESS | 19332 | 17:08:51 INFO - PROCESS | 19332 | __start_tp_report 17:08:51 INFO - PROCESS | 19332 | _x_x_mozilla_page_load 17:08:51 INFO - PROCESS | 19332 | _x_x_mozilla_page_load_details 17:08:51 INFO - PROCESS | 19332 | |i|pagename|runs| 17:08:51 INFO - PROCESS | 19332 | |0;dojo.html;3393.830308484576;3422.657734226577;3483.8432270547823;3516.8769093081746;3517.4547945068507;5652.745626446809;5677.8580535486635;5696.629719068263;5711.485966263035;5721.6853073080965;5661.122526008476;5672.347680016789;5674.546036317095;5715;5724.198612194296;5170.353705786767;5208.843734687946;5259.368875734917;5268.973655131738;5274.05067087924;5117.1556693145585;5238.60710446718;5288.709120998363;5347.41178470368;5364.463553644624;5113;5173.405058418273;5274.789008439658;5368.731563421833;5385.380681221651;5278.2346559749;5299.231611416361;5299.364076310829;5301.522862942315;5306.787728490855;4971.45314015458;5079.466656001104;5245.449227831099;5273.578113750891;5283.894322113575;5442.102053161224;5487.478689524489;5493.340799104093;5495.422980587061;5502.669839809624;6011;6028.909566356509;6048.274207095133;6067.939320606782;6109.175261339707;5979.521638268928;6037.909431358533;6092.268927728656;6243.250809902841;6263.123162757218;5823.592348535604;5835.4748072673665;5841.299044114691;5845.473907348317;5848.795292164797;6311.27420346666;6315.96842015787;6322.241331040304;6323.08315294289;6324.430801227912;5983.970080149571;6097.3292937776805;6154.1999540059505;6179.227596550431;6193.256809182927;6159.3224745277985;6159.84600384994;6161.969190154021;6175.536834737323;6205.782797602063;5883.61756485827;6154.1999540059505;6166.876662466726;6174.320824709278;6196.039613859859;6018.127371531104;6075.75696972125;6109.313572000199;6123.243761421121;6152.938470615326;4505.752183629932;4568.565986231302;4591.288350305641;4608.838690645878;4650.651201159926;4073.572274911151;4129.566395528486;4133.42132101506;4158.500979882433;4162.604552567501;5690.9146362804595;5852;5852.882942341214;5927.911081333784;5973.04431291;6096.359882212392;6099.84750381244;6110.26676798787;6124;6129.325774164839;5698.059820129715;5759.654420734685;5815.41845815415;5834.474897259267;5848.210491583667;5250.238715386247;5274.947250527523;5280.445553216857;5298.072837253465;5342.931413717272;6375.075614035939;6383.010633351838;6390;6399.840003999937;6405.743770249231;6004;6115.301188036123;6217.378262173746;6222.346653601307;6224.284207316216;6265.624062556261;6266.122742816101;6282.246130464374;6288.5598008138995;6294.307626161027;5985.970070149796;6023.608465449732;6031.487323577545;6041.848953776191;6056.515478761777;6027.035674292092;6120.17377654011;6126.029144987285;6142;6147.293061298008;5829.300483941955;5944.375840536854;5963.701814909324;5966.582339236212;5976.940230597638;6009.819705408845;6012.068129439944;6021.397860213943;6022.247219097613;6029.75880964774;5780.537556995514;5914.319853216935;5964.075568286922;5989.071693887455;5996.190514280516;5945.91081133792;5948.762049517971;5967.37342579023;5978.461938425563;6010.338862725184;5790.681512516683;5860.472557469848;5864.384239654945;5875.383084776037;5889.263842019747 17:08:51 INFO - PROCESS | 19332 | |1;ext.html;540.1453182835993;559.2115117684064;572.4161355417474;587.4654064801031;707.193799069061;39431.40852887209;40365.394519082234;40544.39183412248;40566.79716601416;40847.795761021225;40980.59019409805;41532.16935661285;41692.58307416925;41698.37452438216;41834.37248441276;8491.405601607905;8729.956350218241;8737.606807693637;8768.649254029831;8781.42920710155;8775.341849361292;8880.555972201364;8942.329325300596;8958.731238062835;8994.415363001384;8916.331275154356;8951.910480895205;9014.774630634221;9024.052474490183;9050.547472626375;8858.15847494487;8864.8670269946;8969.506677132755;8987.325950553703;9001.414908031022;8779.64881404743;8900.332475064397;8913.28693704502;8924.241439477652;8926.330525210635;35386;41327.793361033;41567;41631.375529367084;41795.791021045006;3412.368711788327;3461.7922924624604;3548.3258180945536;3911.7261791674596;4003.7597744135446;30258.394832103233;30461.23846903823;30507.389852202832;30512.237194070105;30537;3830.444585535082;3879.35990561557;3926.725129240954;3933.3706606943038;4008.3586626139677;198944;199383;200756;201310;249550;60276.39723602796;62983;68876.65561672159;70153.64923175453;70613.2938670617;64373.67813160904;64485.35514644793;64807;64940.675296623216;65042;15941.202939852961;16128.193590320438;16139.919300403422;16213.2704028319;16230.594235144215;11553.537858485735;11605.6518304451;11633.825492617618;11692.123090768226;11713.062954963752;22170.667439988414;23010;23094.53810923772;23122.537549248922;23134.884325578263;7847.607619618996;7918.366530677532;7993.560354180576;8080.27277545012;8153.592320384076;1054.5728979763055;1055.8680164979378;1131.4625552862324;1147.4778975566098;1169.2984209474248;31100.68899311023;31300.53049204264;31489.685103149135;31899;32293.677063229537;1139.9943000284945;1164.1582776836406;1213.1827885290056;1232.975340493185;1255.8555766086834;16171.838281617032;16249.593760155854;16490.670186596442;16679.583010424594;16842.07368594739;183686;184267;184959;185271;185574;63635;63725.681371592844;63786;64235.678821605594;64385.35614643887;1458.3510337899745;1471.8601732835364;1488.642725745813;1505.7139143562688;1509.1322489568543;30457.695423045487;30746.385072298875;30760.846195769773;31477.213069673442;31687.52468713017;54875.17687234774;55093;55329.723351382985;55533.167002494185;55546.16680749711;380456;384272;385241;387662;389260;46235;47103;47930;49108.26337604867;49298.753506233676;51810.481895180565;52029.47970520398;52604.47395525996;52909.7354513225;52992.735036326114;43018.35472467853;43214;44302;44410.79308914371;44721.32918006167;42349;43371;43562;43595;44339;42606.786966064974;42884.1423171541;43020;43246;43417.56582434135;36346.636533635385;37592;37599.248015040095;37643.62356376401;38561.80719096387;25995.220143395727;26869.193924182306;26887;26981.0556630517;27007.45985080248 17:08:51 INFO - PROCESS | 19332 | |2;jquery.html;374.19361276449246;390.63082405212367;391.8021399193407;394.01142335386106;410.7330235347024;14552.854471455283;17675.734863977017;18693;19289.517762055937;19332.51668708281;16550.503484895442;16574.917125414388;16785.748213776802;16794.244259008345;16863.747043794323;5390.1914712793105;5804.216430781854;5833.7374818133285;5843.766249350021;5846.2107615472005;5313.840584782462;5460.126379779236;5506.91739623906;5516.3380394352735;5516.531094856942;5408.161734931092;5412.756425960842;5500.917486237709;5868.09044598088;5878.559108066891;5826.592138550303;5834.183214349994;5840.707964601753;5845.970770146143;5873.148393482942;5143.3570803649545;5331.706756128411;5361.758720857531;5579.8884022319735;5591.580631452657;13468.5286014989;13514.662133446644;13528.729425411535;13756.380962856696;13956.2324072176;2197.4726065744107;2215.700880381144;2449.5713250181325;2674.665666791651;2767.6125342452074;9676.56455459499;9711.90288097117;9731.172850307732;9911.950440247825;10054.24593155509;1779.6974514332464;1866.0762922353385;1910.7993660665568;1917.8753381030328;2006.3278801601334;63790.68104659493;63994.3600563993;64283.357166428206;64780.70438591249;64967.675161624364;9229.307801914883;9290.210332121846;9544.379615324982;9582.233421326277;10185.287029907835;12787.552435664707;13011.544595939286;13082.542111026069;13114.754098360641;13413;6389.584676995981;6439.227292724903;6457.160569125984;6538.215414150332;6574.638394888231;5910.468057874812;5950.613210141327;5987.700614969234;6051.183090282755;6063.575549711478;4204.3693445983345;4218.767967761742;4305;4316.482022157361;4326.891827704332;1806.7018941874705;1820.5903671673768;1840.033982159377;1856.6235218919803;1857.247814635075;454.266359828874;468.0802223630582;472.75416783272505;474.70568247686657;1040.287403128859;11125.72185695348;11219.887801121884;11342.262752921033;11383.317000979967;11389.487473063731;497.7486369383438;500.9073321435546;502.0260694253137;513.6147889083188;514.9356330458693;6100.572959892765;6225.439710426083;6257.155284036597;6292.4966002720585;6359;462829;466372;468453;475602;478317;81073;83277;83279.5836020816;83457.58271208605;83786.58106709427;1087.8041952448634;1091.6615849086809;1104.7348636327383;1112.204773586873;1140.1562843495753;14955.626109347353;15028.774568381701;15072.924635377192;15169.269531484439;15276.847231527987;36207.818960905024;36275.27449450943;36514.634853652184;36808.63191368052;37092;50823.491765081875;52665.7366713164;52776.47223527869;53142;53514;7660.693572257047;8083.393745468996;8253;8403.537805420761;8626.956865215885;9966.60133594677;12938.935305323414;12990.285534295705;13071.542496012595;13566.86433135656;10309.74225644335;10530.36817790935;10824.242303039027;10826.188035897496;10913.618023369145;10332.276740628384;10420.164707763677;10485.790284194425;10511.789764204826;10649.201309901633;10967.725806854893;11031.22781405294;11247.100231981258;11279.887201128213;11309.491072901903;7843.921560784547;8294.543800091053;8373.539455330016;8393.95803020981;8809.647614095364;8671.913280867111;10418.982023692499;10906.34561926287;10915.181361398085;11191.44042797873 17:08:51 INFO - PROCESS | 19332 | |3;mootools.html;1518.8025556677626;1523.7181121492522;1754.5701303180722;1870.5136664467234;1917.3097684833467;7677.65450554725;8311.085780564134;8477.067522572519;8736.995245546756;8778.385513014084;8434.156584341577;8442.535660538668;8550.786230344229;8661.263792577638;8678.349123815724;2481.4168670362496;2512.246326102162;2517.7230504644476;2518.609615509599;2528.4943011397704;2467.580511313081;2518.0934863449143;2533.07542746897;2538.809589280802;2541.758532939368;2478.1450399612104;2487.4900645367657;2500.112460076674;2502.5745623244;2521.205820166651;2427.987860060697;2440.7437219092008;2450.3629056445275;2463.2979600813683;2476.1333533263396;2487.340854673513;2489.676342075537;2500.962485562718;2508.8996440142373;2514.38397592591;8733.606987685569;8736.563171841446;8779.956100219459;8794.296456283482;8800.38397312182;5235.424103348629;5377.865553361158;5401.756920938567;5402.486763757476;5421.051316019681;3249.252671885456;3274.590676165479;3278.1968417737567;3327.3678001179696;3335;1072.3190773858578;1099.7360633447995;1125.7692173104494;1128.2440764687678;1129.60463837657;12185.573504927374;12261.754764904741;12318.199317044453;12341.69145771354;12386.194897331734;4593.219152744042;4593.931091033637;4636.698614590108;4684.859454216311;4751.786169622375;9674.516274186262;9695.51522423876;9705.854412183822;9717;9723.222142228746;5230.843074707765;5284.07528682479;5285.942811437728;5289.920651190235;5291.761870715827;4228.957710422918;4701.929471057937;4777.331173635694;4834.468208497133;4852.272159176081;3699.8705045323286;3771.8868433947027;3795.753276037104;3858.382658774639;3931.5478719947;1127.875933647298;1176.5940750441084;1182.2256422043574;1192;1207.3842340406457;1442.4951267056447;1460.8027916231172;1483.3918093581794;1483.4437086092714;1496.0275820716404;8176;8205.753827385188;8250.793730156794;8256.587170641444;8265.917340826634;537.2344409216851;538.1873371209501;540.3191978107612;541.8834950485585;545.8662627656249;5836.241288632451;5844.503217226498;5877.970610146922;5886.381929897385;5903.1145328200255;10083.59665613382;10361.274710770325;10425.11386532138;10439.530221139916;10508.21188410857;10161.898381016095;10385;10394.792104157874;10398.584056637801;10450.216233782498;8008.79978000543;8145.226203510657;8169.387295952827;8197.79505512355;8249.546274954935;8128.63421146038;8177.836443270982;8283.337333013224;8351.624176912175;8407.663693452438;9426.91590467105;9603.183729383081;9662.56518456657;9770.804583908424;9805.803883922139;9657.758556036155;9878.4566848824;9923.851142233018;9961.302708810314;10157.39055656663;6830.8633827324165;7325.560466372035;7520.360769334668;7635.847283054419;7679.884801728091;8340.666373344999;8354.206350396702;8355.456895301786;8370.037445693579;8396.076431592643;7048.9647551763965;7267.164276108315;7270.200277969525;7286;7402;7014.964925175342;7146.3568278855155;7167.820804479929;7219.0976127984;7288.380487658608;7565.054368203974;7581.696732130874;7611;7633.1985141559335;7644.426668000034;6777.356151165632;6809;6834.350736680008;6844.349786770249;6849.623270720158;7088.326608972139;7277.272272772892;7302.342789149002;7345.412367010519;7361.558306501627 17:08:51 INFO - PROCESS | 19332 | |4;prototype.html;369.8613020117456;372.52875112982076;373.14177391998413;380.7429984760287;381.1367253171567;6328.1457003304595;6374;6396.6801659917055;6404.263509696375;6427.582207156532;6253;6267.686615669221;6305.400986906248;6313.210848643919;6320.399562041599;4749.7387643679585;4838.467768545474;4886.438059623153;4910.361652985125;4925.630577706668;4853.174960256765;4865.464798872139;4880.902381952359;4895.485973972735;4904.852854414374;4811.35046768687;4813.422389313288;4817.397825271841;4819.566239038486;4829.106615276168;4827.734474603895;4836.46798852126;4840;4850.781714822841;4852.102361063179;4257.574242575718;4259.467566554181;4265.466816647919;4266.253405654029;4270.487541495009;6029.698515074273;6060.96969515154;6066.757329706807;6069.908951365733;6073.757049718006;5398.676079435247;5594.692291923942;5598.580106491989;5602.13166959122;5607.271054762896;6520.250171230322;6551.672416379162;6557.770478033293;6561.376669216417;6581;4611.492735799059;4620.283856002291;4627.537246275379;4629.629629629621;4632.2819962905805;6905.516613836983;6965.651717414109;6983.476239282023;7024.54340467873;7026.47301452388;4716.688822476962;4767.547083027107;4802.447718512416;4812.25410061441;4817.8313759018265;4859.1496488114435;4862.07620552094;4868.367112275452;4886.609071274361;4887.291342755351;5578.2748242728185;5615.213870058195;5632.070708333161;5635.605507614428;5644.435556444323;6738.292479289604;6751;6754.527183097234;6756.966215168893;6758.357955994173;1708.478913931263;1729.9966019708538;1731.6969530332142;1734.37562477508;1735.1237624999294;1103.172620534599;1132.994335028336;1139.4929256480953;1143.874173840877;1157.2246594781516;6502.44729198014;6504.934950650433;6544.869102617921;6575.473962083021;6587.473002159816;6900.171979362509;6903.1716194057035;6906.723731050702;6931.445484361239;6956.965215173993;6351.523635727339;6446.161998940108;6497.805065848032;6565.277819439858;6569.967150164314;3734.8692795752017;3774.490443790108;3775.112848480605;3783.791891445942;3785.8107094645156;7120.35916767483;7235;7254.331503754166;7255.310745479171;7267.30960558746;7140.178879428829;7145.321194486515;7156.962240475102;7185.49701520899;7194.532355396883;7064.293570642894;7244.673989670478;7255.09311336083;7274.854502909912;7279.308465695751;6960.79117626472;7019.508634395544;7024.121984751906;7025.508214424941;7040.964795175992;6913.75801846933;6915.481338899704;6921.2732663069655;6928.861422771415;6934.965325173342;7231.3130252625915;7253;7267.345938865527;7280.781576552712;7292.927070729224;4743.312219728189;4800.975995120142;4829.106615276185;4851.417829860439;4855.490173531728;6921.757738479129;6953.582785032914;6970.093887794555;7006.684699188447;7013.754518592029;6744.426723728538;6747.089142965637;6748.662566871735;6778.966105169443;6789.15135608049;6733.595984240961;6753.3921947025;6784.864302714017;6796.72813087471;6802.3537763912345;6524.967375163284;6580.934190658224;6610.966945165435;6661.966690166518;6692.564983276072;6717.899231511434;6746.86506269862;6763.628000460022;6780.762673306411;6794.4904132189295;6599.934000660124;6621.900671490028;6630;6630.701618427086;6647.0029495576055 17:08:51 INFO - PROCESS | 19332 | |5;yui.html;686.8591938652577;689.8171984424129;782.1748055801128;835.3233880556749;926.9258459323255;13398.531051413203;13451.991100667465;13558.525451609183;13564.796528052088;13595.320233988297;11900.940495297533;11912.225705329147;11926.224795388294;11995.400229988509;12355.876441235585;858.1418581418566;924.1359329027347;924.3575714878162;930.2046750028729;934.7242563443766;916.1296768070326;930.4045410937006;930.7300882743996;930.7580029192391;931.3154831199063;957.4207604399343;960.2030314838702;961.427950369529;962.3311798300184;962.4417837654179;941.3222479814523;942.9622815087388;945.078548415293;949.0272470717535;949.9810003799886;701.3932947999995;706.3466293678327;708.961007144612;710.1868360726991;711.0507472524187;12394.504219831286;12416.937915310456;12568.371581420985;12574.371281435982;12590.496380144783;11755.235909665844;11810.527578896834;11949;12011.699707507294;12069.577564785279;10475.685729428053;11499.310041397459;12126.211796233305;12502.187357821713;12552.99576033915;3798.1074447504816;3869;3891.20230352777;3894.5131858517684;3928.0965377962943;46872;47128.52871471276;52230.21654675183;52249;52435;10269.74325641865;11085.83371249432;11220.887791122148;11234.775304493864;11264.38045907483;20153.798462015486;20226.696599551018;20363;20461.693074603892;20482;7158.176809666851;7248;7263.019492368463;7938.206179382131;7972.322352600094;3955.2880481513603;4062.939055914164;4138.8344466221615;4183.016991007111;4196.454460920061;3345.431276682921;3377.8648854046055;3392.2197894484407;3421.8802341917913;3424.092615456906;603.7072020070262;603.9003564411911;606.1604677521664;607.8267693707361;612.3998481488167;607.183338409838;608.3703367015119;610.3073012131174;636.4081404293959;639.309545690653;7439.293267139721;7587.58268295249;7918.881216781753;8112.675492980333;8119.4722343047515;546.1398297681168;570.2159530645363;570.7346084070927;574.2333984131232;578.2915927988181;3581.8388172531777;3607.6572725591027;3722.758020728644;3724.981375093107;3790.886273411802;56123;57520.71239643859;57632.71183644055;57860.71069644709;57985.710071450216;51162.488375115776;51276.23085653718;51536.22695659568;52782.89568947036;52981;47239.291410628866;47284.5271547287;47945.28082078772;48142.27786583204;48729.269060964114;8056.879146812686;8197.590120493833;8225.95887020585;8266.297364723825;8323.625436855476;35793;35944.64055359518;36004.639953600126;36458.63541364553;36964.63035369612;44747;44807;45421.31868021916;45499.09001820011;46318.53681463142;11840.881591184323;11948.34284114382;12024.819627705767;12142.089343299465;12182.05425411791;11767.348976535197;11826.290422574673;11898.881011189776;12223.327716975651;12420.254784712584;11143.94428027887;11379.886201137882;11418.257813242113;11424.71438214018;11493.712657183638;11182.720431989266;11231.943840280746;11235.49440275206;11296.378699171624;11331.036861866503;11132.666020019413;11245;11271.380074095676;11281.661550153509;11466.942665286953;8714.128587141235;8947.776305592412;9018.323625727966;9079.863802043106;9130.77173070652;8410.411271210956;8516.787080322794;8576.271016963628;8689.826302729529;8861.689840855539 17:08:51 INFO - PROCESS | 19332 | __end_tp_report 17:08:51 INFO - PROCESS | 19332 | __start_cc_report 17:08:51 INFO - PROCESS | 19332 | _x_x_mozilla_cycle_collect,330 17:08:51 INFO - PROCESS | 19332 | __end_cc_report 17:08:51 INFO - PROCESS | 19332 | __startTimestamp1461370131001__endTimestamp 17:08:51 INFO - PROCESS | 19332 | 17:08:51 INFO - PROCESS | 19332 | ------- Summary: start ------- 17:08:51 INFO - PROCESS | 19332 | Number of tests: 6 17:08:51 INFO - PROCESS | 19332 | 17:08:51 INFO - PROCESS | 19332 | [#0] dojo.html Cycles:165 Average:5692.62 Median:5927.91 stddev:636.69 (10.7%) stddev-sans-first:612.57 17:08:51 INFO - PROCESS | 19332 | Values: 3393.8 3422.7 3483.8 3516.9 3517.5 5652.7 5677.9 5696.6 5711.5 5721.7 5661.1 5672.3 5674.5 5715.0 5724.2 5170.4 5208.8 5259.4 5269.0 5274.1 5117.2 5238.6 5288.7 5347.4 5364.5 5113.0 5173.4 5274.8 5368.7 5385.4 5278.2 5299.2 5299.4 5301.5 5306.8 4971.5 5079.5 5245.4 5273.6 5283.9 5442.1 5487.5 5493.3 5495.4 5502.7 6011.0 6028.9 6048.3 6067.9 6109.2 5979.5 6037.9 6092.3 6243.3 6263.1 5823.6 5835.5 5841.3 5845.5 5848.8 6311.3 6316.0 6322.2 6323.1 6324.4 5984.0 6097.3 6154.2 6179.2 6193.3 6159.3 6159.8 6162.0 6175.5 6205.8 5883.6 6154.2 6166.9 6174.3 6196.0 6018.1 6075.8 6109.3 6123.2 6152.9 4505.8 4568.6 4591.3 4608.8 4650.7 4073.6 4129.6 4133.4 4158.5 4162.6 5690.9 5852.0 5852.9 5927.9 5973.0 6096.4 6099.8 6110.3 6124.0 6129.3 5698.1 5759.7 5815.4 5834.5 5848.2 5250.2 5274.9 5280.4 5298.1 5342.9 6375.1 6383.0 6390.0 6399.8 6405.7 6004.0 6115.3 6217.4 6222.3 6224.3 6265.6 6266.1 6282.2 6288.6 6294.3 5986.0 6023.6 6031.5 6041.8 6056.5 6027.0 6120.2 6126.0 6142.0 6147.3 5829.3 5944.4 5963.7 5966.6 5976.9 6009.8 6012.1 6021.4 6022.2 6029.8 5780.5 5914.3 5964.1 5989.1 5996.2 5945.9 5948.8 5967.4 5978.5 6010.3 5790.7 5860.5 5864.4 5875.4 5889.3 17:08:51 INFO - PROCESS | 19332 | 17:08:51 INFO - PROCESS | 19332 | [#1] ext.html Cycles:180 Average:46463.20 Median:40914.19 stddev:72394.61 (176.9%) stddev-sans-first:72515.58 17:08:51 INFO - PROCESS | 19332 | Values: 540.1 559.2 572.4 587.5 707.2 39431.4 40365.4 40544.4 40566.8 40847.8 40980.6 41532.2 41692.6 41698.4 41834.4 8491.4 8730.0 8737.6 8768.6 8781.4 8775.3 8880.6 8942.3 8958.7 8994.4 8916.3 8951.9 9014.8 9024.1 9050.5 8858.2 8864.9 8969.5 8987.3 9001.4 8779.6 8900.3 8913.3 8924.2 8926.3 35386.0 41327.8 41567.0 41631.4 41795.8 3412.4 3461.8 3548.3 3911.7 4003.8 30258.4 30461.2 30507.4 30512.2 30537.0 3830.4 3879.4 3926.7 3933.4 4008.4 198944.0 199383.0 200756.0 201310.0 249550.0 60276.4 62983.0 68876.7 70153.6 70613.3 64373.7 64485.4 64807.0 64940.7 65042.0 15941.2 16128.2 16139.9 16213.3 16230.6 11553.5 11605.7 11633.8 11692.1 11713.1 22170.7 23010.0 23094.5 23122.5 23134.9 7847.6 7918.4 7993.6 8080.3 8153.6 1054.6 1055.9 1131.5 1147.5 1169.3 31100.7 31300.5 31489.7 31899.0 32293.7 1140.0 1164.2 1213.2 1233.0 1255.9 16171.8 16249.6 16490.7 16679.6 16842.1 183686.0 184267.0 184959.0 185271.0 185574.0 63635.0 63725.7 63786.0 64235.7 64385.4 1458.4 1471.9 1488.6 1505.7 1509.1 30457.7 30746.4 30760.8 31477.2 31687.5 54875.2 55093.0 55329.7 55533.2 55546.2 380456.0 384272.0 385241.0 387662.0 389260.0 46235.0 47103.0 47930.0 49108.3 49298.8 51810.5 52029.5 52604.5 52909.7 52992.7 43018.4 43214.0 44302.0 44410.8 44721.3 42349.0 43371.0 43562.0 43595.0 44339.0 42606.8 42884.1 43020.0 43246.0 43417.6 36346.6 37592.0 37599.2 37643.6 38561.8 25995.2 26869.2 26887.0 26981.1 27007.5 17:08:51 INFO - PROCESS | 19332 | 17:08:51 INFO - PROCESS | 19332 | [#2] jquery.html Cycles:180 Average:26266.30 Median:2390.58 stddev:77331.65 (3234.9%) stddev-sans-first:77524.15 17:08:51 INFO - PROCESS | 19332 | Values: 374.2 390.6 391.8 394.0 410.7 14552.9 17675.7 18693.0 19289.5 19332.5 16550.5 16574.9 16785.7 16794.2 16863.7 5390.2 5804.2 5833.7 5843.8 5846.2 5313.8 5460.1 5506.9 5516.3 5516.5 5408.2 5412.8 5500.9 5868.1 5878.6 5826.6 5834.2 5840.7 5846.0 5873.1 5143.4 5331.7 5361.8 5579.9 5591.6 13468.5 13514.7 13528.7 13756.4 13956.2 2197.5 2215.7 2449.6 2674.7 2767.6 9676.6 9711.9 9731.2 9912.0 10054.2 1779.7 1866.1 1910.8 1917.9 2006.3 63790.7 63994.4 64283.4 64780.7 64967.7 9229.3 9290.2 9544.4 9582.2 10185.3 12787.6 13011.5 13082.5 13114.8 13413.0 6389.6 6439.2 6457.2 6538.2 6574.6 5910.5 5950.6 5987.7 6051.2 6063.6 4204.4 4218.8 4305.0 4316.5 4326.9 1806.7 1820.6 1840.0 1856.6 1857.2 454.3 468.1 472.8 474.7 1040.3 11125.7 11219.9 11342.3 11383.3 11389.5 497.7 500.9 502.0 513.6 514.9 6100.6 6225.4 6257.2 6292.5 6359.0 462829.0 466372.0 468453.0 475602.0 478317.0 81073.0 83277.0 83279.6 83457.6 83786.6 1087.8 1091.7 1104.7 1112.2 1140.2 14955.6 15028.8 15072.9 15169.3 15276.8 36207.8 36275.3 36514.6 36808.6 37092.0 50823.5 52665.7 52776.5 53142.0 53514.0 7660.7 8083.4 8253.0 8403.5 8627.0 9966.6 12938.9 12990.3 13071.5 13566.9 10309.7 10530.4 10824.2 10826.2 10913.6 10332.3 10420.2 10485.8 10511.8 10649.2 10967.7 11031.2 11247.1 11279.9 11309.5 7843.9 8294.5 8373.5 8394.0 8809.6 8671.9 10419.0 10906.3 10915.2 11191.4 17:08:51 INFO - PROCESS | 19332 | 17:08:51 INFO - PROCESS | 19332 | [#3] mootools.html Cycles:180 Average:6000.16 Median:2971.04 stddev:3190.72 (107.4%) stddev-sans-first:3181.90 17:08:51 INFO - PROCESS | 19332 | Values: 1518.8 1523.7 1754.6 1870.5 1917.3 7677.7 8311.1 8477.1 8737.0 8778.4 8434.2 8442.5 8550.8 8661.3 8678.3 2481.4 2512.2 2517.7 2518.6 2528.5 2467.6 2518.1 2533.1 2538.8 2541.8 2478.1 2487.5 2500.1 2502.6 2521.2 2428.0 2440.7 2450.4 2463.3 2476.1 2487.3 2489.7 2501.0 2508.9 2514.4 8733.6 8736.6 8780.0 8794.3 8800.4 5235.4 5377.9 5401.8 5402.5 5421.1 3249.3 3274.6 3278.2 3327.4 3335.0 1072.3 1099.7 1125.8 1128.2 1129.6 12185.6 12261.8 12318.2 12341.7 12386.2 4593.2 4593.9 4636.7 4684.9 4751.8 9674.5 9695.5 9705.9 9717.0 9723.2 5230.8 5284.1 5285.9 5289.9 5291.8 4229.0 4701.9 4777.3 4834.5 4852.3 3699.9 3771.9 3795.8 3858.4 3931.5 1127.9 1176.6 1182.2 1192.0 1207.4 1442.5 1460.8 1483.4 1483.4 1496.0 8176.0 8205.8 8250.8 8256.6 8265.9 537.2 538.2 540.3 541.9 545.9 5836.2 5844.5 5878.0 5886.4 5903.1 10083.6 10361.3 10425.1 10439.5 10508.2 10161.9 10385.0 10394.8 10398.6 10450.2 8008.8 8145.2 8169.4 8197.8 8249.5 8128.6 8177.8 8283.3 8351.6 8407.7 9426.9 9603.2 9662.6 9770.8 9805.8 9657.8 9878.5 9923.9 9961.3 10157.4 6830.9 7325.6 7520.4 7635.8 7679.9 8340.7 8354.2 8355.5 8370.0 8396.1 7049.0 7267.2 7270.2 7286.0 7402.0 7015.0 7146.4 7167.8 7219.1 7288.4 7565.1 7581.7 7611.0 7633.2 7644.4 6777.4 6809.0 6834.4 6844.3 6849.6 7088.3 7277.3 7302.3 7345.4 7361.6 17:08:51 INFO - PROCESS | 19332 | 17:08:51 INFO - PROCESS | 19332 | [#4] prototype.html Cycles:180 Average:5645.95 Median:6436.87 stddev:1700.32 (26.4%) stddev-sans-first:1658.33 17:08:51 INFO - PROCESS | 19332 | Values: 369.9 372.5 373.1 380.7 381.1 6328.1 6374.0 6396.7 6404.3 6427.6 6253.0 6267.7 6305.4 6313.2 6320.4 4749.7 4838.5 4886.4 4910.4 4925.6 4853.2 4865.5 4880.9 4895.5 4904.9 4811.4 4813.4 4817.4 4819.6 4829.1 4827.7 4836.5 4840.0 4850.8 4852.1 4257.6 4259.5 4265.5 4266.3 4270.5 6029.7 6061.0 6066.8 6069.9 6073.8 5398.7 5594.7 5598.6 5602.1 5607.3 6520.3 6551.7 6557.8 6561.4 6581.0 4611.5 4620.3 4627.5 4629.6 4632.3 6905.5 6965.7 6983.5 7024.5 7026.5 4716.7 4767.5 4802.4 4812.3 4817.8 4859.1 4862.1 4868.4 4886.6 4887.3 5578.3 5615.2 5632.1 5635.6 5644.4 6738.3 6751.0 6754.5 6757.0 6758.4 1708.5 1730.0 1731.7 1734.4 1735.1 1103.2 1133.0 1139.5 1143.9 1157.2 6502.4 6504.9 6544.9 6575.5 6587.5 6900.2 6903.2 6906.7 6931.4 6957.0 6351.5 6446.2 6497.8 6565.3 6570.0 3734.9 3774.5 3775.1 3783.8 3785.8 7120.4 7235.0 7254.3 7255.3 7267.3 7140.2 7145.3 7157.0 7185.5 7194.5 7064.3 7244.7 7255.1 7274.9 7279.3 6960.8 7019.5 7024.1 7025.5 7041.0 6913.8 6915.5 6921.3 6928.9 6935.0 7231.3 7253.0 7267.3 7280.8 7292.9 4743.3 4801.0 4829.1 4851.4 4855.5 6921.8 6953.6 6970.1 7006.7 7013.8 6744.4 6747.1 6748.7 6779.0 6789.2 6733.6 6753.4 6784.9 6796.7 6802.4 6525.0 6580.9 6611.0 6662.0 6692.6 6717.9 6746.9 6763.6 6780.8 6794.5 6599.9 6621.9 6630.0 6630.7 6647.0 17:08:51 INFO - PROCESS | 19332 | 17:08:51 INFO - PROCESS | 19332 | [#5] yui.html Cycles:180 Average:13982.58 Median:47000.26 stddev:16309.99 (34.7%) stddev-sans-first:16325.18 17:08:51 INFO - PROCESS | 19332 | Values: 686.9 689.8 782.2 835.3 926.9 13398.5 13452.0 13558.5 13564.8 13595.3 11900.9 11912.2 11926.2 11995.4 12355.9 858.1 924.1 924.4 930.2 934.7 916.1 930.4 930.7 930.8 931.3 957.4 960.2 961.4 962.3 962.4 941.3 943.0 945.1 949.0 950.0 701.4 706.3 709.0 710.2 711.1 12394.5 12416.9 12568.4 12574.4 12590.5 11755.2 11810.5 11949.0 12011.7 12069.6 10475.7 11499.3 12126.2 12502.2 12553.0 3798.1 3869.0 3891.2 3894.5 3928.1 46872.0 47128.5 52230.2 52249.0 52435.0 10269.7 11085.8 11220.9 11234.8 11264.4 20153.8 20226.7 20363.0 20461.7 20482.0 7158.2 7248.0 7263.0 7938.2 7972.3 3955.3 4062.9 4138.8 4183.0 4196.5 3345.4 3377.9 3392.2 3421.9 3424.1 603.7 603.9 606.2 607.8 612.4 607.2 608.4 610.3 636.4 639.3 7439.3 7587.6 7918.9 8112.7 8119.5 546.1 570.2 570.7 574.2 578.3 3581.8 3607.7 3722.8 3725.0 3790.9 56123.0 57520.7 57632.7 57860.7 57985.7 51162.5 51276.2 51536.2 52782.9 52981.0 47239.3 47284.5 47945.3 48142.3 48729.3 8056.9 8197.6 8226.0 8266.3 8323.6 35793.0 35944.6 36004.6 36458.6 36964.6 44747.0 44807.0 45421.3 45499.1 46318.5 11840.9 11948.3 12024.8 12142.1 12182.1 11767.3 11826.3 11898.9 12223.3 12420.3 11143.9 11379.9 11418.3 11424.7 11493.7 11182.7 11231.9 11235.5 11296.4 11331.0 11132.7 11245.0 11271.4 11281.7 11466.9 8714.1 8947.8 9018.3 9079.9 9130.8 8410.4 8516.8 8576.3 8689.8 8861.7 17:08:51 INFO - PROCESS | 19332 | -------- Summary: end -------- 17:08:51 INFO - PROCESS | 19332 | 17:08:51 INFO - TEST-INFO | 19332: exit 0 17:08:51 INFO - TEST-OK | dromaeo_css | took 1110009ms 17:08:51 INFO - TEST-START | kraken 17:08:51 INFO - operating with platform_type : linux_ 17:08:51 INFO - Initialising browser for kraken test... 17:08:51 INFO - TEST-INFO | started process 19577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbLPsjJ/profile http://localhost:60150/getInfo.html) 17:08:55 INFO - PROCESS | 19577 | 17:08:55 INFO - PROCESS | 19577 | (process:19653): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:08:55 INFO - PROCESS | 19577 | __metrics Screen width/height:1600/1200 17:08:55 INFO - PROCESS | 19577 | colorDepth:24 17:08:55 INFO - PROCESS | 19577 | Browser inner width/height: 1024/697 17:08:55 INFO - PROCESS | 19577 | __metrics 17:08:56 ERROR - PROCESS | 19577 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:08:57 INFO - TEST-INFO | 19577: exit 0 17:08:57 INFO - Browser initialized. 17:08:57 INFO - Running cycle 1/1 for kraken test... 17:08:57 INFO - TEST-INFO | started process 19705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbLPsjJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:59 INFO - PROCESS | 19705 | 17:08:59 INFO - PROCESS | 19705 | (process:19773): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:09:09 INFO - PROCESS | 19705 | RSS: Main: 151494656 17:09:09 INFO - PROCESS | 19705 | 17:09:11 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60150/tests/kraken/driver.html?testName=audio-beat-detection) 17:09:12 INFO - PROCESS | 19705 | RSS: Main: 156164096 17:09:12 INFO - PROCESS | 19705 | 17:09:14 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60150/tests/kraken/driver.html?testName=audio-dft) 17:09:15 INFO - PROCESS | 19705 | RSS: Main: 156520448 17:09:15 INFO - PROCESS | 19705 | 17:09:18 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60150/tests/kraken/driver.html?testName=audio-fft) 17:09:18 INFO - PROCESS | 19705 | RSS: Main: 156950528 17:09:18 INFO - PROCESS | 19705 | 17:09:21 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60150/tests/kraken/driver.html?testName=audio-oscillator) 17:09:21 INFO - PROCESS | 19705 | RSS: Main: 156749824 17:09:21 INFO - PROCESS | 19705 | 17:09:23 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60150/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:09:24 INFO - PROCESS | 19705 | RSS: Main: 156798976 17:09:24 INFO - PROCESS | 19705 | 17:09:27 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60150/tests/kraken/driver.html?testName=imaging-darkroom) 17:09:28 INFO - PROCESS | 19705 | RSS: Main: 156872704 17:09:28 INFO - PROCESS | 19705 | 17:09:31 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60150/tests/kraken/driver.html?testName=imaging-desaturate) 17:09:32 INFO - PROCESS | 19705 | RSS: Main: 156844032 17:09:32 INFO - PROCESS | 19705 | 17:09:34 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60150/tests/kraken/driver.html?testName=json-parse-financial) 17:09:35 INFO - PROCESS | 19705 | RSS: Main: 156999680 17:09:35 INFO - PROCESS | 19705 | 17:09:37 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60150/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:09:37 INFO - PROCESS | 19705 | RSS: Main: 156762112 17:09:37 INFO - PROCESS | 19705 | 17:09:39 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60150/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:09:40 INFO - PROCESS | 19705 | RSS: Main: 156966912 17:09:40 INFO - PROCESS | 19705 | 17:09:42 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60150/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:42 INFO - PROCESS | 19705 | RSS: Main: 157270016 17:09:42 INFO - PROCESS | 19705 | 17:09:45 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:45 INFO - PROCESS | 19705 | RSS: Main: 157491200 17:09:45 INFO - PROCESS | 19705 | 17:09:48 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:09:48 INFO - PROCESS | 19705 | RSS: Main: 157634560 17:09:48 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:60150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60150/tests/kraken/driver.html?testName=ai-astar) 17:09:50 INFO - PROCESS | 19705 | RSS: Main: 158732288 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | __start_tp_report 17:09:50 INFO - PROCESS | 19705 | _x_x_mozilla_page_load 17:09:50 INFO - PROCESS | 19705 | _x_x_mozilla_page_load_details 17:09:50 INFO - PROCESS | 19705 | |i|pagename|runs| 17:09:50 INFO - PROCESS | 19705 | |0;ai-astar;110;105;110;111;111;121;111;112;111;112 17:09:50 INFO - PROCESS | 19705 | |1;audio-beat-detection;151;128;163;178;129;152;156;132;172;129 17:09:50 INFO - PROCESS | 19705 | |2;audio-dft;162;164;163;166;163;162;165;163;167;164 17:09:50 INFO - PROCESS | 19705 | |3;audio-fft;76;74;75;167;74;75;72;78;175;75 17:09:50 INFO - PROCESS | 19705 | |4;audio-oscillator;94;93;140;93;94;95;143;93;95;147 17:09:50 INFO - PROCESS | 19705 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;118;117 17:09:50 INFO - PROCESS | 19705 | |6;imaging-darkroom;147;146;147;147;147;146;147;148;147;149 17:09:50 INFO - PROCESS | 19705 | |7;imaging-desaturate;96;96;96;96;98;97;96;96;98;96 17:09:50 INFO - PROCESS | 19705 | |8;json-parse-financial;60;53;61;54;56;54;55;65;54;52 17:09:50 INFO - PROCESS | 19705 | |9;json-stringify-tinderbox;75;65;65;65;66;66;65;66;66;64 17:09:50 INFO - PROCESS | 19705 | |10;stanford-crypto-aes;78;78;80;85;79;80;86;79;81;78 17:09:50 INFO - PROCESS | 19705 | |11;stanford-crypto-ccm;115;117;116;112;115;116;116;117;115;115 17:09:50 INFO - PROCESS | 19705 | |12;stanford-crypto-pbkdf2;138;145;147;145;146;148;147;148;141;145 17:09:50 INFO - PROCESS | 19705 | |13;stanford-crypto-sha256-iterative;73;74;71;68;68;68;67;69;68;66 17:09:50 INFO - PROCESS | 19705 | __end_tp_report 17:09:50 INFO - PROCESS | 19705 | __start_cc_report 17:09:50 INFO - PROCESS | 19705 | _x_x_mozilla_cycle_collect,823 17:09:50 INFO - PROCESS | 19705 | __end_cc_report 17:09:50 INFO - PROCESS | 19705 | __startTimestamp1461370190763__endTimestamp 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | ------- Summary: start ------- 17:09:50 INFO - PROCESS | 19705 | Number of tests: 14 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:3.92 (3.5%) stddev-sans-first:4.13 17:09:50 INFO - PROCESS | 19705 | Values: 110.0 105.0 110.0 111.0 111.0 121.0 111.0 112.0 111.0 112.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.00 stddev:18.73 (12.2%) stddev-sans-first:19.85 17:09:50 INFO - PROCESS | 19705 | Values: 151.0 128.0 163.0 178.0 129.0 152.0 156.0 132.0 172.0 129.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.66 (1.0%) stddev-sans-first:1.62 17:09:50 INFO - PROCESS | 19705 | Values: 162.0 164.0 163.0 166.0 163.0 162.0 165.0 163.0 167.0 164.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:40.60 (54.1%) stddev-sans-first:42.53 17:09:50 INFO - PROCESS | 19705 | Values: 76.0 74.0 75.0 167.0 74.0 75.0 72.0 78.0 175.0 75.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.50 stddev:23.97 (25.6%) stddev-sans-first:24.82 17:09:50 INFO - PROCESS | 19705 | Values: 94.0 93.0 140.0 93.0 94.0 95.0 143.0 93.0 95.0 147.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:09:50 INFO - PROCESS | 19705 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 17:09:50 INFO - PROCESS | 19705 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 147.0 148.0 147.0 149.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 17:09:50 INFO - PROCESS | 19705 | Values: 96.0 96.0 96.0 96.0 98.0 97.0 96.0 96.0 98.0 96.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:55.50 stddev:4.20 (7.6%) stddev-sans-first:4.24 17:09:50 INFO - PROCESS | 19705 | Values: 60.0 53.0 61.0 54.0 56.0 54.0 55.0 65.0 54.0 52.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:3.13 (4.7%) stddev-sans-first:0.71 17:09:50 INFO - PROCESS | 19705 | Values: 75.0 65.0 65.0 65.0 66.0 66.0 65.0 66.0 66.0 64.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:2.88 (3.6%) stddev-sans-first:2.92 17:09:50 INFO - PROCESS | 19705 | Values: 78.0 78.0 80.0 85.0 79.0 80.0 86.0 79.0 81.0 78.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#11] stanford-crypto-ccm Cycles:10 Average:115.40 Median:116.00 stddev:1.43 (1.2%) stddev-sans-first:1.51 17:09:50 INFO - PROCESS | 19705 | Values: 115.0 117.0 116.0 112.0 115.0 116.0 116.0 117.0 115.0 115.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:146.50 stddev:3.20 (2.2%) stddev-sans-first:2.17 17:09:50 INFO - PROCESS | 19705 | Values: 138.0 145.0 147.0 145.0 146.0 148.0 147.0 148.0 141.0 145.0 17:09:50 INFO - PROCESS | 19705 | 17:09:50 INFO - PROCESS | 19705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.50 stddev:2.62 (3.8%) stddev-sans-first:2.39 17:09:50 INFO - PROCESS | 19705 | Values: 73.0 74.0 71.0 68.0 68.0 68.0 67.0 69.0 68.0 66.0 17:09:50 INFO - PROCESS | 19705 | -------- Summary: end -------- 17:09:50 INFO - PROCESS | 19705 | 17:09:51 INFO - TEST-INFO | 19705: exit 0 17:09:51 INFO - TEST-OK | kraken | took 60032ms 17:09:51 INFO - SUITE-END | took 1170s 17:09:51 INFO - Completed test suite (00:19:30) 17:09:51 INFO - javascript benchmark 17:09:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3393.830308484576, 3422.657734226577, 3483.8432270547823, 3516.8769093081746, 3517.4547945068507, 5652.745626446809, 5677.8580535486635, 5696.629719068263, 5711.485966263035, 5721.6853073080965, 5661.122526008476, 5672.347680016789, 5674.546036317095, 5715.0, 5724.198612194296, 5170.353705786767, 5208.843734687946, 5259.368875734917, 5268.973655131738, 5274.05067087924, 5117.1556693145585, 5238.60710446718, 5288.709120998363, 5347.41178470368, 5364.463553644624, 5113.0, 5173.405058418273, 5274.789008439658, 5368.731563421833, 5385.380681221651, 5278.2346559749, 5299.231611416361, 5299.364076310829, 5301.522862942315, 5306.787728490855, 4971.45314015458, 5079.466656001104, 5245.449227831099, 5273.578113750891, 5283.894322113575, 5442.102053161224, 5487.478689524489, 5493.340799104093, 5495.422980587061, 5502.669839809624, 6011.0, 6028.909566356509, 6048.274207095133, 6067.939320606782, 6109.175261339707, 5979.521638268928, 6037.909431358533, 6092.268927728656, 6243.250809902841, 6263.123162757218, 5823.592348535604, 5835.4748072673665, 5841.299044114691, 5845.473907348317, 5848.795292164797, 6311.27420346666, 6315.96842015787, 6322.241331040304, 6323.08315294289, 6324.430801227912, 5983.970080149571, 6097.3292937776805, 6154.1999540059505, 6179.227596550431, 6193.256809182927, 6159.3224745277985, 6159.84600384994, 6161.969190154021, 6175.536834737323, 6205.782797602063, 5883.61756485827, 6154.1999540059505, 6166.876662466726, 6174.320824709278, 6196.039613859859, 6018.127371531104, 6075.75696972125, 6109.313572000199, 6123.243761421121, 6152.938470615326, 4505.752183629932, 4568.565986231302, 4591.288350305641, 4608.838690645878, 4650.651201159926, 4073.572274911151, 4129.566395528486, 4133.42132101506, 4158.500979882433, 4162.604552567501, 5690.9146362804595, 5852.0, 5852.882942341214, 5927.911081333784, 5973.04431291, 6096.359882212392, 6099.84750381244, 6110.26676798787, 6124.0, 6129.325774164839, 5698.059820129715, 5759.654420734685, 5815.41845815415, 5834.474897259267, 5848.210491583667, 5250.238715386247, 5274.947250527523, 5280.445553216857, 5298.072837253465, 5342.931413717272, 6375.075614035939, 6383.010633351838, 6390.0, 6399.840003999937, 6405.743770249231, 6004.0, 6115.301188036123, 6217.378262173746, 6222.346653601307, 6224.284207316216, 6265.624062556261, 6266.122742816101, 6282.246130464374, 6288.5598008138995, 6294.307626161027, 5985.970070149796, 6023.608465449732, 6031.487323577545, 6041.848953776191, 6056.515478761777, 6027.035674292092, 6120.17377654011, 6126.029144987285, 6142.0, 6147.293061298008, 5829.300483941955, 5944.375840536854, 5963.701814909324, 5966.582339236212, 5976.940230597638, 6009.819705408845, 6012.068129439944, 6021.397860213943, 6022.247219097613, 6029.75880964774, 5780.537556995514, 5914.319853216935, 5964.075568286922, 5989.071693887455, 5996.190514280516, 5945.91081133792, 5948.762049517971, 5967.37342579023, 5978.461938425563, 6010.338862725184, 5790.681512516683, 5860.472557469848, 5864.384239654945, 5875.383084776037, 5889.263842019747], "unit": "score", "name": "dojo.html", "value": 5651.085580551162}, {"lowerIsBetter": false, "replicates": [540.1453182835993, 559.2115117684064, 572.4161355417474, 587.4654064801031, 707.193799069061, 39431.40852887209, 40365.394519082234, 40544.39183412248, 40566.79716601416, 40847.795761021225, 40980.59019409805, 41532.16935661285, 41692.58307416925, 41698.37452438216, 41834.37248441276, 8491.405601607905, 8729.956350218241, 8737.606807693637, 8768.649254029831, 8781.42920710155, 8775.341849361292, 8880.555972201364, 8942.329325300596, 8958.731238062835, 8994.415363001384, 8916.331275154356, 8951.910480895205, 9014.774630634221, 9024.052474490183, 9050.547472626375, 8858.15847494487, 8864.8670269946, 8969.506677132755, 8987.325950553703, 9001.414908031022, 8779.64881404743, 8900.332475064397, 8913.28693704502, 8924.241439477652, 8926.330525210635, 35386.0, 41327.793361033, 41567.0, 41631.375529367084, 41795.791021045006, 3412.368711788327, 3461.7922924624604, 3548.3258180945536, 3911.7261791674596, 4003.7597744135446, 30258.394832103233, 30461.23846903823, 30507.389852202832, 30512.237194070105, 30537.0, 3830.444585535082, 3879.35990561557, 3926.725129240954, 3933.3706606943038, 4008.3586626139677, 198944.0, 199383.0, 200756.0, 201310.0, 249550.0, 60276.39723602796, 62983.0, 68876.65561672159, 70153.64923175453, 70613.2938670617, 64373.67813160904, 64485.35514644793, 64807.0, 64940.675296623216, 65042.0, 15941.202939852961, 16128.193590320438, 16139.919300403422, 16213.2704028319, 16230.594235144215, 11553.537858485735, 11605.6518304451, 11633.825492617618, 11692.123090768226, 11713.062954963752, 22170.667439988414, 23010.0, 23094.53810923772, 23122.537549248922, 23134.884325578263, 7847.607619618996, 7918.366530677532, 7993.560354180576, 8080.27277545012, 8153.592320384076, 1054.5728979763055, 1055.8680164979378, 1131.4625552862324, 1147.4778975566098, 1169.2984209474248, 31100.68899311023, 31300.53049204264, 31489.685103149135, 31899.0, 32293.677063229537, 1139.9943000284945, 1164.1582776836406, 1213.1827885290056, 1232.975340493185, 1255.8555766086834, 16171.838281617032, 16249.593760155854, 16490.670186596442, 16679.583010424594, 16842.07368594739, 183686.0, 184267.0, 184959.0, 185271.0, 185574.0, 63635.0, 63725.681371592844, 63786.0, 64235.678821605594, 64385.35614643887, 1458.3510337899745, 1471.8601732835364, 1488.642725745813, 1505.7139143562688, 1509.1322489568543, 30457.695423045487, 30746.385072298875, 30760.846195769773, 31477.213069673442, 31687.52468713017, 54875.17687234774, 55093.0, 55329.723351382985, 55533.167002494185, 55546.16680749711, 380456.0, 384272.0, 385241.0, 387662.0, 389260.0, 46235.0, 47103.0, 47930.0, 49108.26337604867, 49298.753506233676, 51810.481895180565, 52029.47970520398, 52604.47395525996, 52909.7354513225, 52992.735036326114, 43018.35472467853, 43214.0, 44302.0, 44410.79308914371, 44721.32918006167, 42349.0, 43371.0, 43562.0, 43595.0, 44339.0, 42606.786966064974, 42884.1423171541, 43020.0, 43246.0, 43417.56582434135, 36346.636533635385, 37592.0, 37599.248015040095, 37643.62356376401, 38561.80719096387, 25995.220143395727, 26869.193924182306, 26887.0, 26981.0556630517, 27007.45985080248], "unit": "score", "name": "ext.html", "value": 19834.4353496137}, {"lowerIsBetter": false, "replicates": [374.19361276449246, 390.63082405212367, 391.8021399193407, 394.01142335386106, 410.7330235347024, 14552.854471455283, 17675.734863977017, 18693.0, 19289.517762055937, 19332.51668708281, 16550.503484895442, 16574.917125414388, 16785.748213776802, 16794.244259008345, 16863.747043794323, 5390.1914712793105, 5804.216430781854, 5833.7374818133285, 5843.766249350021, 5846.2107615472005, 5313.840584782462, 5460.126379779236, 5506.91739623906, 5516.3380394352735, 5516.531094856942, 5408.161734931092, 5412.756425960842, 5500.917486237709, 5868.09044598088, 5878.559108066891, 5826.592138550303, 5834.183214349994, 5840.707964601753, 5845.970770146143, 5873.148393482942, 5143.3570803649545, 5331.706756128411, 5361.758720857531, 5579.8884022319735, 5591.580631452657, 13468.5286014989, 13514.662133446644, 13528.729425411535, 13756.380962856696, 13956.2324072176, 2197.4726065744107, 2215.700880381144, 2449.5713250181325, 2674.665666791651, 2767.6125342452074, 9676.56455459499, 9711.90288097117, 9731.172850307732, 9911.950440247825, 10054.24593155509, 1779.6974514332464, 1866.0762922353385, 1910.7993660665568, 1917.8753381030328, 2006.3278801601334, 63790.68104659493, 63994.3600563993, 64283.357166428206, 64780.70438591249, 64967.675161624364, 9229.307801914883, 9290.210332121846, 9544.379615324982, 9582.233421326277, 10185.287029907835, 12787.552435664707, 13011.544595939286, 13082.542111026069, 13114.754098360641, 13413.0, 6389.584676995981, 6439.227292724903, 6457.160569125984, 6538.215414150332, 6574.638394888231, 5910.468057874812, 5950.613210141327, 5987.700614969234, 6051.183090282755, 6063.575549711478, 4204.3693445983345, 4218.767967761742, 4305.0, 4316.482022157361, 4326.891827704332, 1806.7018941874705, 1820.5903671673768, 1840.033982159377, 1856.6235218919803, 1857.247814635075, 454.266359828874, 468.0802223630582, 472.75416783272505, 474.70568247686657, 1040.287403128859, 11125.72185695348, 11219.887801121884, 11342.262752921033, 11383.317000979967, 11389.487473063731, 497.7486369383438, 500.9073321435546, 502.0260694253137, 513.6147889083188, 514.9356330458693, 6100.572959892765, 6225.439710426083, 6257.155284036597, 6292.4966002720585, 6359.0, 462829.0, 466372.0, 468453.0, 475602.0, 478317.0, 81073.0, 83277.0, 83279.5836020816, 83457.58271208605, 83786.58106709427, 1087.8041952448634, 1091.6615849086809, 1104.7348636327383, 1112.204773586873, 1140.1562843495753, 14955.626109347353, 15028.774568381701, 15072.924635377192, 15169.269531484439, 15276.847231527987, 36207.818960905024, 36275.27449450943, 36514.634853652184, 36808.63191368052, 37092.0, 50823.491765081875, 52665.7366713164, 52776.47223527869, 53142.0, 53514.0, 7660.693572257047, 8083.393745468996, 8253.0, 8403.537805420761, 8626.956865215885, 9966.60133594677, 12938.935305323414, 12990.285534295705, 13071.542496012595, 13566.86433135656, 10309.74225644335, 10530.36817790935, 10824.242303039027, 10826.188035897496, 10913.618023369145, 10332.276740628384, 10420.164707763677, 10485.790284194425, 10511.789764204826, 10649.201309901633, 10967.725806854893, 11031.22781405294, 11247.100231981258, 11279.887201128213, 11309.491072901903, 7843.921560784547, 8294.543800091053, 8373.539455330016, 8393.95803020981, 8809.647614095364, 8671.913280867111, 10418.982023692499, 10906.34561926287, 10915.181361398085, 11191.44042797873], "unit": "score", "name": "jquery.html", "value": 7977.579875553653}, {"lowerIsBetter": false, "replicates": [1518.8025556677626, 1523.7181121492522, 1754.5701303180722, 1870.5136664467234, 1917.3097684833467, 7677.65450554725, 8311.085780564134, 8477.067522572519, 8736.995245546756, 8778.385513014084, 8434.156584341577, 8442.535660538668, 8550.786230344229, 8661.263792577638, 8678.349123815724, 2481.4168670362496, 2512.246326102162, 2517.7230504644476, 2518.609615509599, 2528.4943011397704, 2467.580511313081, 2518.0934863449143, 2533.07542746897, 2538.809589280802, 2541.758532939368, 2478.1450399612104, 2487.4900645367657, 2500.112460076674, 2502.5745623244, 2521.205820166651, 2427.987860060697, 2440.7437219092008, 2450.3629056445275, 2463.2979600813683, 2476.1333533263396, 2487.340854673513, 2489.676342075537, 2500.962485562718, 2508.8996440142373, 2514.38397592591, 8733.606987685569, 8736.563171841446, 8779.956100219459, 8794.296456283482, 8800.38397312182, 5235.424103348629, 5377.865553361158, 5401.756920938567, 5402.486763757476, 5421.051316019681, 3249.252671885456, 3274.590676165479, 3278.1968417737567, 3327.3678001179696, 3335.0, 1072.3190773858578, 1099.7360633447995, 1125.7692173104494, 1128.2440764687678, 1129.60463837657, 12185.573504927374, 12261.754764904741, 12318.199317044453, 12341.69145771354, 12386.194897331734, 4593.219152744042, 4593.931091033637, 4636.698614590108, 4684.859454216311, 4751.786169622375, 9674.516274186262, 9695.51522423876, 9705.854412183822, 9717.0, 9723.222142228746, 5230.843074707765, 5284.07528682479, 5285.942811437728, 5289.920651190235, 5291.761870715827, 4228.957710422918, 4701.929471057937, 4777.331173635694, 4834.468208497133, 4852.272159176081, 3699.8705045323286, 3771.8868433947027, 3795.753276037104, 3858.382658774639, 3931.5478719947, 1127.875933647298, 1176.5940750441084, 1182.2256422043574, 1192.0, 1207.3842340406457, 1442.4951267056447, 1460.8027916231172, 1483.3918093581794, 1483.4437086092714, 1496.0275820716404, 8176.0, 8205.753827385188, 8250.793730156794, 8256.587170641444, 8265.917340826634, 537.2344409216851, 538.1873371209501, 540.3191978107612, 541.8834950485585, 545.8662627656249, 5836.241288632451, 5844.503217226498, 5877.970610146922, 5886.381929897385, 5903.1145328200255, 10083.59665613382, 10361.274710770325, 10425.11386532138, 10439.530221139916, 10508.21188410857, 10161.898381016095, 10385.0, 10394.792104157874, 10398.584056637801, 10450.216233782498, 8008.79978000543, 8145.226203510657, 8169.387295952827, 8197.79505512355, 8249.546274954935, 8128.63421146038, 8177.836443270982, 8283.337333013224, 8351.624176912175, 8407.663693452438, 9426.91590467105, 9603.183729383081, 9662.56518456657, 9770.804583908424, 9805.803883922139, 9657.758556036155, 9878.4566848824, 9923.851142233018, 9961.302708810314, 10157.39055656663, 6830.8633827324165, 7325.560466372035, 7520.360769334668, 7635.847283054419, 7679.884801728091, 8340.666373344999, 8354.206350396702, 8355.456895301786, 8370.037445693579, 8396.076431592643, 7048.9647551763965, 7267.164276108315, 7270.200277969525, 7286.0, 7402.0, 7014.964925175342, 7146.3568278855155, 7167.820804479929, 7219.0976127984, 7288.380487658608, 7565.054368203974, 7581.696732130874, 7611.0, 7633.1985141559335, 7644.426668000034, 6777.356151165632, 6809.0, 6834.350736680008, 6844.349786770249, 6849.623270720158, 7088.326608972139, 7277.272272772892, 7302.342789149002, 7345.412367010519, 7361.558306501627], "unit": "score", "name": "mootools.html", "value": 4827.564270188771}, {"lowerIsBetter": false, "replicates": [369.8613020117456, 372.52875112982076, 373.14177391998413, 380.7429984760287, 381.1367253171567, 6328.1457003304595, 6374.0, 6396.6801659917055, 6404.263509696375, 6427.582207156532, 6253.0, 6267.686615669221, 6305.400986906248, 6313.210848643919, 6320.399562041599, 4749.7387643679585, 4838.467768545474, 4886.438059623153, 4910.361652985125, 4925.630577706668, 4853.174960256765, 4865.464798872139, 4880.902381952359, 4895.485973972735, 4904.852854414374, 4811.35046768687, 4813.422389313288, 4817.397825271841, 4819.566239038486, 4829.106615276168, 4827.734474603895, 4836.46798852126, 4840.0, 4850.781714822841, 4852.102361063179, 4257.574242575718, 4259.467566554181, 4265.466816647919, 4266.253405654029, 4270.487541495009, 6029.698515074273, 6060.96969515154, 6066.757329706807, 6069.908951365733, 6073.757049718006, 5398.676079435247, 5594.692291923942, 5598.580106491989, 5602.13166959122, 5607.271054762896, 6520.250171230322, 6551.672416379162, 6557.770478033293, 6561.376669216417, 6581.0, 4611.492735799059, 4620.283856002291, 4627.537246275379, 4629.629629629621, 4632.2819962905805, 6905.516613836983, 6965.651717414109, 6983.476239282023, 7024.54340467873, 7026.47301452388, 4716.688822476962, 4767.547083027107, 4802.447718512416, 4812.25410061441, 4817.8313759018265, 4859.1496488114435, 4862.07620552094, 4868.367112275452, 4886.609071274361, 4887.291342755351, 5578.2748242728185, 5615.213870058195, 5632.070708333161, 5635.605507614428, 5644.435556444323, 6738.292479289604, 6751.0, 6754.527183097234, 6756.966215168893, 6758.357955994173, 1708.478913931263, 1729.9966019708538, 1731.6969530332142, 1734.37562477508, 1735.1237624999294, 1103.172620534599, 1132.994335028336, 1139.4929256480953, 1143.874173840877, 1157.2246594781516, 6502.44729198014, 6504.934950650433, 6544.869102617921, 6575.473962083021, 6587.473002159816, 6900.171979362509, 6903.1716194057035, 6906.723731050702, 6931.445484361239, 6956.965215173993, 6351.523635727339, 6446.161998940108, 6497.805065848032, 6565.277819439858, 6569.967150164314, 3734.8692795752017, 3774.490443790108, 3775.112848480605, 3783.791891445942, 3785.8107094645156, 7120.35916767483, 7235.0, 7254.331503754166, 7255.310745479171, 7267.30960558746, 7140.178879428829, 7145.321194486515, 7156.962240475102, 7185.49701520899, 7194.532355396883, 7064.293570642894, 7244.673989670478, 7255.09311336083, 7274.854502909912, 7279.308465695751, 6960.79117626472, 7019.508634395544, 7024.121984751906, 7025.508214424941, 7040.964795175992, 6913.75801846933, 6915.481338899704, 6921.2732663069655, 6928.861422771415, 6934.965325173342, 7231.3130252625915, 7253.0, 7267.345938865527, 7280.781576552712, 7292.927070729224, 4743.312219728189, 4800.975995120142, 4829.106615276185, 4851.417829860439, 4855.490173531728, 6921.757738479129, 6953.582785032914, 6970.093887794555, 7006.684699188447, 7013.754518592029, 6744.426723728538, 6747.089142965637, 6748.662566871735, 6778.966105169443, 6789.15135608049, 6733.595984240961, 6753.3921947025, 6784.864302714017, 6796.72813087471, 6802.3537763912345, 6524.967375163284, 6580.934190658224, 6610.966945165435, 6661.966690166518, 6692.564983276072, 6717.899231511434, 6746.86506269862, 6763.628000460022, 6780.762673306411, 6794.4904132189295, 6599.934000660124, 6621.900671490028, 6630.0, 6630.701618427086, 6647.0029495576055], "unit": "score", "name": "prototype.html", "value": 5098.713193275062}, {"lowerIsBetter": false, "replicates": [686.8591938652577, 689.8171984424129, 782.1748055801128, 835.3233880556749, 926.9258459323255, 13398.531051413203, 13451.991100667465, 13558.525451609183, 13564.796528052088, 13595.320233988297, 11900.940495297533, 11912.225705329147, 11926.224795388294, 11995.400229988509, 12355.876441235585, 858.1418581418566, 924.1359329027347, 924.3575714878162, 930.2046750028729, 934.7242563443766, 916.1296768070326, 930.4045410937006, 930.7300882743996, 930.7580029192391, 931.3154831199063, 957.4207604399343, 960.2030314838702, 961.427950369529, 962.3311798300184, 962.4417837654179, 941.3222479814523, 942.9622815087388, 945.078548415293, 949.0272470717535, 949.9810003799886, 701.3932947999995, 706.3466293678327, 708.961007144612, 710.1868360726991, 711.0507472524187, 12394.504219831286, 12416.937915310456, 12568.371581420985, 12574.371281435982, 12590.496380144783, 11755.235909665844, 11810.527578896834, 11949.0, 12011.699707507294, 12069.577564785279, 10475.685729428053, 11499.310041397459, 12126.211796233305, 12502.187357821713, 12552.99576033915, 3798.1074447504816, 3869.0, 3891.20230352777, 3894.5131858517684, 3928.0965377962943, 46872.0, 47128.52871471276, 52230.21654675183, 52249.0, 52435.0, 10269.74325641865, 11085.83371249432, 11220.887791122148, 11234.775304493864, 11264.38045907483, 20153.798462015486, 20226.696599551018, 20363.0, 20461.693074603892, 20482.0, 7158.176809666851, 7248.0, 7263.019492368463, 7938.206179382131, 7972.322352600094, 3955.2880481513603, 4062.939055914164, 4138.8344466221615, 4183.016991007111, 4196.454460920061, 3345.431276682921, 3377.8648854046055, 3392.2197894484407, 3421.8802341917913, 3424.092615456906, 603.7072020070262, 603.9003564411911, 606.1604677521664, 607.8267693707361, 612.3998481488167, 607.183338409838, 608.3703367015119, 610.3073012131174, 636.4081404293959, 639.309545690653, 7439.293267139721, 7587.58268295249, 7918.881216781753, 8112.675492980333, 8119.4722343047515, 546.1398297681168, 570.2159530645363, 570.7346084070927, 574.2333984131232, 578.2915927988181, 3581.8388172531777, 3607.6572725591027, 3722.758020728644, 3724.981375093107, 3790.886273411802, 56123.0, 57520.71239643859, 57632.71183644055, 57860.71069644709, 57985.710071450216, 51162.488375115776, 51276.23085653718, 51536.22695659568, 52782.89568947036, 52981.0, 47239.291410628866, 47284.5271547287, 47945.28082078772, 48142.27786583204, 48729.269060964114, 8056.879146812686, 8197.590120493833, 8225.95887020585, 8266.297364723825, 8323.625436855476, 35793.0, 35944.64055359518, 36004.639953600126, 36458.63541364553, 36964.63035369612, 44747.0, 44807.0, 45421.31868021916, 45499.09001820011, 46318.53681463142, 11840.881591184323, 11948.34284114382, 12024.819627705767, 12142.089343299465, 12182.05425411791, 11767.348976535197, 11826.290422574673, 11898.881011189776, 12223.327716975651, 12420.254784712584, 11143.94428027887, 11379.886201137882, 11418.257813242113, 11424.71438214018, 11493.712657183638, 11182.720431989266, 11231.943840280746, 11235.49440275206, 11296.378699171624, 11331.036861866503, 11132.666020019413, 11245.0, 11271.380074095676, 11281.661550153509, 11466.942665286953, 8714.128587141235, 8947.776305592412, 9018.323625727966, 9079.863802043106, 9130.77173070652, 8410.411271210956, 8516.787080322794, 8576.271016963628, 8689.826302729529, 8861.689840855539], "unit": "score", "name": "yui.html", "value": 6405.196303819902}], "name": "dromaeo_css", "value": 7214.337979399617}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 110.0, 111.0, 111.0, 121.0, 111.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [151.0, 128.0, 163.0, 178.0, 129.0, 152.0, 156.0, 132.0, 172.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 166.0, 163.0, 162.0, 165.0, 163.0, 167.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 75.0, 167.0, 74.0, 75.0, 72.0, 78.0, 175.0, 75.0], "unit": "score", "name": "audio-fft", "value": 94.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 140.0, 93.0, 94.0, 95.0, 143.0, 93.0, 95.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 98.0, 97.0, 96.0, 96.0, 98.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [60.0, 53.0, 61.0, 54.0, 56.0, 54.0, 55.0, 65.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [75.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.3}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 80.0, 85.0, 79.0, 80.0, 86.0, 79.0, 81.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.4}, {"lowerIsBetter": true, "replicates": [115.0, 117.0, 116.0, 112.0, 115.0, 116.0, 116.0, 117.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.4}, {"lowerIsBetter": true, "replicates": [138.0, 145.0, 147.0, 145.0, 146.0, 148.0, 147.0, 148.0, 141.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 71.0, 68.0, 68.0, 68.0, 67.0, 69.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1520.6000000000004}]} 17:09:52 INFO - Return code: 0 17:09:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:09:52 ERROR - # TBPL SUCCESS # 17:09:52 INFO - Running post-action listener: _resource_record_post_action 17:09:52 INFO - Running post-run listener: _resource_record_post_run 17:09:53 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 278528; Write bytes: 501268480; Read time: 60; Write time: 395116 17:09:53 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244793344; Read time: 0; Write time: 253220 17:09:53 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 278528; Write bytes: 255877120; Read time: 60; Write time: 141896 17:09:53 INFO - Running post-run listener: _upload_blobber_files 17:09:53 INFO - Blob upload gear active. 17:09:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:09:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:09:53 INFO - (blobuploader) - INFO - Open directory for files ... 17:09:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:09:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:09:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:54 INFO - (blobuploader) - INFO - Done attempting. 17:09:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:55 INFO - (blobuploader) - INFO - Done attempting. 17:09:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:09:55 INFO - Return code: 0 17:09:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:09:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:09:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38405fbc66320131181364a5dfadedf0f28bbb1ad7c1a26f2a010e73fee30a243fde499750dc3d40d1ef4ba4734c901f6300a1013432ce893ac03b70f112ea66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b531a9a7641a6521a5c5c49f412908bc4e02ce59b820563f51863b47a239e2ed0f2027d4500939b6e3ff98fe9ed30e5429237349064b1e7c1cf79ad75c58ef1c"} 17:09:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:09:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:09:55 INFO - Contents: 17:09:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38405fbc66320131181364a5dfadedf0f28bbb1ad7c1a26f2a010e73fee30a243fde499750dc3d40d1ef4ba4734c901f6300a1013432ce893ac03b70f112ea66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b531a9a7641a6521a5c5c49f412908bc4e02ce59b820563f51863b47a239e2ed0f2027d4500939b6e3ff98fe9ed30e5429237349064b1e7c1cf79ad75c58ef1c"} 17:09:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:09:55 INFO - Copying logs to upload dir... 17:09:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:09:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.914437 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-22 17:09:54.779304) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 17:09:54.783131) ========= 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=6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38405fbc66320131181364a5dfadedf0f28bbb1ad7c1a26f2a010e73fee30a243fde499750dc3d40d1ef4ba4734c901f6300a1013432ce893ac03b70f112ea66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b531a9a7641a6521a5c5c49f412908bc4e02ce59b820563f51863b47a239e2ed0f2027d4500939b6e3ff98fe9ed30e5429237349064b1e7c1cf79ad75c58ef1c"} build_url:https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011138 build_url: 'https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38405fbc66320131181364a5dfadedf0f28bbb1ad7c1a26f2a010e73fee30a243fde499750dc3d40d1ef4ba4734c901f6300a1013432ce893ac03b70f112ea66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b531a9a7641a6521a5c5c49f412908bc4e02ce59b820563f51863b47a239e2ed0f2027d4500939b6e3ff98fe9ed30e5429237349064b1e7c1cf79ad75c58ef1c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 17:09:54.807286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:09:54.807622) ========= 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=6dbc10da6d83fee962c624be000001a8-1461365524.463081-746795943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:09:54.893760) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 17:09:54.894087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 17:09:54.894386) ========= ========= Total master_lag: 0.17 =========