builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1461259275.78 results: success (0) buildid: 20160421095844 builduid: d795cfbb64f6461bae7f11fa73d69ab8 revision: 5ad0f8d2d7dffcf57ff4d935f5dfb4781683091e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:15.783162) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:15.783860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:15.784401) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:15.812736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:15.813072) ========= 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=20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 10:21:15-- 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% 66.7M=0s 2016-04-21 10:21:16 (66.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110958 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:15.937358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:15.937671) ========= 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=20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016333 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:15.987477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:15.987841) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ad0f8d2d7dffcf57ff4d935f5dfb4781683091e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5ad0f8d2d7dffcf57ff4d935f5dfb4781683091e --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=20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 10:21:16,138 truncating revision to first 12 chars 2016-04-21 10:21:16,138 Setting DEBUG logging. 2016-04-21 10:21:16,138 attempt 1/10 2016-04-21 10:21:16,138 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ad0f8d2d7df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 10:21:16,390 unpacking tar archive at: fx-team-5ad0f8d2d7df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546575 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:16.547398) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:16.547703) ========= script_repo_revision: 5ad0f8d2d7dffcf57ff4d935f5dfb4781683091e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:16.548098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:16.548372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 10:21:16.557600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-21 10:21:16.557898) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:21:16 INFO - MultiFileLogger online at 20160421 10:21:16 in /builds/slave/test 10:21:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:21:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:21:16 INFO - {'append_to_log': False, 10:21:16 INFO - 'base_work_dir': '/builds/slave/test', 10:21:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:21:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:21:16 INFO - 'branch': 'Fx-Team-Non-PGO', 10:21:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:21:16 INFO - 'config_files': ('talos/linux_config.py',), 10:21:16 INFO - 'default_actions': ('clobber', 10:21:16 INFO - 'read-buildbot-config', 10:21:16 INFO - 'download-and-extract', 10:21:16 INFO - 'populate-webroot', 10:21:16 INFO - 'create-virtualenv', 10:21:16 INFO - 'install', 10:21:16 INFO - 'run-tests'), 10:21:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:21:16 INFO - 'download_minidump_stackwalk': True, 10:21:16 INFO - 'download_symbols': 'ondemand', 10:21:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:21:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:21:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:21:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:21:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:21:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:21:16 INFO - 'installer_path': 'installer.exe', 10:21:16 INFO - 'log_level': 'info', 10:21:16 INFO - 'log_name': 'talos', 10:21:16 INFO - 'log_to_console': True, 10:21:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:21:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:21:16 INFO - 'opt_config_files': (), 10:21:16 INFO - 'pip_index': False, 10:21:16 INFO - 'sps_profile': False, 10:21:16 INFO - 'sps_profile_interval': 0, 10:21:16 INFO - 'suite': 'dromaeojs-e10s', 10:21:16 INFO - 'system_bits': '32', 10:21:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:21:16 INFO - 'title': 'talos-linux64-ix-015', 10:21:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:21:16 INFO - 'use_talos_json': True, 10:21:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:21:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:21:16 INFO - 'work_dir': 'build'} 10:21:16 INFO - ##### 10:21:16 INFO - ##### Running clobber step. 10:21:16 INFO - ##### 10:21:16 INFO - Running pre-action listener: _resource_record_pre_action 10:21:16 INFO - Running main action method: clobber 10:21:16 INFO - rmtree: /builds/slave/test/build 10:21:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:21:17 INFO - Running post-action listener: _resource_record_post_action 10:21:17 INFO - ##### 10:21:17 INFO - ##### Running read-buildbot-config step. 10:21:17 INFO - ##### 10:21:17 INFO - Running pre-action listener: _resource_record_pre_action 10:21:17 INFO - Running main action method: read_buildbot_config 10:21:17 INFO - Using buildbot properties: 10:21:17 INFO - { 10:21:17 INFO - "project": "", 10:21:17 INFO - "product": "firefox", 10:21:17 INFO - "script_repo_revision": "production", 10:21:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:21:17 INFO - "repository": "", 10:21:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:21:17 INFO - "buildid": "20160421095844", 10:21:17 INFO - "pgo_build": "False", 10:21:17 INFO - "basedir": "/builds/slave/test", 10:21:17 INFO - "buildnumber": 1179, 10:21:17 INFO - "slavename": "talos-linux64-ix-015", 10:21:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:21:17 INFO - "platform": "ubuntu64_hw", 10:21:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:21:17 INFO - "branch": "fx-team", 10:21:17 INFO - "repo_path": "integration/fx-team", 10:21:17 INFO - "revision": "5ad0f8d2d7dffcf57ff4d935f5dfb4781683091e", 10:21:17 INFO - "stage_platform": "linux64", 10:21:17 INFO - "builduid": "d795cfbb64f6461bae7f11fa73d69ab8", 10:21:17 INFO - "slavebuilddir": "test" 10:21:17 INFO - } 10:21:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:21:17 INFO - Running post-action listener: _resource_record_post_action 10:21:17 INFO - ##### 10:21:17 INFO - ##### Running download-and-extract step. 10:21:17 INFO - ##### 10:21:17 INFO - Running pre-action listener: _resource_record_pre_action 10:21:17 INFO - Running main action method: download_and_extract 10:21:17 INFO - mkdir: /builds/slave/test/build/tests 10:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:17 INFO - https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:21:18 INFO - Downloaded 1361 bytes. 10:21:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:21:18 INFO - Using the following test package requirements: 10:21:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:21:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:21:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:18 INFO - u'jsshell-linux-x86_64.zip'], 10:21:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:21:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:21:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:21:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:21:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:21:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:18 INFO - https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:21:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:21:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:21:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:21:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:21:35 INFO - Downloaded 22275943 bytes. 10:21:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:21:37 INFO - Return code: 0 10:21:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:21: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')]} 10:21:37 INFO - https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:21:39 INFO - Downloaded 22275943 bytes. 10:21:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:21:41 INFO - Return code: 0 10:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:41 INFO - https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:21:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:21:42 INFO - Downloaded 10845952 bytes. 10:21:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:21:42 INFO - Return code: 0 10:21:42 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')]} 10:21:42 INFO - https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:21:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:21:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:21:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:21:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:21:44 INFO - Downloaded 54622168 bytes. 10:21:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:21:44 INFO - mkdir: /builds/slave/test/properties 10:21:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:21:44 INFO - Writing to file /builds/slave/test/properties/build_url 10:21:44 INFO - Contents: 10:21:44 INFO - build_url:https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:21:44 INFO - Running post-action listener: _resource_record_post_action 10:21:44 INFO - Running post-action listener: set_extra_try_arguments 10:21:44 INFO - ##### 10:21:44 INFO - ##### Running populate-webroot step. 10:21:44 INFO - ##### 10:21:44 INFO - Running pre-action listener: _resource_record_pre_action 10:21:44 INFO - Running main action method: populate_webroot 10:21:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:21:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:21:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:21:44 INFO - '--tppagecycles', 10:21:44 INFO - '7'], 10:21:44 INFO - 'tests': ['tsvgm']}}, 10:21:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:21:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:21:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:21:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:21:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:21:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:21:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:44 INFO - 'talos_options': ['--disable-e10s'], 10:21:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:44 INFO - 'talos_options': ['--disable-e10s'], 10:21:44 INFO - 'tests': ['damp', 'tps']}, 10:21:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:44 INFO - 'tests': ['damp', 'tps']}, 10:21:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:21:44 INFO - 'tests': ['dromaeo_dom']}, 10:21:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:21:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:21:44 INFO - 'tests': ['a11yr', 10:21:44 INFO - 'ts_paint', 10:21:44 INFO - 'tpaint', 10:21:44 INFO - 'sessionrestore', 10:21:44 INFO - 'sessionrestore_no_auto_restore', 10:21:44 INFO - 'tabpaint']}, 10:21:44 INFO - 'other-e10s': {'tests': ['a11yr', 10:21:44 INFO - 'ts_paint', 10:21:44 INFO - 'tpaint', 10:21:44 INFO - 'sessionrestore', 10:21:44 INFO - 'sessionrestore_no_auto_restore', 10:21:44 INFO - 'tabpaint']}, 10:21:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:21:44 INFO - 'ts_paint', 10:21:44 INFO - 'tpaint', 10:21:44 INFO - 'sessionrestore', 10:21:44 INFO - 'sessionrestore_no_auto_restore', 10:21:44 INFO - 'tabpaint']}, 10:21:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:21:44 INFO - 'ts_paint', 10:21:44 INFO - 'tpaint', 10:21:44 INFO - 'sessionrestore', 10:21:44 INFO - 'sessionrestore_no_auto_restore', 10:21:44 INFO - 'tabpaint']}, 10:21:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:21:44 INFO - 'tests': ['a11yr', 10:21:44 INFO - 'ts_paint', 10:21:44 INFO - 'tpaint', 10:21:44 INFO - 'sessionrestore', 10:21:44 INFO - 'sessionrestore_no_auto_restore', 10:21:44 INFO - 'tabpaint']}, 10:21:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:21:44 INFO - 'tests': ['a11yr', 10:21:44 INFO - 'ts_paint', 10:21:44 INFO - 'tpaint', 10:21:44 INFO - 'sessionrestore', 10:21:44 INFO - 'sessionrestore_no_auto_restore', 10:21:44 INFO - 'tabpaint']}, 10:21:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:21:44 INFO - 'tests': ['tsvgx', 10:21:44 INFO - 'tsvgr_opacity', 10:21:44 INFO - 'tart', 10:21:44 INFO - 'tscrollx', 10:21:44 INFO - 'cart']}, 10:21:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:21:44 INFO - 'tsvgr_opacity', 10:21:44 INFO - 'tart', 10:21:44 INFO - 'tscrollx', 10:21:44 INFO - 'cart']}, 10:21:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:44 INFO - 'talos_options': ['--disable-e10s'], 10:21:44 INFO - 'tests': ['tp5o']}, 10:21:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:44 INFO - 'tests': ['tp5o']}, 10:21:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:44 INFO - 'talos_options': ['--disable-e10s', 10:21:44 INFO - '--xperf_path', 10:21:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:44 INFO - 'tests': ['tp5n']}, 10:21:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:44 INFO - 'talos_options': ['--xperf_path', 10:21:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:44 INFO - 'tests': ['tp5n']}}, 10:21:44 INFO - 'talos.zip': {'path': '', 10:21:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:21:44 INFO - Running post-action listener: _resource_record_post_action 10:21:44 INFO - ##### 10:21:44 INFO - ##### Running create-virtualenv step. 10:21:44 INFO - ##### 10:21:44 INFO - Running pre-action listener: _resource_record_pre_action 10:21:44 INFO - Running main action method: create_virtualenv 10:21:44 INFO - Creating virtualenv /builds/slave/test/build/venv 10:21:44 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 10:21:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:21:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:21:45 INFO - Using real prefix '/usr' 10:21:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:21:45 INFO - Installing distribute.............................................................................................................................................................................................done. 10:21:47 INFO - Installing pip.................done. 10:21:47 INFO - Return code: 0 10:21:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:47 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 0x7f773059ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f410>, '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 0xf80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf807a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', '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 10:21:47 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 10:21:47 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 10:21:47 INFO - Using env: {'DISPLAY': ':0', 10:21:47 INFO - 'HOME': '/home/cltbld', 10:21:47 INFO - 'LANG': 'en_US.UTF-8', 10:21:47 INFO - 'LANGUAGE': 'en_US:en', 10:21:47 INFO - 'LOGNAME': 'cltbld', 10:21:47 INFO - 'MAIL': '/var/mail/cltbld', 10:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:47 INFO - 'MOZ_NO_REMOTE': '1', 10:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:47 INFO - 'NO_EM_RESTART': '1', 10:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:47 INFO - 'PWD': '/builds/slave/test', 10:21:47 INFO - 'SHELL': '/bin/bash', 10:21:47 INFO - 'SHLVL': '1', 10:21:47 INFO - 'TERM': 'linux', 10:21:47 INFO - 'TMOUT': '86400', 10:21:47 INFO - 'USER': 'cltbld', 10:21:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', 10:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:47 INFO - '_': '/tools/buildbot/bin/python'} 10:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:47 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 10:21:47 INFO - Cleaning up... 10:21:47 INFO - Return code: 0 10:21:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:47 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 0x7f773059ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f410>, '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 0xf80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf807a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', '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 10:21:47 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 10:21:47 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 10:21:47 INFO - Using env: {'DISPLAY': ':0', 10:21:47 INFO - 'HOME': '/home/cltbld', 10:21:47 INFO - 'LANG': 'en_US.UTF-8', 10:21:47 INFO - 'LANGUAGE': 'en_US:en', 10:21:47 INFO - 'LOGNAME': 'cltbld', 10:21:47 INFO - 'MAIL': '/var/mail/cltbld', 10:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:47 INFO - 'MOZ_NO_REMOTE': '1', 10:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:47 INFO - 'NO_EM_RESTART': '1', 10:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:47 INFO - 'PWD': '/builds/slave/test', 10:21:47 INFO - 'SHELL': '/bin/bash', 10:21:47 INFO - 'SHLVL': '1', 10:21:47 INFO - 'TERM': 'linux', 10:21:47 INFO - 'TMOUT': '86400', 10:21:47 INFO - 'USER': 'cltbld', 10:21:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', 10:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:47 INFO - '_': '/tools/buildbot/bin/python'} 10:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:47 INFO - Downloading/unpacking psutil>=0.7.1 10:21:47 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 10:21:47 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 10:21:47 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 10:21:47 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 10:21:47 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 10:21:47 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 10:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:21:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:49 INFO - Installing collected packages: psutil 10:21:49 INFO - Running setup.py install for psutil 10:21:49 INFO - building 'psutil._psutil_linux' extension 10:21:49 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 10:21:50 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 10:21:50 INFO - building 'psutil._psutil_posix' extension 10:21:50 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 10:21:50 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 10:21:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:50 INFO - Successfully installed psutil 10:21:50 INFO - Cleaning up... 10:21:50 INFO - Return code: 0 10:21:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:21:50 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')]} 10:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:50 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')]} 10:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:50 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 0x7f773059ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f410>, '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 0xf80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf807a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', '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 10:21:50 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 10:21:50 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 10:21:50 INFO - Using env: {'DISPLAY': ':0', 10:21:50 INFO - 'HOME': '/home/cltbld', 10:21:50 INFO - 'LANG': 'en_US.UTF-8', 10:21:50 INFO - 'LANGUAGE': 'en_US:en', 10:21:50 INFO - 'LOGNAME': 'cltbld', 10:21:50 INFO - 'MAIL': '/var/mail/cltbld', 10:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:50 INFO - 'MOZ_NO_REMOTE': '1', 10:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:50 INFO - 'NO_EM_RESTART': '1', 10:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:50 INFO - 'PWD': '/builds/slave/test', 10:21:50 INFO - 'SHELL': '/bin/bash', 10:21:50 INFO - 'SHLVL': '1', 10:21:50 INFO - 'TERM': 'linux', 10:21:50 INFO - 'TMOUT': '86400', 10:21:50 INFO - 'USER': 'cltbld', 10:21:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', 10:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:50 INFO - '_': '/tools/buildbot/bin/python'} 10:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:21:52 INFO - Installing collected packages: mozsystemmonitor 10:21:52 INFO - Running setup.py install for mozsystemmonitor 10:21:52 INFO - Successfully installed mozsystemmonitor 10:21:52 INFO - Cleaning up... 10:21:52 INFO - Return code: 0 10:21:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:21:52 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')]} 10:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:52 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')]} 10:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:52 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 0x7f773059ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f410>, '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 0xf80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf807a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', '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 10:21:52 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 10:21:52 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 10:21:52 INFO - Using env: {'DISPLAY': ':0', 10:21:52 INFO - 'HOME': '/home/cltbld', 10:21:52 INFO - 'LANG': 'en_US.UTF-8', 10:21:52 INFO - 'LANGUAGE': 'en_US:en', 10:21:52 INFO - 'LOGNAME': 'cltbld', 10:21:52 INFO - 'MAIL': '/var/mail/cltbld', 10:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:52 INFO - 'MOZ_NO_REMOTE': '1', 10:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:52 INFO - 'NO_EM_RESTART': '1', 10:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:52 INFO - 'PWD': '/builds/slave/test', 10:21:52 INFO - 'SHELL': '/bin/bash', 10:21:52 INFO - 'SHLVL': '1', 10:21:52 INFO - 'TERM': 'linux', 10:21:52 INFO - 'TMOUT': '86400', 10:21:52 INFO - 'USER': 'cltbld', 10:21:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', 10:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:52 INFO - '_': '/tools/buildbot/bin/python'} 10:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:21:52 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 10:21:52 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 10:21:52 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 10:21:52 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 10:21:52 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 10:21:52 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 10:21:54 INFO - Downloading blobuploader-1.2.4.tar.gz 10:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:21:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:21:54 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 10:21:54 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 10:21:54 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 10:21:54 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 10:21:54 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 10:21:54 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 10:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:21:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:55 INFO - Downloading docopt-0.6.1.tar.gz 10:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:21:55 INFO - Installing collected packages: blobuploader, requests, docopt 10:21:55 INFO - Running setup.py install for blobuploader 10:21:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:21:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:21:55 INFO - Running setup.py install for requests 10:21:56 INFO - Running setup.py install for docopt 10:21:56 INFO - Successfully installed blobuploader requests docopt 10:21:56 INFO - Cleaning up... 10:21:56 INFO - Return code: 0 10:21:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:56 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 0x7f773059ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f410>, '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 0xf80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf807a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', '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 10:21:56 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 10:21:56 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 10:21:56 INFO - Using env: {'DISPLAY': ':0', 10:21:56 INFO - 'HOME': '/home/cltbld', 10:21:56 INFO - 'LANG': 'en_US.UTF-8', 10:21:56 INFO - 'LANGUAGE': 'en_US:en', 10:21:56 INFO - 'LOGNAME': 'cltbld', 10:21:56 INFO - 'MAIL': '/var/mail/cltbld', 10:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:56 INFO - 'MOZ_NO_REMOTE': '1', 10:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:56 INFO - 'NO_EM_RESTART': '1', 10:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:56 INFO - 'PWD': '/builds/slave/test', 10:21:56 INFO - 'SHELL': '/bin/bash', 10:21:56 INFO - 'SHLVL': '1', 10:21:56 INFO - 'TERM': 'linux', 10:21:56 INFO - 'TMOUT': '86400', 10:21:56 INFO - 'USER': 'cltbld', 10:21:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', 10:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:56 INFO - '_': '/tools/buildbot/bin/python'} 10:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:56 INFO - Running setup.py (path:/tmp/pip-wRSUQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:56 INFO - Running setup.py (path:/tmp/pip-CkgT1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:56 INFO - Running setup.py (path:/tmp/pip-J6JKUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:56 INFO - Running setup.py (path:/tmp/pip-TKans9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:56 INFO - Running setup.py (path:/tmp/pip-FEaVaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:56 INFO - Running setup.py (path:/tmp/pip-IHwT3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:56 INFO - Running setup.py (path:/tmp/pip-llhWjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:56 INFO - Running setup.py (path:/tmp/pip-mx1xJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:57 INFO - Running setup.py (path:/tmp/pip-rSSafW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:57 INFO - Running setup.py (path:/tmp/pip-dKTPNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:57 INFO - Running setup.py (path:/tmp/pip-oxz33U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:57 INFO - Running setup.py (path:/tmp/pip-TJ9USu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:57 INFO - Running setup.py (path:/tmp/pip-kW3467-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:57 INFO - Running setup.py (path:/tmp/pip-mRB2CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:57 INFO - Running setup.py (path:/tmp/pip-afp5E8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:57 INFO - Running setup.py (path:/tmp/pip-NTao3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:57 INFO - Running setup.py (path:/tmp/pip-OjTEiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:21:57 INFO - Running setup.py install for manifestparser 10:21:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:21:57 INFO - Running setup.py install for mozcrash 10:21:57 INFO - Running setup.py install for mozdebug 10:21:57 INFO - Running setup.py install for mozdevice 10:21:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Running setup.py install for mozfile 10:21:58 INFO - Running setup.py install for mozhttpd 10:21:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Running setup.py install for mozinfo 10:21:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Running setup.py install for mozInstall 10:21:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Running setup.py install for mozleak 10:21:58 INFO - Running setup.py install for mozlog 10:21:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Running setup.py install for moznetwork 10:21:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Running setup.py install for mozprocess 10:21:58 INFO - Running setup.py install for mozprofile 10:21:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:21:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:21:59 INFO - Running setup.py install for mozrunner 10:21:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:21:59 INFO - Running setup.py install for mozscreenshot 10:21:59 INFO - Running setup.py install for moztest 10:21:59 INFO - Running setup.py install for mozversion 10:21:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:21:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:21:59 INFO - Cleaning up... 10:21:59 INFO - Return code: 0 10:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:59 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 0x7f773059ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f410>, '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 0xf80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf807a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', '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 10:21:59 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 10:21:59 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 10:21:59 INFO - Using env: {'DISPLAY': ':0', 10:21:59 INFO - 'HOME': '/home/cltbld', 10:21:59 INFO - 'LANG': 'en_US.UTF-8', 10:21:59 INFO - 'LANGUAGE': 'en_US:en', 10:21:59 INFO - 'LOGNAME': 'cltbld', 10:21:59 INFO - 'MAIL': '/var/mail/cltbld', 10:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:59 INFO - 'MOZ_NO_REMOTE': '1', 10:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:59 INFO - 'NO_EM_RESTART': '1', 10:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:59 INFO - 'PWD': '/builds/slave/test', 10:21:59 INFO - 'SHELL': '/bin/bash', 10:21:59 INFO - 'SHLVL': '1', 10:21:59 INFO - 'TERM': 'linux', 10:21:59 INFO - 'TMOUT': '86400', 10:21:59 INFO - 'USER': 'cltbld', 10:21:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', 10:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:59 INFO - '_': '/tools/buildbot/bin/python'} 10:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:59 INFO - Running setup.py (path:/tmp/pip-Ot5lEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:59 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)) 10:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:59 INFO - Running setup.py (path:/tmp/pip-5mgO6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:59 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)) 10:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:59 INFO - Running setup.py (path:/tmp/pip-lFJp1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:59 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)) 10:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:59 INFO - Running setup.py (path:/tmp/pip-PLgYW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:59 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)) 10:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:59 INFO - Running setup.py (path:/tmp/pip-98wUms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:00 INFO - Running setup.py (path:/tmp/pip-hHIbHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:00 INFO - Running setup.py (path:/tmp/pip-CI7aVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:00 INFO - Running setup.py (path:/tmp/pip-V28GBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:00 INFO - Running setup.py (path:/tmp/pip-kP9LKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:00 INFO - Running setup.py (path:/tmp/pip-mf2imz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:00 INFO - Running setup.py (path:/tmp/pip-TEwQ7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:00 INFO - Running setup.py (path:/tmp/pip-nsnU5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:00 INFO - Running setup.py (path:/tmp/pip-MoRz9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:00 INFO - Running setup.py (path:/tmp/pip-5MGxlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:00 INFO - Running setup.py (path:/tmp/pip-ppffV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:00 INFO - Running setup.py (path:/tmp/pip-PLFsrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:00 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)) 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:00 INFO - Running setup.py (path:/tmp/pip-rh3Zyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:00 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)) 10:22:00 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)) 10:22:00 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)) 10:22:00 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)) 10:22:00 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)) 10:22:00 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)) 10:22:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:02 INFO - Downloading blessings-1.6.tar.gz 10:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:22:02 INFO - Installing collected packages: blessings 10:22:02 INFO - Running setup.py install for blessings 10:22:02 INFO - Successfully installed blessings 10:22:02 INFO - Cleaning up... 10:22:03 INFO - Return code: 0 10:22:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:22:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:22:03 INFO - Reading from file tmpfile_stdout 10:22:03 INFO - Current package versions: 10:22:03 INFO - argparse == 1.2.1 10:22:03 INFO - blessings == 1.6 10:22:03 INFO - blobuploader == 1.2.4 10:22:03 INFO - docopt == 0.6.1 10:22:03 INFO - manifestparser == 1.1 10:22:03 INFO - mozInstall == 1.12 10:22:03 INFO - mozcrash == 0.17 10:22:03 INFO - mozdebug == 0.1 10:22:03 INFO - mozdevice == 0.48 10:22:03 INFO - mozfile == 1.2 10:22:03 INFO - mozhttpd == 0.7 10:22:03 INFO - mozinfo == 0.9 10:22:03 INFO - mozleak == 0.1 10:22:03 INFO - mozlog == 3.1 10:22:03 INFO - moznetwork == 0.27 10:22:03 INFO - mozprocess == 0.22 10:22:03 INFO - mozprofile == 0.28 10:22:03 INFO - mozrunner == 6.11 10:22:03 INFO - mozscreenshot == 0.1 10:22:03 INFO - mozsystemmonitor == 0.0 10:22:03 INFO - moztest == 0.7 10:22:03 INFO - mozversion == 1.4 10:22:03 INFO - psutil == 3.1.1 10:22:03 INFO - requests == 1.2.3 10:22:03 INFO - wsgiref == 0.1.2 10:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:03 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 0x7f773059ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f410>, '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 0xf80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf807a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', '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 10:22:03 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 10:22:03 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 10:22:03 INFO - Using env: {'DISPLAY': ':0', 10:22:03 INFO - 'HOME': '/home/cltbld', 10:22:03 INFO - 'LANG': 'en_US.UTF-8', 10:22:03 INFO - 'LANGUAGE': 'en_US:en', 10:22:03 INFO - 'LOGNAME': 'cltbld', 10:22:03 INFO - 'MAIL': '/var/mail/cltbld', 10:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:03 INFO - 'MOZ_NO_REMOTE': '1', 10:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:03 INFO - 'NO_EM_RESTART': '1', 10:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:03 INFO - 'PWD': '/builds/slave/test', 10:22:03 INFO - 'SHELL': '/bin/bash', 10:22:03 INFO - 'SHLVL': '1', 10:22:03 INFO - 'TERM': 'linux', 10:22:03 INFO - 'TMOUT': '86400', 10:22:03 INFO - 'USER': 'cltbld', 10:22:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', 10:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:03 INFO - '_': '/tools/buildbot/bin/python'} 10:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:03 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)) 10:22:03 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)) 10:22:03 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)) 10:22:03 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)) 10:22:03 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)) 10:22:03 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)) 10:22:03 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)) 10:22:03 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)) 10:22:03 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)) 10:22:03 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)) 10:22:03 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)) 10:22:03 INFO - Cleaning up... 10:22:03 INFO - Return code: 0 10:22:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:03 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 0x7f773059ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f410>, '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 0xf80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf807a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', '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 10:22:03 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 10:22:03 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 10:22:03 INFO - Using env: {'DISPLAY': ':0', 10:22:03 INFO - 'HOME': '/home/cltbld', 10:22:03 INFO - 'LANG': 'en_US.UTF-8', 10:22:03 INFO - 'LANGUAGE': 'en_US:en', 10:22:03 INFO - 'LOGNAME': 'cltbld', 10:22:03 INFO - 'MAIL': '/var/mail/cltbld', 10:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:03 INFO - 'MOZ_NO_REMOTE': '1', 10:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:03 INFO - 'NO_EM_RESTART': '1', 10:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:03 INFO - 'PWD': '/builds/slave/test', 10:22:03 INFO - 'SHELL': '/bin/bash', 10:22:03 INFO - 'SHLVL': '1', 10:22:03 INFO - 'TERM': 'linux', 10:22:03 INFO - 'TMOUT': '86400', 10:22:03 INFO - 'USER': 'cltbld', 10:22:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', 10:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:03 INFO - '_': '/tools/buildbot/bin/python'} 10:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:03 INFO - Downloading/unpacking jsonschema 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:22:05 INFO - Downloading/unpacking functools32 (from jsonschema) 10:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:05 INFO - Downloading functools32-3.2.3-2.tar.gz 10:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:22:05 INFO - warning: no files found matching '*.txt' 10:22:05 INFO - no previously-included directories found matching 'build' 10:22:05 INFO - no previously-included directories found matching 'dist' 10:22:05 INFO - no previously-included directories found matching '.git*' 10:22:05 INFO - Installing collected packages: jsonschema, functools32 10:22:05 INFO - Running setup.py install for functools32 10:22:05 INFO - warning: no files found matching '*.txt' 10:22:05 INFO - no previously-included directories found matching 'build' 10:22:05 INFO - no previously-included directories found matching 'dist' 10:22:05 INFO - no previously-included directories found matching '.git*' 10:22:05 INFO - Successfully installed jsonschema functools32 10:22:05 INFO - Cleaning up... 10:22:05 INFO - Return code: 0 10:22:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f773059ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f410>, '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 0xf80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf807a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', '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 10:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:22:06 INFO - Using env: {'DISPLAY': ':0', 10:22:06 INFO - 'HOME': '/home/cltbld', 10:22:06 INFO - 'LANG': 'en_US.UTF-8', 10:22:06 INFO - 'LANGUAGE': 'en_US:en', 10:22:06 INFO - 'LOGNAME': 'cltbld', 10:22:06 INFO - 'MAIL': '/var/mail/cltbld', 10:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:06 INFO - 'MOZ_NO_REMOTE': '1', 10:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:06 INFO - 'NO_EM_RESTART': '1', 10:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:06 INFO - 'PWD': '/builds/slave/test', 10:22:06 INFO - 'SHELL': '/bin/bash', 10:22:06 INFO - 'SHLVL': '1', 10:22:06 INFO - 'TERM': 'linux', 10:22:06 INFO - 'TMOUT': '86400', 10:22:06 INFO - 'USER': 'cltbld', 10:22:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', 10:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:06 INFO - '_': '/tools/buildbot/bin/python'} 10:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:06 INFO - Downloading/unpacking flake8 10:22:06 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 10:22:06 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 10:22:06 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 10:22:06 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 10:22:06 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 10:22:06 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 10:22:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:22:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:22:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:22:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:22:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:22:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:22:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:22:08 INFO - no previously-included directories found matching 'docs/_build' 10:22:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:22:08 INFO - Running setup.py install for pep8 10:22:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:22:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:22:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:22:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:22:08 INFO - no previously-included directories found matching 'docs/_build' 10:22:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:22:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:22:08 INFO - Cleaning up... 10:22:09 INFO - Return code: 0 10:22:09 INFO - Running post-action listener: _resource_record_post_action 10:22:09 INFO - Running post-action listener: _start_resource_monitoring 10:22:09 INFO - Starting resource monitoring. 10:22:09 INFO - ##### 10:22:09 INFO - ##### Running install step. 10:22:09 INFO - ##### 10:22:09 INFO - Running pre-action listener: _resource_record_pre_action 10:22:09 INFO - Running main action method: install 10:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:22:09 INFO - Reading from file tmpfile_stdout 10:22:09 INFO - Detecting whether we're running mozinstall >=1.0... 10:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:22:09 INFO - Reading from file tmpfile_stdout 10:22:09 INFO - Output received: 10:22:09 INFO - Usage: mozinstall [options] installer 10:22:09 INFO - Options: 10:22:09 INFO - -h, --help show this help message and exit 10:22:09 INFO - -d DEST, --destination=DEST 10:22:09 INFO - Directory to install application into. [default: 10:22:09 INFO - "/builds/slave/test"] 10:22:09 INFO - --app=APP Application being installed. [default: firefox] 10:22:09 INFO - mkdir: /builds/slave/test/build/application 10:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:22:25 INFO - Reading from file tmpfile_stdout 10:22:25 INFO - Output received: 10:22:25 INFO - /builds/slave/test/build/application/firefox/firefox 10:22:25 INFO - Running post-action listener: _resource_record_post_action 10:22:25 INFO - ##### 10:22:25 INFO - ##### Running run-tests step. 10:22:25 INFO - ##### 10:22:25 INFO - Running pre-action listener: _resource_record_pre_action 10:22:25 INFO - Running main action method: run_tests 10:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:22:25 INFO - Python 2.7.3 10:22:25 INFO - Return code: 0 10:22:25 INFO - grabbing minidump binary from tooltool 10:22:25 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')]} 10:22:25 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 0xf7f410>, '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 0xf80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf807a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:22:25 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 10:22:25 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 10:22:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:22:25 INFO - Return code: 0 10:22:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:22:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:22:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:22:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:22:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:22:26 INFO - Return code: 0 10:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 10:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 10:22:26 INFO - Using env: {'DISPLAY': ':0', 10:22:26 INFO - 'HOME': '/home/cltbld', 10:22:26 INFO - 'LANG': 'en_US.UTF-8', 10:22:26 INFO - 'LANGUAGE': 'en_US:en', 10:22:26 INFO - 'LOGNAME': 'cltbld', 10:22:26 INFO - 'MAIL': '/var/mail/cltbld', 10:22:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:22:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:26 INFO - 'MOZ_NO_REMOTE': '1', 10:22:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:26 INFO - 'NO_EM_RESTART': '1', 10:22:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:26 INFO - 'PWD': '/builds/slave/test', 10:22:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:22:26 INFO - 'SHELL': '/bin/bash', 10:22:26 INFO - 'SHLVL': '1', 10:22:26 INFO - 'TERM': 'linux', 10:22:26 INFO - 'TMOUT': '86400', 10:22:26 INFO - 'USER': 'cltbld', 10:22:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074', 10:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:26 INFO - '_': '/tools/buildbot/bin/python'} 10:22:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 10:22:26 INFO - mozversion application_buildid: 20160421095844 10:22:26 INFO - mozversion application_changeset: 5ad0f8d2d7dffcf57ff4d935f5dfb4781683091e 10:22:26 INFO - mozversion application_display_name: Nightly 10:22:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:22:26 INFO - mozversion application_name: Firefox 10:22:26 INFO - mozversion application_remotingname: firefox 10:22:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:22:26 INFO - mozversion application_vendor: Mozilla 10:22:26 INFO - mozversion application_version: 48.0a1 10:22:26 INFO - mozversion platform_buildid: 20160421095844 10:22:26 INFO - mozversion platform_changeset: 5ad0f8d2d7dffcf57ff4d935f5dfb4781683091e 10:22:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:22:26 INFO - mozversion platform_version: 48.0a1 10:22:26 INFO - using testdate: 1461259346 10:22:26 INFO - actual date: 1461259346 10:22:26 INFO - starting webserver on 'localhost:51863' 10:22:26 INFO - SUITE-START | Running 2 tests 10:22:26 INFO - TEST-START | dromaeo_css 10:22:26 INFO - operating with platform_type : linux_ 10:22:26 INFO - Initialising browser for dromaeo_css test... 10:22:26 INFO - TEST-INFO | started process 15059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbd6fK6/profile http://localhost:51863/getInfo.html) 10:22:30 INFO - PROCESS | 15059 | 10:22:30 INFO - PROCESS | 15059 | (process:15125): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:22:31 INFO - PROCESS | 15059 | __metrics Screen width/height:1600/1200 10:22:31 INFO - PROCESS | 15059 | colorDepth:24 10:22:31 INFO - PROCESS | 15059 | Browser inner width/height: 1024/697 10:22:31 INFO - PROCESS | 15059 | __metrics 10:22:31 ERROR - PROCESS | 15059 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:22:32 INFO - TEST-INFO | 15059: exit 0 10:22:32 INFO - Browser initialized. 10:22:32 INFO - Running cycle 1/1 for dromaeo_css test... 10:22:32 INFO - TEST-INFO | started process 15176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbd6fK6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:34 INFO - PROCESS | 15176 | 10:22:34 INFO - PROCESS | 15176 | (process:15236): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:22:44 INFO - PROCESS | 15176 | RSS: Main: 164966400 10:22:44 INFO - PROCESS | 15176 | 10:23:34 INFO - PROCESS | 15176 | 1461259414332 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] 10:25:46 INFO - PROCESS | 15176 | Cycle 1(1): loaded http://localhost:51863/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51863/tests/dromaeo/cssquery-ext.html) 10:25:47 INFO - PROCESS | 15176 | RSS: Main: 169574400 10:25:47 INFO - PROCESS | 15176 | 10:28:49 INFO - PROCESS | 15176 | Cycle 1(1): loaded http://localhost:51863/tests/dromaeo/cssquery-ext.html (next: http://localhost:51863/tests/dromaeo/cssquery-jquery.html) 10:28:50 INFO - PROCESS | 15176 | RSS: Main: 165851136 10:28:50 INFO - PROCESS | 15176 | 10:31:52 INFO - PROCESS | 15176 | Cycle 1(1): loaded http://localhost:51863/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51863/tests/dromaeo/cssquery-mootools.html) 10:31:52 INFO - PROCESS | 15176 | RSS: Main: 167288832 10:31:52 INFO - PROCESS | 15176 | 10:34:54 INFO - PROCESS | 15176 | Cycle 1(1): loaded http://localhost:51863/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51863/tests/dromaeo/cssquery-prototype.html) 10:34:55 INFO - PROCESS | 15176 | RSS: Main: 164835328 10:34:55 INFO - PROCESS | 15176 | 10:37:57 INFO - PROCESS | 15176 | Cycle 1(1): loaded http://localhost:51863/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51863/tests/dromaeo/cssquery-yui.html) 10:37:58 INFO - PROCESS | 15176 | RSS: Main: 166113280 10:37:58 INFO - PROCESS | 15176 | 10:41:01 INFO - PROCESS | 15176 | Cycle 1(1): loaded http://localhost:51863/tests/dromaeo/cssquery-yui.html (next: http://localhost:51863/tests/dromaeo/cssquery-dojo.html) 10:41:01 INFO - PROCESS | 15176 | RSS: Main: 168341504 10:41:01 INFO - PROCESS | 15176 | 10:41:01 INFO - PROCESS | 15176 | __start_tp_report 10:41:01 INFO - PROCESS | 15176 | _x_x_mozilla_page_load 10:41:01 INFO - PROCESS | 15176 | _x_x_mozilla_page_load_details 10:41:01 INFO - PROCESS | 15176 | |i|pagename|runs| 10:41:01 INFO - PROCESS | 15176 | |0;dojo.html;2627.750363715447;2680.490706765715;2712.9186124416274;2732.7540521353076;2745.794065445091;4620.122176786413;4638.1419437404065;4679.625629949604;4685.2737825637;4705.670603057779;4576.1762882681105;4696.50686677899;4724.503927087658;4774.212254977933;4819.638527110464;4351.543087975772;4377.562243775629;4455.064436468346;4457.39825123609;4489.910201795962;4375.496817865938;4441.4004109445295;4459.487158976727;4480.215962206617;4492;4250.681198910094;4326.632236259922;4368.868933931971;4387.956120438818;4430.867073987785;4352.434183556117;4382.824687012516;4383.715058521186;4407.052483715985;4449.644028477714;4283.31466965284;4348.543402942677;4355.237833379146;4364.5635436456105;4410.889727756799;4669.626429885601;4697.88255293617;4719.811207551694;4748.810047598126;4767.785449654774;4952.405711314629;4974.552290293891;4979.0788704089855;4994.175960966436;5055.721935293557;4869.488703686097;5018.64869459138;5030.144875371196;5058.620603454719;5080.314157588715;4593.471750748673;4670.346151538787;4674.579287864109;4711.481737008926;4720.551547602972;5074.037905813453;5087.033463641897;5104.132297509433;5121.718305493159;5138.820141295037;4817.518248175154;4901.803927842846;4906.362172917497;4912.336834527365;4937.8271760488215;5020.171671674133;5065.088284108896;5083.466236045236;5114.846554603368;5163.8192663256605;4858.46556878743;4998.725070121105;5028.220625802934;5043.4956504349275;5080.822171223989;4835.975820120947;5005;5008.048470790538;5019.974900125549;5055.140626093573;4218.346156345771;4242.957570424318;4244.681648876347;4253.574642535722;4254.170436764801;3714.0900479382726;3765.5104836371643;3765.8870233893026;3772.3775577029483;3799.5820459749407;4312.805923733439;4379.386885835986;4379.540148284448;4405.889852753643;4410.779461026936;4925.581325587294;5085.415177254589;5097.439281679012;5117.820876269313;5118.641695081308;4341.978290108529;4369.4101296325225;4370.038591509863;4391.604755572014;4411.602955733999;4532.4334458192725;4550.567696068868;4561.840335588238;4588.541145885385;4607.562281583244;4558.8860278491975;4684.718916864999;4717.669763116617;4723.929141062887;4742.834000809955;5085.186370180902;5090.592752579859;5124.846254612367;5137.5889928806355;5188.7405629717605;4754.0491901619125;4759.928601071056;4762.476127626028;4804.903901922012;4843.4430040545785;4919.827806026772;4985.52637499437;5036.697798132123;5049.015441988924;5110.514501122388;5096.133657278346;5110.97444512775;5136.460671629425;5141.126008578625;5150.48495150482;4918.2622606607865;4944.085344211332;4954.455009948975;4972.378452693413;4975.378077740283;4806.711597304173;4824.179889418737;4850.83022094225;4943.752812359296;4973.626977976739;4803.879903002453;4807.735574543433;4831.444383895757;4840.588549973291;4863.708177509361;4973.229149481836;5011.949880501148;5015.297858299914;5015.724135172601;5021.573166280907;4756.025014872012;4883.560479556857;4895.8041678332465;4974.825881094144;4988.775505102351 10:41:01 INFO - PROCESS | 15176 | |1;ext.html;551.4238723381812;580.6516090345792;593.2258402784367;596.4274296675193;617.5430181665569;32546.67453325466;33406;33663.495047574244;33704.32591348171;33759.32481350374;33479.16302092449;33819.83090084546;34103.65896341036;34122.829385853096;34237.14407139823;7421.406287497;7550.169481357047;7563.470557061008;7608.353289970331;7624.580648064354;7464.066991626047;7774.689012439496;7784.532928024337;7792.10390805059;7809.843803123934;7745.7676269712;7787.454878158531;7791.104023037338;7805.141434442206;7808.804779880492;7633.274838890296;7666.961665191666;7684.846303073908;7721.652525636332;7750.961245193795;7666.578338191397;7748.4188685848785;7762.883556746653;7781.066272047334;7785.4939428937505;28472.28819279514;35166;35734.463983040274;35842.46236306457;35874.820625896704;3032.4844776388068;3075.2311922019494;3197.1847178969215;3432.4806070322425;3596.9100772480638;26603.600945985825;26812.195634131007;26840.194794156207;27540.862295688392;28159.15522534327;3459.636738142484;3482.5298584690995;3523.260115375774;3540.2919416116624;3628.818559072036;182744;187586;189380;189849;190388;33815.32369352599;34617.134571635404;57027.42972570304;57787;57930.710346447995;33427.49858752072;33544.66455335415;33778.66221337755;33790.155246119044;33903.830480847435;11862.703432414259;12013.939930300292;12095.576654817216;12142.817857732141;12167.391630418444;9430.339876208736;9455.101765332283;9470.715878523655;9492.050794920591;9508.762280943032;8316.6673333066;8322.126176751353;8344.707935222237;8364.414490985573;8422.199891010345;3285.80285182885;3330.9500357494658;3345.5818022747158;3368.9326213475592;3371.0392538126516;924.3991405586288;962.9903700963041;974.1865542272141;982.6708052802248;1005.0602686488157;27788.444231115667;28545.57181642277;29031;29158.854205728836;29406.411871762873;1023.22746326523;1038.6053299746047;1074.3500182389698;1084.8318510630866;1129.3506233915532;14932.402703891723;15232.619184520476;15547.844521554865;15635;15639.530814075595;146094;148183;148576;148613;149312;49784.751076244385;50212;50244.74877625588;50424.49575504271;50506;1204.9396531052619;1252.931088790107;1252.956146534867;1266.6769973656658;1329.547953695748;26702.866485667448;27497.725022749517;27767.722322776513;27811.582826258025;28102.578461322686;42389.15221695611;42545.149097018504;42815;42975.355369668854;43060.569394305654;302715;304673;305411;305903;307637;22121.889390552944;22180.445488862908;22193.22323718662;22298.77701222967;22422.990965406923;41740;42322.29734787081;42757.78621106874;43012.78493607512;43026.78486607547;35560.46659300164;35627.82186089053;35682.28635427225;36113.27773444464;36176.27647447089;34920.65079349174;34939;35080.94757157289;35210.47184292289;35477.29045419129;35556.28887422186;35918.28163436769;36021.63978360183;36091.63908360988;36689.61517501354;31041.844790776806;32534.674653253165;32592.34815303633;32781.67218327882;32887.506687400186;24465.510689785748;24818.627720584565;24974.750252497244;25227.49545009126;25268.241952741446 10:41:01 INFO - PROCESS | 15176 | |2;jquery.html;372.2573465935457;373.3727338072039;373.9682127019204;380.40656575741826;382.711053154868;15074.773878391832;15550.300236489356;16225.83774162258;16275.430359937374;16311;15183;16648.50054498364;16799.16004199791;16822.663546729058;16900.492985210432;4774.0690565339855;4945;4980.651354405193;4982.277569752384;5032.672876263049;4970.155073637472;4998.250262460624;5001.3998320201445;5007.4491805901325;5019.171836646967;5111.6166287528395;5436.945630543703;5462.262594549745;5468.28912241408;5473.890522189554;5373;5402.270693456392;5791.855203619901;6182.907256391158;6198.969005154991;5470.507654311131;5485.61600687952;5505.724713764336;5514;5514.503694667499;18955;19793.9010304949;20065.796052236914;20224.69662955057;20462.693059604117;1936.5836345185712;2015.4256037029377;2036.0634108310196;2048.047657839112;2140.3578926322043;9370.531473426301;9457.527123643791;9552.856707149398;9785.07041831025;10511.421871797049;1693.6612677464434;1699.9980140210032;1711.084569755175;1736.444337811888;1823.9270429182816;50891;58882;59053.7047314765;66177.66911165461;70739;9525.951695457527;9700.514974251259;9953.054459826304;10072.546735396925;10082.798344033079;14153.929230353782;14259.21574313402;14260.85739142616;14287.928560357132;14327.06874053204;7000.404965577983;7023.754168604074;7081.681324340417;7175.8564828704175;7244.746433874789;6445.065465507569;6445.097686323918;6531.706073226716;6561.475081993429;6596.472282217411;4403.669724770655;4443.155800397914;4453.287474004143;4478.708883922534;4556.72659640416;1759.4281858396073;1799.4511673939573;1862.6460972415198;1889.23485988175;1901.7622797150357;847.3941132090462;876.1151237250423;897.3494216692845;900.7432881628704;939.9389039712534;15631.3747450103;16238.918805406134;16368.181590920407;16443;16609.086500242604;892.4823602310644;902.9593668284942;913.255696607263;942.6983365323168;944.8991924407987;9278.257739380833;9410.764730881783;9430.95284523573;9519.23846092311;9539.80416560446;138644;140364.2981785105;223669.88165059072;378583.6062295284;382182;72699.90950135647;73075.63462182762;74257.25742742611;74578;74902.62548687222;936.194872409727;939.4832841937044;946.9857952130724;962.9133377995873;968.6319198704447;14680.926595366955;14754.48359307419;14800.925995369955;14887.627809304853;14944.701105977601;29312.41375172442;30169.69830301669;32147.839260803546;35794.463083053255;36154;46874.53125468702;47372.289415659485;47438;47488;47660.76169619268;7299.817504562216;7605.733799317219;7641.961790191013;7714.961425192838;7880.527168369917;7318.487705860539;7444.106707195171;10610.204234682275;10632.681019569425;11207.831882521605;9712.223022158068;9924.206063515046;10233.385996840214;10280.948595256976;10394.948025259826;9924.354916930377;10067.647632332833;10286.948565257426;10393.740156495845;10414.687559373231;10123.341982771097;10249.180065594586;10603.204759642904;10603.310784798963;10652;7791.92208077912;7940.325072368913;7948.483348582324;7966.760997170094;8060.758177254692;9208.631654733736;9834;10262.230332725225;10366.274360794672;10578.41818699948 10:41:01 INFO - PROCESS | 15176 | |3;mootools.html;1440.38063632638;1475.1665309100358;1617.5228307649243;1753.587906841891;1776.760137381454;6651.73393064278;7399.112106547215;7432.96283518583;7669.079710434748;7688.192739762321;7476.1776204617445;7477.25227477252;7505.512141710785;7545.943567900498;7559.433042521805;2211.436083798629;2227.766084561122;2232.441889527618;2239.585676649817;2259.604569200383;2174.184680744721;2217.1796435318956;2241.674957131215;2244.8316376271764;2245.315178870444;2187.3437968609433;2206.6689996500495;2208.1277895231374;2212.1814928476488;2249.910003599854;2133.9253126140666;2140.7966243206947;2144.1959265275523;2151.8493705440624;2164.8701077935375;2162.4593851537115;2176.6190916589535;2177.3250292409243;2179.259051922338;2182.8035476807163;7645.694172233104;7662.9233707663325;7680.11678656956;7689.346405555534;7706.152323244439;4341.782910854445;4454.109178164348;4485.461744590637;4502.684812063157;4511.210538155809;2770.7644850187758;2832.2494538947194;2911.1121108062034;2919.022127587261;2920.751736102434;925.759302581327;951.5242378810594;966.1401352796017;967.0957654592978;972.0910948263396;9942.353747006493;9948.80102397948;9962.750931226778;9979.051990060932;10008.39949603026;4022.4770779799023;4033.9596604034173;4183.435236243129;4194.077302993398;4208.305629571148;8539.82920341602;8552.657893684307;8561.101084386175;8564.272036876811;8584.613692383859;4569.474510431343;4584.839530616412;4586.656000799953;4602.930956035662;4603.516630753789;3601.819909004539;4132.91734165315;4165.854195103157;4205.032842446193;4216.409702641633;3527.9294414111573;3543.344481270973;3655.707543396522;3672.210474747942;3715.3869611513796;1173.5188572685158;1202.9699257518632;1210.7820592293472;1229.305442425027;1238.219921449481;789.403999980023;801.8797180422984;888.7778055486128;893.1604291965532;896.9368759519258;5228.111221092423;5422.539084177889;5455.781768729206;5455.781768729285;5481.780728770885;401.70073295394536;406.7986346758374;407.63109386005715;408.55059434621677;430.5930895303908;3545.2554963457965;3581.6239294874185;3653.1962968146963;3666.395044817629;3696.8890933272046;8754.080821513777;9080.954595227115;9151.862722059175;9183.173514383738;9206.355555111211;8882.777930551789;8972.37193396469;9080.954595226982;9096.636134554676;9098.499582523025;6890.414314783299;6926.307369263134;6970.895436568456;7034.331738484836;7049.154101507749;4982.4768399317545;5076.695398276115;5136.075506408883;5209.583233341399;5255.264263003259;8276.751697449086;8313.501189928624;8381.664733410595;8396.748097557083;8515.19105684959;8024.759257222293;8290.212429819157;8382.580870956306;8497.702580409656;8510.74467765968;6002.069679199731;6452;6640.966795165993;6671;6761.898571521333;7146.071010768567;7175.282471752783;7177.1746249182015;7199.640017998974;7235.927640723736;6359.49124070064;6554.049662798963;6563.737450501926;6591.307912669101;6702.798916032331;6544.28012918569;6551.737930482918;6607.57050791697;6613.966930165318;6677.09859169006;6220.937790622036;6263.718132683949;6282.183316168869;6284.183056202664;6301.495880329654;4108.2810508160355;4157.584241575818;4235;4240.851570195028;4305.82776688929;4525.63794896414;4570.108828778356;4661.3940187776725;4677.368555244999;4701.929471057869 10:41:01 INFO - PROCESS | 15176 | |4;prototype.html;300.4411794063043;308.28631717573813;310.6210423283594;311.1164293406724;314.4795363673119;5250.448702886194;5284.603654725896;5331.600129990247;5339.398180545831;5400.70296133713;5184.326037615114;5231.058409486291;5246.7901283948695;5253.789848406059;5285.127953887613;3897.57126716061;3968.821403036856;4125.113100683352;4140.378943158536;4145.896352591194;4122.855700050499;4124.649404800581;4125.2780763366445;4133.979330103345;4148.6266236038755;4089.7750623715683;4113.362428823537;4120.876373708794;4127.380892866064;4129.690273229505;4041.7979101044975;4105.815238314283;4141.095096255726;4142.2543942090415;4150.584941505856;3611.9638803611892;3639.763415377992;3640.12636967126;3643.744937854351;3645.434957581579;5047.772850221749;5050.873728156826;5061.240813877911;5077.111505486562;5111.565516931066;4571.908561828778;4738.976305118453;4753.500882407367;4768.47546769855;4776.47458779534;5539.14143307788;5580.804671836466;5618.297712785902;5619.6066275360745;5622.526088521078;3973.9931334676094;3978.562358140602;3999.900002499961;4009.298372784751;4009.3384591542363;5625.156226566048;5881.264841894763;5894.705264736789;5904.498117660004;5923.141144534018;3894.6884249260556;3921;3935.6457918787446;3945.2109578084496;3951.7431366961055;3997.040710229524;4011.0373510357886;4019.4975628046495;4020.0753826619457;4024.6176613221696;4561;4609.124266389443;4626.537346265414;4640.489546149921;4642.698224615457;5531.1426728857095;5570.610057296031;5628.465295796893;5648.322201335784;5657.405972372924;1384.1694983010314;1408.4647833823287;1409.3728290910447;1411.5200831717061;1414.978775318371;875;875.365360113925;926.5830376330678;937.3391758810022;938.6808485115093;4715.962488252648;4725.314829349725;4773.331733557305;4798.928685641193;4821.108095002436;5691.317041954909;5700.914486282709;5704.4295570443455;5732.082866741302;5755.913661295084;4633.837815676503;4766.642501812378;4805.014971930746;4810.63920205986;4835.6131509479865;3042.361104168105;3066.5553494743585;3070.1250143708935;3080.5047911192005;3095.4273459410083;5277.9472205278225;5309.309789727388;5315.176147697113;5344.091504444254;5355.357357117171;5686.516646085129;5828.213191219216;5864.120381942743;5866.677332746654;5882.02946513829;5271.920921186185;5310.309659744285;5312.282841816305;5327.786888524415;5343.412224655207;5522.116461366162;5662.235598194191;5697.601167918206;5716.28546431696;5725.914111288251;5558.583106267127;5566.246632310809;5579.163125531203;5600.635958662674;5615.213870058114;5271.525562699376;5285.550728188147;5293.655912365838;5293.867653308698;5300.363956325112;3710.8144592769713;3936.4488971543433;3939.9015024624614;3943.132510847609;3959.4258832468554;5720.199172115824;5760.395158508296;5761.971190144022;5780.855478613068;5781.5663825214115;5601.29983752031;5610.607257491936;5615.522680572197;5616.7191640416995;5622.212890195294;5390.919136212881;5588.804391846428;5604.243427137284;5668.7165641718575;5676.480582039162;5299.099153143898;5456.372517160577;5513.5037846594;5549.472800083986;5573.470520300565;5494.917576236279;5679.971600141973;5713.857153571194;5731.942680573141;5748.137779333133;5548.0845660465575;5558.833235002957;5573.108302671553;5574.554035677217;5581.358143813513 10:41:01 INFO - PROCESS | 15176 | |5;yui.html;770.4645271536283;787.5510958753509;787.933025692816;789.9486533375326;795.7612716185143;11935.940320298398;12266.037434010537;12331.876681233196;12336.999999999989;12375;12936.805947910789;12949.676258093552;12987;13006.219626822374;13029.348532573356;629.1223742878705;798.3732769775742;802.5104686141449;803.6022169026311;804.5293503300576;769.165455480804;793.3217099380033;795.5862951265367;798.393221151923;800.1118758178446;834.4492634860993;836.3392919593545;840.4075127035426;840.4369072721261;841.7895526118471;831.2560258568577;833.1876420490034;834.3867257565685;835.381817455085;837.0374069819756;613.9723712432951;614.3457218062749;615.8183335915916;622.5019984012772;623.6382897919241;12078.6376408707;12108.939455302756;12137.635870923887;12144.149909506337;12159.574414895436;11941.522339106425;12052.939735301356;12143;12154.756904861853;12347.876521234763;9708.998389950106;9716.562754675986;9774.853377199348;9847.310688251826;10076.496175191285;3306.057773534555;3325.334933013383;3346.916327091818;3362.6132994705677;3399.133221028622;42201;42948.141037179084;45023;45064;45249;9791.608335666637;9832;9865.605375784888;10076.193904487624;10109;16387.83612163887;16498.505044848673;16535.338586456648;16556.337746490004;17064.146792660318;6743.224529179109;6771.932280677229;6780.355866192704;6803.727850886008;6840.41856442208;3792.2984247914223;3819.694424446038;3841.078141246081;3852.8266228019806;3890.708196885245;2824.7740180785486;2894.3198348388114;2897.2322334581354;2901.2166714987256;2927.9121626351243;513.9152039913447;514.9253358263031;519.8986197691414;521.5644936478008;521.6661336744487;610.5725991805665;640.4364159539668;643.7038962077403;644.6003477843767;653.4086651580327;7728.729494467667;7807.258310460497;8097.190280971856;8103.878441823377;8137.633806478722;523.4190049045557;536.4153073150285;640.7437025189961;641.7581978870807;655.2235600812957;3668.8899333020054;3700.6114357992024;3726.7763934164036;3780.432935059708;3792.0898984244136;42179.57820421756;43343.78328108339;43442.131157377305;52372.47627523676;53056.734716326944;37558.8122059388;38891.02772430712;39261.411078833844;39380.60619393826;39540.20919581592;31420.685793141776;31781.682183178335;35336.293274134885;36709;41028;7903.170167132598;8201.876971845308;8399.244068033906;8481.87277190855;8611.48331100136;26867.462650746485;26867.731322687305;26903.596446052932;27594.724052759215;28177.57733633956;33652.663473364955;36148.63851361558;37808.62191378051;38201.61798381981;38579.80710096544;10449.111825494918;10541.31481453703;10620.09729173029;10657.41384223844;10723.284274516353;11591.6522504325;11658.53365865356;11753.353565553976;11836;11881.5841445549;11146.777064458827;11307.943460282646;11504.82742758876;11523.711907202387;12055.095867810125;11577.536898523964;11624.593139240085;11811.586594469496;11973.401329933295;12324.383780811102;10237.641682541076;10489.737756556147;10571.735706607396;10908.672739817817;11699.88300117022;9368.4378937264;9529.761755956157;9536.713898583053;9667.323287369816;9714.854277185706;9228.146094863914;10136.239782016231;10218;10254.948725256327;10314.690559283234 10:41:01 INFO - PROCESS | 15176 | __end_tp_report 10:41:01 INFO - PROCESS | 15176 | __start_cc_report 10:41:01 INFO - PROCESS | 15176 | _x_x_mozilla_cycle_collect,412 10:41:01 INFO - PROCESS | 15176 | __end_cc_report 10:41:01 INFO - PROCESS | 15176 | __startTimestamp1461260461391__endTimestamp 10:41:01 INFO - PROCESS | 15176 | 10:41:01 INFO - PROCESS | 15176 | ------- Summary: start ------- 10:41:01 INFO - PROCESS | 15176 | Number of tests: 6 10:41:01 INFO - PROCESS | 15176 | 10:41:01 INFO - PROCESS | 15176 | [#0] dojo.html Cycles:165 Average:4674.11 Median:4774.21 stddev:475.26 (10.0%) stddev-sans-first:448.79 10:41:01 INFO - PROCESS | 15176 | Values: 2627.8 2680.5 2712.9 2732.8 2745.8 4620.1 4638.1 4679.6 4685.3 4705.7 4576.2 4696.5 4724.5 4774.2 4819.6 4351.5 4377.6 4455.1 4457.4 4489.9 4375.5 4441.4 4459.5 4480.2 4492.0 4250.7 4326.6 4368.9 4388.0 4430.9 4352.4 4382.8 4383.7 4407.1 4449.6 4283.3 4348.5 4355.2 4364.6 4410.9 4669.6 4697.9 4719.8 4748.8 4767.8 4952.4 4974.6 4979.1 4994.2 5055.7 4869.5 5018.6 5030.1 5058.6 5080.3 4593.5 4670.3 4674.6 4711.5 4720.6 5074.0 5087.0 5104.1 5121.7 5138.8 4817.5 4901.8 4906.4 4912.3 4937.8 5020.2 5065.1 5083.5 5114.8 5163.8 4858.5 4998.7 5028.2 5043.5 5080.8 4836.0 5005.0 5008.0 5020.0 5055.1 4218.3 4243.0 4244.7 4253.6 4254.2 3714.1 3765.5 3765.9 3772.4 3799.6 4312.8 4379.4 4379.5 4405.9 4410.8 4925.6 5085.4 5097.4 5117.8 5118.6 4342.0 4369.4 4370.0 4391.6 4411.6 4532.4 4550.6 4561.8 4588.5 4607.6 4558.9 4684.7 4717.7 4723.9 4742.8 5085.2 5090.6 5124.8 5137.6 5188.7 4754.0 4759.9 4762.5 4804.9 4843.4 4919.8 4985.5 5036.7 5049.0 5110.5 5096.1 5111.0 5136.5 5141.1 5150.5 4918.3 4944.1 4954.5 4972.4 4975.4 4806.7 4824.2 4850.8 4943.8 4973.6 4803.9 4807.7 4831.4 4840.6 4863.7 4973.2 5011.9 5015.3 5015.7 5021.6 4756.0 4883.6 4895.8 4974.8 4988.8 10:41:01 INFO - PROCESS | 15176 | 10:41:01 INFO - PROCESS | 15176 | [#1] ext.html Cycles:180 Average:36900.71 Median:18834.81 stddev:58821.33 (312.3%) stddev-sans-first:58923.02 10:41:01 INFO - PROCESS | 15176 | Values: 551.4 580.7 593.2 596.4 617.5 32546.7 33406.0 33663.5 33704.3 33759.3 33479.2 33819.8 34103.7 34122.8 34237.1 7421.4 7550.2 7563.5 7608.4 7624.6 7464.1 7774.7 7784.5 7792.1 7809.8 7745.8 7787.5 7791.1 7805.1 7808.8 7633.3 7667.0 7684.8 7721.7 7751.0 7666.6 7748.4 7762.9 7781.1 7785.5 28472.3 35166.0 35734.5 35842.5 35874.8 3032.5 3075.2 3197.2 3432.5 3596.9 26603.6 26812.2 26840.2 27540.9 28159.2 3459.6 3482.5 3523.3 3540.3 3628.8 182744.0 187586.0 189380.0 189849.0 190388.0 33815.3 34617.1 57027.4 57787.0 57930.7 33427.5 33544.7 33778.7 33790.2 33903.8 11862.7 12013.9 12095.6 12142.8 12167.4 9430.3 9455.1 9470.7 9492.1 9508.8 8316.7 8322.1 8344.7 8364.4 8422.2 3285.8 3331.0 3345.6 3368.9 3371.0 924.4 963.0 974.2 982.7 1005.1 27788.4 28545.6 29031.0 29158.9 29406.4 1023.2 1038.6 1074.4 1084.8 1129.4 14932.4 15232.6 15547.8 15635.0 15639.5 146094.0 148183.0 148576.0 148613.0 149312.0 49784.8 50212.0 50244.7 50424.5 50506.0 1204.9 1252.9 1253.0 1266.7 1329.5 26702.9 27497.7 27767.7 27811.6 28102.6 42389.2 42545.1 42815.0 42975.4 43060.6 302715.0 304673.0 305411.0 305903.0 307637.0 22121.9 22180.4 22193.2 22298.8 22423.0 41740.0 42322.3 42757.8 43012.8 43026.8 35560.5 35627.8 35682.3 36113.3 36176.3 34920.7 34939.0 35080.9 35210.5 35477.3 35556.3 35918.3 36021.6 36091.6 36689.6 31041.8 32534.7 32592.3 32781.7 32887.5 24465.5 24818.6 24974.8 25227.5 25268.2 10:41:01 INFO - PROCESS | 15176 | 10:41:01 INFO - PROCESS | 15176 | [#2] jquery.html Cycles:180 Average:19826.21 Median:26217.42 stddev:46339.61 (176.8%) stddev-sans-first:46446.59 10:41:01 INFO - PROCESS | 15176 | Values: 372.3 373.4 374.0 380.4 382.7 15074.8 15550.3 16225.8 16275.4 16311.0 15183.0 16648.5 16799.2 16822.7 16900.5 4774.1 4945.0 4980.7 4982.3 5032.7 4970.2 4998.3 5001.4 5007.4 5019.2 5111.6 5436.9 5462.3 5468.3 5473.9 5373.0 5402.3 5791.9 6182.9 6199.0 5470.5 5485.6 5505.7 5514.0 5514.5 18955.0 19793.9 20065.8 20224.7 20462.7 1936.6 2015.4 2036.1 2048.0 2140.4 9370.5 9457.5 9552.9 9785.1 10511.4 1693.7 1700.0 1711.1 1736.4 1823.9 50891.0 58882.0 59053.7 66177.7 70739.0 9526.0 9700.5 9953.1 10072.5 10082.8 14153.9 14259.2 14260.9 14287.9 14327.1 7000.4 7023.8 7081.7 7175.9 7244.7 6445.1 6445.1 6531.7 6561.5 6596.5 4403.7 4443.2 4453.3 4478.7 4556.7 1759.4 1799.5 1862.6 1889.2 1901.8 847.4 876.1 897.3 900.7 939.9 15631.4 16238.9 16368.2 16443.0 16609.1 892.5 903.0 913.3 942.7 944.9 9278.3 9410.8 9431.0 9519.2 9539.8 138644.0 140364.3 223669.9 378583.6 382182.0 72699.9 73075.6 74257.3 74578.0 74902.6 936.2 939.5 947.0 962.9 968.6 14680.9 14754.5 14800.9 14887.6 14944.7 29312.4 30169.7 32147.8 35794.5 36154.0 46874.5 47372.3 47438.0 47488.0 47660.8 7299.8 7605.7 7642.0 7715.0 7880.5 7318.5 7444.1 10610.2 10632.7 11207.8 9712.2 9924.2 10233.4 10280.9 10394.9 9924.4 10067.6 10286.9 10393.7 10414.7 10123.3 10249.2 10603.2 10603.3 10652.0 7791.9 7940.3 7948.5 7966.8 8060.8 9208.6 9834.0 10262.2 10366.3 10578.4 10:41:01 INFO - PROCESS | 15176 | 10:41:01 INFO - PROCESS | 15176 | [#3] mootools.html Cycles:180 Average:4966.05 Median:5241.69 stddev:2698.98 (51.5%) stddev-sans-first:2693.55 10:41:01 INFO - PROCESS | 15176 | Values: 1440.4 1475.2 1617.5 1753.6 1776.8 6651.7 7399.1 7433.0 7669.1 7688.2 7476.2 7477.3 7505.5 7545.9 7559.4 2211.4 2227.8 2232.4 2239.6 2259.6 2174.2 2217.2 2241.7 2244.8 2245.3 2187.3 2206.7 2208.1 2212.2 2249.9 2133.9 2140.8 2144.2 2151.8 2164.9 2162.5 2176.6 2177.3 2179.3 2182.8 7645.7 7662.9 7680.1 7689.3 7706.2 4341.8 4454.1 4485.5 4502.7 4511.2 2770.8 2832.2 2911.1 2919.0 2920.8 925.8 951.5 966.1 967.1 972.1 9942.4 9948.8 9962.8 9979.1 10008.4 4022.5 4034.0 4183.4 4194.1 4208.3 8539.8 8552.7 8561.1 8564.3 8584.6 4569.5 4584.8 4586.7 4602.9 4603.5 3601.8 4132.9 4165.9 4205.0 4216.4 3527.9 3543.3 3655.7 3672.2 3715.4 1173.5 1203.0 1210.8 1229.3 1238.2 789.4 801.9 888.8 893.2 896.9 5228.1 5422.5 5455.8 5455.8 5481.8 401.7 406.8 407.6 408.6 430.6 3545.3 3581.6 3653.2 3666.4 3696.9 8754.1 9081.0 9151.9 9183.2 9206.4 8882.8 8972.4 9081.0 9096.6 9098.5 6890.4 6926.3 6970.9 7034.3 7049.2 4982.5 5076.7 5136.1 5209.6 5255.3 8276.8 8313.5 8381.7 8396.7 8515.2 8024.8 8290.2 8382.6 8497.7 8510.7 6002.1 6452.0 6641.0 6671.0 6761.9 7146.1 7175.3 7177.2 7199.6 7235.9 6359.5 6554.0 6563.7 6591.3 6702.8 6544.3 6551.7 6607.6 6614.0 6677.1 6220.9 6263.7 6282.2 6284.2 6301.5 4108.3 4157.6 4235.0 4240.9 4305.8 4525.6 4570.1 4661.4 4677.4 4701.9 10:41:01 INFO - PROCESS | 15176 | 10:41:01 INFO - PROCESS | 15176 | [#4] prototype.html Cycles:180 Average:4598.24 Median:5271.72 stddev:1353.38 (25.7%) stddev-sans-first:1318.17 10:41:01 INFO - PROCESS | 15176 | Values: 300.4 308.3 310.6 311.1 314.5 5250.4 5284.6 5331.6 5339.4 5400.7 5184.3 5231.1 5246.8 5253.8 5285.1 3897.6 3968.8 4125.1 4140.4 4145.9 4122.9 4124.6 4125.3 4134.0 4148.6 4089.8 4113.4 4120.9 4127.4 4129.7 4041.8 4105.8 4141.1 4142.3 4150.6 3612.0 3639.8 3640.1 3643.7 3645.4 5047.8 5050.9 5061.2 5077.1 5111.6 4571.9 4739.0 4753.5 4768.5 4776.5 5539.1 5580.8 5618.3 5619.6 5622.5 3974.0 3978.6 3999.9 4009.3 4009.3 5625.2 5881.3 5894.7 5904.5 5923.1 3894.7 3921.0 3935.6 3945.2 3951.7 3997.0 4011.0 4019.5 4020.1 4024.6 4561.0 4609.1 4626.5 4640.5 4642.7 5531.1 5570.6 5628.5 5648.3 5657.4 1384.2 1408.5 1409.4 1411.5 1415.0 875.0 875.4 926.6 937.3 938.7 4716.0 4725.3 4773.3 4798.9 4821.1 5691.3 5700.9 5704.4 5732.1 5755.9 4633.8 4766.6 4805.0 4810.6 4835.6 3042.4 3066.6 3070.1 3080.5 3095.4 5277.9 5309.3 5315.2 5344.1 5355.4 5686.5 5828.2 5864.1 5866.7 5882.0 5271.9 5310.3 5312.3 5327.8 5343.4 5522.1 5662.2 5697.6 5716.3 5725.9 5558.6 5566.2 5579.2 5600.6 5615.2 5271.5 5285.6 5293.7 5293.9 5300.4 3710.8 3936.4 3939.9 3943.1 3959.4 5720.2 5760.4 5762.0 5780.9 5781.6 5601.3 5610.6 5615.5 5616.7 5622.2 5390.9 5588.8 5604.2 5668.7 5676.5 5299.1 5456.4 5513.5 5549.5 5573.5 5494.9 5680.0 5713.9 5731.9 5748.1 5548.1 5558.8 5573.1 5574.6 5581.4 10:41:01 INFO - PROCESS | 15176 | 10:41:01 INFO - PROCESS | 15176 | [#5] yui.html Cycles:180 Average:12070.67 Median:38735.42 stddev:12890.43 (33.3%) stddev-sans-first:12898.66 10:41:01 INFO - PROCESS | 15176 | Values: 770.5 787.6 787.9 789.9 795.8 11935.9 12266.0 12331.9 12337.0 12375.0 12936.8 12949.7 12987.0 13006.2 13029.3 629.1 798.4 802.5 803.6 804.5 769.2 793.3 795.6 798.4 800.1 834.4 836.3 840.4 840.4 841.8 831.3 833.2 834.4 835.4 837.0 614.0 614.3 615.8 622.5 623.6 12078.6 12108.9 12137.6 12144.1 12159.6 11941.5 12052.9 12143.0 12154.8 12347.9 9709.0 9716.6 9774.9 9847.3 10076.5 3306.1 3325.3 3346.9 3362.6 3399.1 42201.0 42948.1 45023.0 45064.0 45249.0 9791.6 9832.0 9865.6 10076.2 10109.0 16387.8 16498.5 16535.3 16556.3 17064.1 6743.2 6771.9 6780.4 6803.7 6840.4 3792.3 3819.7 3841.1 3852.8 3890.7 2824.8 2894.3 2897.2 2901.2 2927.9 513.9 514.9 519.9 521.6 521.7 610.6 640.4 643.7 644.6 653.4 7728.7 7807.3 8097.2 8103.9 8137.6 523.4 536.4 640.7 641.8 655.2 3668.9 3700.6 3726.8 3780.4 3792.1 42179.6 43343.8 43442.1 52372.5 53056.7 37558.8 38891.0 39261.4 39380.6 39540.2 31420.7 31781.7 35336.3 36709.0 41028.0 7903.2 8201.9 8399.2 8481.9 8611.5 26867.5 26867.7 26903.6 27594.7 28177.6 33652.7 36148.6 37808.6 38201.6 38579.8 10449.1 10541.3 10620.1 10657.4 10723.3 11591.7 11658.5 11753.4 11836.0 11881.6 11146.8 11307.9 11504.8 11523.7 12055.1 11577.5 11624.6 11811.6 11973.4 12324.4 10237.6 10489.7 10571.7 10908.7 11699.9 9368.4 9529.8 9536.7 9667.3 9714.9 9228.1 10136.2 10218.0 10254.9 10314.7 10:41:01 INFO - PROCESS | 15176 | -------- Summary: end -------- 10:41:01 INFO - PROCESS | 15176 | 10:41:02 INFO - TEST-INFO | 15176: exit 0 10:41:02 INFO - TEST-OK | dromaeo_css | took 1115749ms 10:41:02 INFO - TEST-START | kraken 10:41:02 INFO - operating with platform_type : linux_ 10:41:02 INFO - Initialising browser for kraken test... 10:41:02 INFO - TEST-INFO | started process 15409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLd_trH/profile http://localhost:51863/getInfo.html) 10:41:05 INFO - PROCESS | 15409 | 10:41:05 INFO - PROCESS | 15409 | (process:15477): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:41:06 INFO - PROCESS | 15409 | __metrics Screen width/height:1600/1200 10:41:06 INFO - PROCESS | 15409 | colorDepth:24 10:41:06 INFO - PROCESS | 15409 | Browser inner width/height: 1024/697 10:41:06 INFO - PROCESS | 15409 | __metrics 10:41:07 ERROR - PROCESS | 15409 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:41:08 INFO - TEST-INFO | 15409: exit 0 10:41:08 INFO - Browser initialized. 10:41:08 INFO - Running cycle 1/1 for kraken test... 10:41:08 INFO - TEST-INFO | started process 15528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLd_trH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:10 INFO - PROCESS | 15528 | 10:41:10 INFO - PROCESS | 15528 | (process:15589): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:41:20 INFO - PROCESS | 15528 | RSS: Main: 165236736 10:41:20 INFO - PROCESS | 15528 | 10:41:22 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51863/tests/kraken/driver.html?testName=audio-beat-detection) 10:41:23 INFO - PROCESS | 15528 | RSS: Main: 169799680 10:41:23 INFO - PROCESS | 15528 | 10:41:26 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51863/tests/kraken/driver.html?testName=audio-dft) 10:41:27 INFO - PROCESS | 15528 | RSS: Main: 173211648 10:41:27 INFO - PROCESS | 15528 | 10:41:30 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51863/tests/kraken/driver.html?testName=audio-fft) 10:41:30 INFO - PROCESS | 15528 | RSS: Main: 163160064 10:41:30 INFO - PROCESS | 15528 | 10:41:32 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51863/tests/kraken/driver.html?testName=audio-oscillator) 10:41:33 INFO - PROCESS | 15528 | RSS: Main: 163524608 10:41:33 INFO - PROCESS | 15528 | 10:41:35 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51863/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:41:36 INFO - PROCESS | 15528 | RSS: Main: 164605952 10:41:36 INFO - PROCESS | 15528 | 10:41:39 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51863/tests/kraken/driver.html?testName=imaging-darkroom) 10:41:40 INFO - PROCESS | 15528 | RSS: Main: 165249024 10:41:40 INFO - PROCESS | 15528 | 10:41:43 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51863/tests/kraken/driver.html?testName=imaging-desaturate) 10:41:44 INFO - PROCESS | 15528 | RSS: Main: 165040128 10:41:44 INFO - PROCESS | 15528 | 10:41:47 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51863/tests/kraken/driver.html?testName=json-parse-financial) 10:41:47 INFO - PROCESS | 15528 | RSS: Main: 165638144 10:41:47 INFO - PROCESS | 15528 | 10:41:49 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51863/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:41:50 INFO - PROCESS | 15528 | RSS: Main: 165720064 10:41:50 INFO - PROCESS | 15528 | 10:41:52 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51863/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:41:52 INFO - PROCESS | 15528 | RSS: Main: 165875712 10:41:52 INFO - PROCESS | 15528 | 10:41:54 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51863/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:41:55 INFO - PROCESS | 15528 | RSS: Main: 166121472 10:41:55 INFO - PROCESS | 15528 | 10:41:58 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:41:59 INFO - PROCESS | 15528 | RSS: Main: 166330368 10:41:59 INFO - PROCESS | 15528 | 10:42:02 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:42:02 INFO - PROCESS | 15528 | RSS: Main: 166289408 10:42:02 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | Cycle 1(1): loaded http://localhost:51863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51863/tests/kraken/driver.html?testName=ai-astar) 10:42:04 INFO - PROCESS | 15528 | RSS: Main: 167755776 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | __start_tp_report 10:42:04 INFO - PROCESS | 15528 | _x_x_mozilla_page_load 10:42:04 INFO - PROCESS | 15528 | _x_x_mozilla_page_load_details 10:42:04 INFO - PROCESS | 15528 | |i|pagename|runs| 10:42:04 INFO - PROCESS | 15528 | |0;ai-astar;112;108;114;116;115;126;116;113;113;114 10:42:04 INFO - PROCESS | 15528 | |1;audio-beat-detection;163;139;165;196;134;166;155;135;198;134 10:42:04 INFO - PROCESS | 15528 | |2;audio-dft;163;162;162;164;175;164;163;166;165;162 10:42:04 INFO - PROCESS | 15528 | |3;audio-fft;75;74;74;158;79;76;78;77;163;77 10:42:04 INFO - PROCESS | 15528 | |4;audio-oscillator;95;99;141;95;94;98;155;95;96;159 10:42:04 INFO - PROCESS | 15528 | |5;imaging-gaussian-blur;117;118;117;117;118;117;117;118;117;117 10:42:04 INFO - PROCESS | 15528 | |6;imaging-darkroom;147;148;147;149;148;149;148;149;148;148 10:42:04 INFO - PROCESS | 15528 | |7;imaging-desaturate;95;96;95;95;95;96;95;95;96;95 10:42:04 INFO - PROCESS | 15528 | |8;json-parse-financial;66;64;65;65;64;65;64;65;67;72 10:42:04 INFO - PROCESS | 15528 | |9;json-stringify-tinderbox;65;66;64;65;65;64;65;65;65;65 10:42:04 INFO - PROCESS | 15528 | |10;stanford-crypto-aes;79;79;78;79;79;88;82;81;107;80 10:42:04 INFO - PROCESS | 15528 | |11;stanford-crypto-ccm;147;141;148;148;139;138;144;136;147;136 10:42:04 INFO - PROCESS | 15528 | |12;stanford-crypto-pbkdf2;179;179;180;183;177;177;175;178;178;178 10:42:04 INFO - PROCESS | 15528 | |13;stanford-crypto-sha256-iterative;76;75;73;76;80;76;74;72;75;74 10:42:04 INFO - PROCESS | 15528 | __end_tp_report 10:42:04 INFO - PROCESS | 15528 | __start_cc_report 10:42:04 INFO - PROCESS | 15528 | _x_x_mozilla_cycle_collect,921 10:42:04 INFO - PROCESS | 15528 | __end_cc_report 10:42:04 INFO - PROCESS | 15528 | __startTimestamp1461260524825__endTimestamp 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | ------- Summary: start ------- 10:42:04 INFO - PROCESS | 15528 | Number of tests: 14 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.50 stddev:4.60 (4.0%) stddev-sans-first:4.77 10:42:04 INFO - PROCESS | 15528 | Values: 112.0 108.0 114.0 116.0 115.0 126.0 116.0 113.0 113.0 114.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#1] audio-beat-detection Cycles:10 Average:158.50 Median:164.00 stddev:24.11 (14.7%) stddev-sans-first:25.51 10:42:04 INFO - PROCESS | 15528 | Values: 163.0 139.0 165.0 196.0 134.0 166.0 155.0 135.0 198.0 134.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.89 (2.4%) stddev-sans-first:4.09 10:42:04 INFO - PROCESS | 15528 | Values: 163.0 162.0 162.0 164.0 175.0 164.0 163.0 166.0 165.0 162.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.50 stddev:35.58 (46.5%) stddev-sans-first:37.13 10:42:04 INFO - PROCESS | 15528 | Values: 75.0 74.0 74.0 158.0 79.0 76.0 78.0 77.0 163.0 77.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#4] audio-oscillator Cycles:10 Average:112.70 Median:95.00 stddev:27.30 (28.7%) stddev-sans-first:28.19 10:42:04 INFO - PROCESS | 15528 | Values: 95.0 99.0 141.0 95.0 94.0 98.0 155.0 95.0 96.0 159.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:42:04 INFO - PROCESS | 15528 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 10:42:04 INFO - PROCESS | 15528 | Values: 147.0 148.0 147.0 149.0 148.0 149.0 148.0 149.0 148.0 148.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:42:04 INFO - PROCESS | 15528 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.00 stddev:2.41 (3.7%) stddev-sans-first:2.55 10:42:04 INFO - PROCESS | 15528 | Values: 66.0 64.0 65.0 65.0 64.0 65.0 64.0 65.0 67.0 72.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 10:42:04 INFO - PROCESS | 15528 | Values: 65.0 66.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:79.50 stddev:8.84 (11.1%) stddev-sans-first:9.25 10:42:04 INFO - PROCESS | 15528 | Values: 79.0 79.0 78.0 79.0 79.0 88.0 82.0 81.0 107.0 80.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:145.50 stddev:4.97 (3.4%) stddev-sans-first:4.99 10:42:04 INFO - PROCESS | 15528 | Values: 147.0 141.0 148.0 148.0 139.0 138.0 144.0 136.0 147.0 136.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:178.50 stddev:2.12 (1.2%) stddev-sans-first:2.24 10:42:04 INFO - PROCESS | 15528 | Values: 179.0 179.0 180.0 183.0 177.0 177.0 175.0 178.0 178.0 178.0 10:42:04 INFO - PROCESS | 15528 | 10:42:04 INFO - PROCESS | 15528 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:75.50 stddev:2.18 (2.9%) stddev-sans-first:2.29 10:42:04 INFO - PROCESS | 15528 | Values: 76.0 75.0 73.0 76.0 80.0 76.0 74.0 72.0 75.0 74.0 10:42:04 INFO - PROCESS | 15528 | -------- Summary: end -------- 10:42:04 INFO - PROCESS | 15528 | 10:42:05 INFO - TEST-INFO | 15528: exit 0 10:42:05 INFO - TEST-OK | kraken | took 63801ms 10:42:05 INFO - SUITE-END | took 1179s 10:42:05 INFO - Completed test suite (00:19:39) 10:42:05 INFO - javascript benchmark 10:42:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.750363715447, 2680.490706765715, 2712.9186124416274, 2732.7540521353076, 2745.794065445091, 4620.122176786413, 4638.1419437404065, 4679.625629949604, 4685.2737825637, 4705.670603057779, 4576.1762882681105, 4696.50686677899, 4724.503927087658, 4774.212254977933, 4819.638527110464, 4351.543087975772, 4377.562243775629, 4455.064436468346, 4457.39825123609, 4489.910201795962, 4375.496817865938, 4441.4004109445295, 4459.487158976727, 4480.215962206617, 4492.0, 4250.681198910094, 4326.632236259922, 4368.868933931971, 4387.956120438818, 4430.867073987785, 4352.434183556117, 4382.824687012516, 4383.715058521186, 4407.052483715985, 4449.644028477714, 4283.31466965284, 4348.543402942677, 4355.237833379146, 4364.5635436456105, 4410.889727756799, 4669.626429885601, 4697.88255293617, 4719.811207551694, 4748.810047598126, 4767.785449654774, 4952.405711314629, 4974.552290293891, 4979.0788704089855, 4994.175960966436, 5055.721935293557, 4869.488703686097, 5018.64869459138, 5030.144875371196, 5058.620603454719, 5080.314157588715, 4593.471750748673, 4670.346151538787, 4674.579287864109, 4711.481737008926, 4720.551547602972, 5074.037905813453, 5087.033463641897, 5104.132297509433, 5121.718305493159, 5138.820141295037, 4817.518248175154, 4901.803927842846, 4906.362172917497, 4912.336834527365, 4937.8271760488215, 5020.171671674133, 5065.088284108896, 5083.466236045236, 5114.846554603368, 5163.8192663256605, 4858.46556878743, 4998.725070121105, 5028.220625802934, 5043.4956504349275, 5080.822171223989, 4835.975820120947, 5005.0, 5008.048470790538, 5019.974900125549, 5055.140626093573, 4218.346156345771, 4242.957570424318, 4244.681648876347, 4253.574642535722, 4254.170436764801, 3714.0900479382726, 3765.5104836371643, 3765.8870233893026, 3772.3775577029483, 3799.5820459749407, 4312.805923733439, 4379.386885835986, 4379.540148284448, 4405.889852753643, 4410.779461026936, 4925.581325587294, 5085.415177254589, 5097.439281679012, 5117.820876269313, 5118.641695081308, 4341.978290108529, 4369.4101296325225, 4370.038591509863, 4391.604755572014, 4411.602955733999, 4532.4334458192725, 4550.567696068868, 4561.840335588238, 4588.541145885385, 4607.562281583244, 4558.8860278491975, 4684.718916864999, 4717.669763116617, 4723.929141062887, 4742.834000809955, 5085.186370180902, 5090.592752579859, 5124.846254612367, 5137.5889928806355, 5188.7405629717605, 4754.0491901619125, 4759.928601071056, 4762.476127626028, 4804.903901922012, 4843.4430040545785, 4919.827806026772, 4985.52637499437, 5036.697798132123, 5049.015441988924, 5110.514501122388, 5096.133657278346, 5110.97444512775, 5136.460671629425, 5141.126008578625, 5150.48495150482, 4918.2622606607865, 4944.085344211332, 4954.455009948975, 4972.378452693413, 4975.378077740283, 4806.711597304173, 4824.179889418737, 4850.83022094225, 4943.752812359296, 4973.626977976739, 4803.879903002453, 4807.735574543433, 4831.444383895757, 4840.588549973291, 4863.708177509361, 4973.229149481836, 5011.949880501148, 5015.297858299914, 5015.724135172601, 5021.573166280907, 4756.025014872012, 4883.560479556857, 4895.8041678332465, 4974.825881094144, 4988.775505102351], "value": 4644.932706489896, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.4238723381812, 580.6516090345792, 593.2258402784367, 596.4274296675193, 617.5430181665569, 32546.67453325466, 33406.0, 33663.495047574244, 33704.32591348171, 33759.32481350374, 33479.16302092449, 33819.83090084546, 34103.65896341036, 34122.829385853096, 34237.14407139823, 7421.406287497, 7550.169481357047, 7563.470557061008, 7608.353289970331, 7624.580648064354, 7464.066991626047, 7774.689012439496, 7784.532928024337, 7792.10390805059, 7809.843803123934, 7745.7676269712, 7787.454878158531, 7791.104023037338, 7805.141434442206, 7808.804779880492, 7633.274838890296, 7666.961665191666, 7684.846303073908, 7721.652525636332, 7750.961245193795, 7666.578338191397, 7748.4188685848785, 7762.883556746653, 7781.066272047334, 7785.4939428937505, 28472.28819279514, 35166.0, 35734.463983040274, 35842.46236306457, 35874.820625896704, 3032.4844776388068, 3075.2311922019494, 3197.1847178969215, 3432.4806070322425, 3596.9100772480638, 26603.600945985825, 26812.195634131007, 26840.194794156207, 27540.862295688392, 28159.15522534327, 3459.636738142484, 3482.5298584690995, 3523.260115375774, 3540.2919416116624, 3628.818559072036, 182744.0, 187586.0, 189380.0, 189849.0, 190388.0, 33815.32369352599, 34617.134571635404, 57027.42972570304, 57787.0, 57930.710346447995, 33427.49858752072, 33544.66455335415, 33778.66221337755, 33790.155246119044, 33903.830480847435, 11862.703432414259, 12013.939930300292, 12095.576654817216, 12142.817857732141, 12167.391630418444, 9430.339876208736, 9455.101765332283, 9470.715878523655, 9492.050794920591, 9508.762280943032, 8316.6673333066, 8322.126176751353, 8344.707935222237, 8364.414490985573, 8422.199891010345, 3285.80285182885, 3330.9500357494658, 3345.5818022747158, 3368.9326213475592, 3371.0392538126516, 924.3991405586288, 962.9903700963041, 974.1865542272141, 982.6708052802248, 1005.0602686488157, 27788.444231115667, 28545.57181642277, 29031.0, 29158.854205728836, 29406.411871762873, 1023.22746326523, 1038.6053299746047, 1074.3500182389698, 1084.8318510630866, 1129.3506233915532, 14932.402703891723, 15232.619184520476, 15547.844521554865, 15635.0, 15639.530814075595, 146094.0, 148183.0, 148576.0, 148613.0, 149312.0, 49784.751076244385, 50212.0, 50244.74877625588, 50424.49575504271, 50506.0, 1204.9396531052619, 1252.931088790107, 1252.956146534867, 1266.6769973656658, 1329.547953695748, 26702.866485667448, 27497.725022749517, 27767.722322776513, 27811.582826258025, 28102.578461322686, 42389.15221695611, 42545.149097018504, 42815.0, 42975.355369668854, 43060.569394305654, 302715.0, 304673.0, 305411.0, 305903.0, 307637.0, 22121.889390552944, 22180.445488862908, 22193.22323718662, 22298.77701222967, 22422.990965406923, 41740.0, 42322.29734787081, 42757.78621106874, 43012.78493607512, 43026.78486607547, 35560.46659300164, 35627.82186089053, 35682.28635427225, 36113.27773444464, 36176.27647447089, 34920.65079349174, 34939.0, 35080.94757157289, 35210.47184292289, 35477.29045419129, 35556.28887422186, 35918.28163436769, 36021.63978360183, 36091.63908360988, 36689.61517501354, 31041.844790776806, 32534.674653253165, 32592.34815303633, 32781.67218327882, 32887.506687400186, 24465.510689785748, 24818.627720584565, 24974.750252497244, 25227.49545009126, 25268.241952741446], "value": 15656.77970836401, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.2573465935457, 373.3727338072039, 373.9682127019204, 380.40656575741826, 382.711053154868, 15074.773878391832, 15550.300236489356, 16225.83774162258, 16275.430359937374, 16311.0, 15183.0, 16648.50054498364, 16799.16004199791, 16822.663546729058, 16900.492985210432, 4774.0690565339855, 4945.0, 4980.651354405193, 4982.277569752384, 5032.672876263049, 4970.155073637472, 4998.250262460624, 5001.3998320201445, 5007.4491805901325, 5019.171836646967, 5111.6166287528395, 5436.945630543703, 5462.262594549745, 5468.28912241408, 5473.890522189554, 5373.0, 5402.270693456392, 5791.855203619901, 6182.907256391158, 6198.969005154991, 5470.507654311131, 5485.61600687952, 5505.724713764336, 5514.0, 5514.503694667499, 18955.0, 19793.9010304949, 20065.796052236914, 20224.69662955057, 20462.693059604117, 1936.5836345185712, 2015.4256037029377, 2036.0634108310196, 2048.047657839112, 2140.3578926322043, 9370.531473426301, 9457.527123643791, 9552.856707149398, 9785.07041831025, 10511.421871797049, 1693.6612677464434, 1699.9980140210032, 1711.084569755175, 1736.444337811888, 1823.9270429182816, 50891.0, 58882.0, 59053.7047314765, 66177.66911165461, 70739.0, 9525.951695457527, 9700.514974251259, 9953.054459826304, 10072.546735396925, 10082.798344033079, 14153.929230353782, 14259.21574313402, 14260.85739142616, 14287.928560357132, 14327.06874053204, 7000.404965577983, 7023.754168604074, 7081.681324340417, 7175.8564828704175, 7244.746433874789, 6445.065465507569, 6445.097686323918, 6531.706073226716, 6561.475081993429, 6596.472282217411, 4403.669724770655, 4443.155800397914, 4453.287474004143, 4478.708883922534, 4556.72659640416, 1759.4281858396073, 1799.4511673939573, 1862.6460972415198, 1889.23485988175, 1901.7622797150357, 847.3941132090462, 876.1151237250423, 897.3494216692845, 900.7432881628704, 939.9389039712534, 15631.3747450103, 16238.918805406134, 16368.181590920407, 16443.0, 16609.086500242604, 892.4823602310644, 902.9593668284942, 913.255696607263, 942.6983365323168, 944.8991924407987, 9278.257739380833, 9410.764730881783, 9430.95284523573, 9519.23846092311, 9539.80416560446, 138644.0, 140364.2981785105, 223669.88165059072, 378583.6062295284, 382182.0, 72699.90950135647, 73075.63462182762, 74257.25742742611, 74578.0, 74902.62548687222, 936.194872409727, 939.4832841937044, 946.9857952130724, 962.9133377995873, 968.6319198704447, 14680.926595366955, 14754.48359307419, 14800.925995369955, 14887.627809304853, 14944.701105977601, 29312.41375172442, 30169.69830301669, 32147.839260803546, 35794.463083053255, 36154.0, 46874.53125468702, 47372.289415659485, 47438.0, 47488.0, 47660.76169619268, 7299.817504562216, 7605.733799317219, 7641.961790191013, 7714.961425192838, 7880.527168369917, 7318.487705860539, 7444.106707195171, 10610.204234682275, 10632.681019569425, 11207.831882521605, 9712.223022158068, 9924.206063515046, 10233.385996840214, 10280.948595256976, 10394.948025259826, 9924.354916930377, 10067.647632332833, 10286.948565257426, 10393.740156495845, 10414.687559373231, 10123.341982771097, 10249.180065594586, 10603.204759642904, 10603.310784798963, 10652.0, 7791.92208077912, 7940.325072368913, 7948.483348582324, 7966.760997170094, 8060.758177254692, 9208.631654733736, 9834.0, 10262.230332725225, 10366.274360794672, 10578.41818699948], "value": 7982.264526493027, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.38063632638, 1475.1665309100358, 1617.5228307649243, 1753.587906841891, 1776.760137381454, 6651.73393064278, 7399.112106547215, 7432.96283518583, 7669.079710434748, 7688.192739762321, 7476.1776204617445, 7477.25227477252, 7505.512141710785, 7545.943567900498, 7559.433042521805, 2211.436083798629, 2227.766084561122, 2232.441889527618, 2239.585676649817, 2259.604569200383, 2174.184680744721, 2217.1796435318956, 2241.674957131215, 2244.8316376271764, 2245.315178870444, 2187.3437968609433, 2206.6689996500495, 2208.1277895231374, 2212.1814928476488, 2249.910003599854, 2133.9253126140666, 2140.7966243206947, 2144.1959265275523, 2151.8493705440624, 2164.8701077935375, 2162.4593851537115, 2176.6190916589535, 2177.3250292409243, 2179.259051922338, 2182.8035476807163, 7645.694172233104, 7662.9233707663325, 7680.11678656956, 7689.346405555534, 7706.152323244439, 4341.782910854445, 4454.109178164348, 4485.461744590637, 4502.684812063157, 4511.210538155809, 2770.7644850187758, 2832.2494538947194, 2911.1121108062034, 2919.022127587261, 2920.751736102434, 925.759302581327, 951.5242378810594, 966.1401352796017, 967.0957654592978, 972.0910948263396, 9942.353747006493, 9948.80102397948, 9962.750931226778, 9979.051990060932, 10008.39949603026, 4022.4770779799023, 4033.9596604034173, 4183.435236243129, 4194.077302993398, 4208.305629571148, 8539.82920341602, 8552.657893684307, 8561.101084386175, 8564.272036876811, 8584.613692383859, 4569.474510431343, 4584.839530616412, 4586.656000799953, 4602.930956035662, 4603.516630753789, 3601.819909004539, 4132.91734165315, 4165.854195103157, 4205.032842446193, 4216.409702641633, 3527.9294414111573, 3543.344481270973, 3655.707543396522, 3672.210474747942, 3715.3869611513796, 1173.5188572685158, 1202.9699257518632, 1210.7820592293472, 1229.305442425027, 1238.219921449481, 789.403999980023, 801.8797180422984, 888.7778055486128, 893.1604291965532, 896.9368759519258, 5228.111221092423, 5422.539084177889, 5455.781768729206, 5455.781768729285, 5481.780728770885, 401.70073295394536, 406.7986346758374, 407.63109386005715, 408.55059434621677, 430.5930895303908, 3545.2554963457965, 3581.6239294874185, 3653.1962968146963, 3666.395044817629, 3696.8890933272046, 8754.080821513777, 9080.954595227115, 9151.862722059175, 9183.173514383738, 9206.355555111211, 8882.777930551789, 8972.37193396469, 9080.954595226982, 9096.636134554676, 9098.499582523025, 6890.414314783299, 6926.307369263134, 6970.895436568456, 7034.331738484836, 7049.154101507749, 4982.4768399317545, 5076.695398276115, 5136.075506408883, 5209.583233341399, 5255.264263003259, 8276.751697449086, 8313.501189928624, 8381.664733410595, 8396.748097557083, 8515.19105684959, 8024.759257222293, 8290.212429819157, 8382.580870956306, 8497.702580409656, 8510.74467765968, 6002.069679199731, 6452.0, 6640.966795165993, 6671.0, 6761.898571521333, 7146.071010768567, 7175.282471752783, 7177.1746249182015, 7199.640017998974, 7235.927640723736, 6359.49124070064, 6554.049662798963, 6563.737450501926, 6591.307912669101, 6702.798916032331, 6544.28012918569, 6551.737930482918, 6607.57050791697, 6613.966930165318, 6677.09859169006, 6220.937790622036, 6263.718132683949, 6282.183316168869, 6284.183056202664, 6301.495880329654, 4108.2810508160355, 4157.584241575818, 4235.0, 4240.851570195028, 4305.82776688929, 4525.63794896414, 4570.108828778356, 4661.3940187776725, 4677.368555244999, 4701.929471057869], "value": 3990.9036293953613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.4411794063043, 308.28631717573813, 310.6210423283594, 311.1164293406724, 314.4795363673119, 5250.448702886194, 5284.603654725896, 5331.600129990247, 5339.398180545831, 5400.70296133713, 5184.326037615114, 5231.058409486291, 5246.7901283948695, 5253.789848406059, 5285.127953887613, 3897.57126716061, 3968.821403036856, 4125.113100683352, 4140.378943158536, 4145.896352591194, 4122.855700050499, 4124.649404800581, 4125.2780763366445, 4133.979330103345, 4148.6266236038755, 4089.7750623715683, 4113.362428823537, 4120.876373708794, 4127.380892866064, 4129.690273229505, 4041.7979101044975, 4105.815238314283, 4141.095096255726, 4142.2543942090415, 4150.584941505856, 3611.9638803611892, 3639.763415377992, 3640.12636967126, 3643.744937854351, 3645.434957581579, 5047.772850221749, 5050.873728156826, 5061.240813877911, 5077.111505486562, 5111.565516931066, 4571.908561828778, 4738.976305118453, 4753.500882407367, 4768.47546769855, 4776.47458779534, 5539.14143307788, 5580.804671836466, 5618.297712785902, 5619.6066275360745, 5622.526088521078, 3973.9931334676094, 3978.562358140602, 3999.900002499961, 4009.298372784751, 4009.3384591542363, 5625.156226566048, 5881.264841894763, 5894.705264736789, 5904.498117660004, 5923.141144534018, 3894.6884249260556, 3921.0, 3935.6457918787446, 3945.2109578084496, 3951.7431366961055, 3997.040710229524, 4011.0373510357886, 4019.4975628046495, 4020.0753826619457, 4024.6176613221696, 4561.0, 4609.124266389443, 4626.537346265414, 4640.489546149921, 4642.698224615457, 5531.1426728857095, 5570.610057296031, 5628.465295796893, 5648.322201335784, 5657.405972372924, 1384.1694983010314, 1408.4647833823287, 1409.3728290910447, 1411.5200831717061, 1414.978775318371, 875.0, 875.365360113925, 926.5830376330678, 937.3391758810022, 938.6808485115093, 4715.962488252648, 4725.314829349725, 4773.331733557305, 4798.928685641193, 4821.108095002436, 5691.317041954909, 5700.914486282709, 5704.4295570443455, 5732.082866741302, 5755.913661295084, 4633.837815676503, 4766.642501812378, 4805.014971930746, 4810.63920205986, 4835.6131509479865, 3042.361104168105, 3066.5553494743585, 3070.1250143708935, 3080.5047911192005, 3095.4273459410083, 5277.9472205278225, 5309.309789727388, 5315.176147697113, 5344.091504444254, 5355.357357117171, 5686.516646085129, 5828.213191219216, 5864.120381942743, 5866.677332746654, 5882.02946513829, 5271.920921186185, 5310.309659744285, 5312.282841816305, 5327.786888524415, 5343.412224655207, 5522.116461366162, 5662.235598194191, 5697.601167918206, 5716.28546431696, 5725.914111288251, 5558.583106267127, 5566.246632310809, 5579.163125531203, 5600.635958662674, 5615.213870058114, 5271.525562699376, 5285.550728188147, 5293.655912365838, 5293.867653308698, 5300.363956325112, 3710.8144592769713, 3936.4488971543433, 3939.9015024624614, 3943.132510847609, 3959.4258832468554, 5720.199172115824, 5760.395158508296, 5761.971190144022, 5780.855478613068, 5781.5663825214115, 5601.29983752031, 5610.607257491936, 5615.522680572197, 5616.7191640416995, 5622.212890195294, 5390.919136212881, 5588.804391846428, 5604.243427137284, 5668.7165641718575, 5676.480582039162, 5299.099153143898, 5456.372517160577, 5513.5037846594, 5549.472800083986, 5573.470520300565, 5494.917576236279, 5679.971600141973, 5713.857153571194, 5731.942680573141, 5748.137779333133, 5548.0845660465575, 5558.833235002957, 5573.108302671553, 5574.554035677217, 5581.358143813513], "value": 4161.000187332259, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.4645271536283, 787.5510958753509, 787.933025692816, 789.9486533375326, 795.7612716185143, 11935.940320298398, 12266.037434010537, 12331.876681233196, 12336.999999999989, 12375.0, 12936.805947910789, 12949.676258093552, 12987.0, 13006.219626822374, 13029.348532573356, 629.1223742878705, 798.3732769775742, 802.5104686141449, 803.6022169026311, 804.5293503300576, 769.165455480804, 793.3217099380033, 795.5862951265367, 798.393221151923, 800.1118758178446, 834.4492634860993, 836.3392919593545, 840.4075127035426, 840.4369072721261, 841.7895526118471, 831.2560258568577, 833.1876420490034, 834.3867257565685, 835.381817455085, 837.0374069819756, 613.9723712432951, 614.3457218062749, 615.8183335915916, 622.5019984012772, 623.6382897919241, 12078.6376408707, 12108.939455302756, 12137.635870923887, 12144.149909506337, 12159.574414895436, 11941.522339106425, 12052.939735301356, 12143.0, 12154.756904861853, 12347.876521234763, 9708.998389950106, 9716.562754675986, 9774.853377199348, 9847.310688251826, 10076.496175191285, 3306.057773534555, 3325.334933013383, 3346.916327091818, 3362.6132994705677, 3399.133221028622, 42201.0, 42948.141037179084, 45023.0, 45064.0, 45249.0, 9791.608335666637, 9832.0, 9865.605375784888, 10076.193904487624, 10109.0, 16387.83612163887, 16498.505044848673, 16535.338586456648, 16556.337746490004, 17064.146792660318, 6743.224529179109, 6771.932280677229, 6780.355866192704, 6803.727850886008, 6840.41856442208, 3792.2984247914223, 3819.694424446038, 3841.078141246081, 3852.8266228019806, 3890.708196885245, 2824.7740180785486, 2894.3198348388114, 2897.2322334581354, 2901.2166714987256, 2927.9121626351243, 513.9152039913447, 514.9253358263031, 519.8986197691414, 521.5644936478008, 521.6661336744487, 610.5725991805665, 640.4364159539668, 643.7038962077403, 644.6003477843767, 653.4086651580327, 7728.729494467667, 7807.258310460497, 8097.190280971856, 8103.878441823377, 8137.633806478722, 523.4190049045557, 536.4153073150285, 640.7437025189961, 641.7581978870807, 655.2235600812957, 3668.8899333020054, 3700.6114357992024, 3726.7763934164036, 3780.432935059708, 3792.0898984244136, 42179.57820421756, 43343.78328108339, 43442.131157377305, 52372.47627523676, 53056.734716326944, 37558.8122059388, 38891.02772430712, 39261.411078833844, 39380.60619393826, 39540.20919581592, 31420.685793141776, 31781.682183178335, 35336.293274134885, 36709.0, 41028.0, 7903.170167132598, 8201.876971845308, 8399.244068033906, 8481.87277190855, 8611.48331100136, 26867.462650746485, 26867.731322687305, 26903.596446052932, 27594.724052759215, 28177.57733633956, 33652.663473364955, 36148.63851361558, 37808.62191378051, 38201.61798381981, 38579.80710096544, 10449.111825494918, 10541.31481453703, 10620.09729173029, 10657.41384223844, 10723.284274516353, 11591.6522504325, 11658.53365865356, 11753.353565553976, 11836.0, 11881.5841445549, 11146.777064458827, 11307.943460282646, 11504.82742758876, 11523.711907202387, 12055.095867810125, 11577.536898523964, 11624.593139240085, 11811.586594469496, 11973.401329933295, 12324.383780811102, 10237.641682541076, 10489.737756556147, 10571.735706607396, 10908.672739817817, 11699.88300117022, 9368.4378937264, 9529.761755956157, 9536.713898583053, 9667.323287369816, 9714.854277185706, 9228.146094863914, 10136.239782016231, 10218.0, 10254.948725256327, 10314.690559283234], "value": 5877.731928174436, "unit": "score"}], "name": "dromaeo_css", "value": 6197.570841456756, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 114.0, 116.0, 115.0, 126.0, 116.0, 113.0, 113.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 139.0, 165.0, 196.0, 134.0, 166.0, 155.0, 135.0, 198.0, 134.0], "value": 158.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 164.0, 175.0, 164.0, 163.0, 166.0, 165.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 158.0, 79.0, 76.0, 78.0, 77.0, 163.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 141.0, 95.0, 94.0, 98.0, 155.0, 95.0, 96.0, 159.0], "value": 112.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 148.0, 149.0, 148.0, 149.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 67.0, 72.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 79.0, 88.0, 82.0, 81.0, 107.0, 80.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 141.0, 148.0, 148.0, 139.0, 138.0, 144.0, 136.0, 147.0, 136.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 180.0, 183.0, 177.0, 177.0, 175.0, 178.0, 178.0, 178.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 73.0, 76.0, 80.0, 76.0, 74.0, 72.0, 75.0, 74.0], "value": 75.1, "unit": "score"}], "name": "kraken", "value": 1614.0000000000002, "alertThreshold": 2.0}]} 10:42:06 INFO - Return code: 0 10:42:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:42:06 ERROR - # TBPL SUCCESS # 10:42:06 INFO - Running post-action listener: _resource_record_post_action 10:42:06 INFO - Running post-run listener: _resource_record_post_run 10:42:07 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518610944; Read time: 16; Write time: 578652 10:42:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234352640; Read time: 0; Write time: 289988 10:42:07 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284258304; Read time: 16; Write time: 288664 10:42:07 INFO - Running post-run listener: _upload_blobber_files 10:42:07 INFO - Blob upload gear active. 10:42:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:42:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:42:07 INFO - (blobuploader) - INFO - Open directory for files ... 10:42:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:42:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:42:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:08 INFO - (blobuploader) - INFO - Done attempting. 10:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:42:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:09 INFO - (blobuploader) - INFO - Done attempting. 10:42:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:42:09 INFO - Return code: 0 10:42:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:42:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:42:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/150cede4789838d81ee7386bdcb995c440eb7ab1f17a719469243fe38fea614943b1c771317eddd1b9444ac7c2b62fb0ed5c1671cfc118f063675fef1dfb95d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bef33a7efd61c2e29aa0649ade7ef49b28f32c6d8c25cdddfb7c84046567d872ca491c25f92c727580610796d1760c31c02804f974cece11c511424dc37aceaf"} 10:42:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:42:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:42:09 INFO - Contents: 10:42:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/150cede4789838d81ee7386bdcb995c440eb7ab1f17a719469243fe38fea614943b1c771317eddd1b9444ac7c2b62fb0ed5c1671cfc118f063675fef1dfb95d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bef33a7efd61c2e29aa0649ade7ef49b28f32c6d8c25cdddfb7c84046567d872ca491c25f92c727580610796d1760c31c02804f974cece11c511424dc37aceaf"} 10:42:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:42:09 INFO - Copying logs to upload dir... 10:42:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:42:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.355075 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-21 10:42:09.930986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 10:42:09.934327) ========= 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=20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074 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/Fx-Team-Non-PGO/sha512/150cede4789838d81ee7386bdcb995c440eb7ab1f17a719469243fe38fea614943b1c771317eddd1b9444ac7c2b62fb0ed5c1671cfc118f063675fef1dfb95d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bef33a7efd61c2e29aa0649ade7ef49b28f32c6d8c25cdddfb7c84046567d872ca491c25f92c727580610796d1760c31c02804f974cece11c511424dc37aceaf"} build_url:https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/bnopoyCeSMmMUl0c5g9tTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/150cede4789838d81ee7386bdcb995c440eb7ab1f17a719469243fe38fea614943b1c771317eddd1b9444ac7c2b62fb0ed5c1671cfc118f063675fef1dfb95d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bef33a7efd61c2e29aa0649ade7ef49b28f32c6d8c25cdddfb7c84046567d872ca491c25f92c727580610796d1760c31c02804f974cece11c511424dc37aceaf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 10:42:09.958603) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:42:09.958916) ========= 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=20e666a3d4cfbb71505a330e000001b4-1461258711.496514-1567137074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:42:10.041015) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 10:42:10.041325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 10:42:10.041619) ========= ========= Total master_lag: 0.17 =========