builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1461942434.04 results: success (0) buildid: 20160429053011 builduid: 46eeb6e489be4ea2b9e626e8473b2090 revision: f98e3add979e3b2eba6461fdaed2cfc80961ff6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.039817) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.040203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.040708) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.059147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.059415) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 08:07:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2016-04-29 08:07:14 (18.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.170034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.170357) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015340 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.223612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.223929) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f98e3add979e3b2eba6461fdaed2cfc80961ff6f --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 f98e3add979e3b2eba6461fdaed2cfc80961ff6f --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=6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 08:07:14,680 truncating revision to first 12 chars 2016-04-29 08:07:14,680 Setting DEBUG logging. 2016-04-29 08:07:14,680 attempt 1/10 2016-04-29 08:07:14,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f98e3add979e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 08:07:14,938 unpacking tar archive at: fx-team-f98e3add979e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542243 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.778401) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.778718) ========= script_repo_revision: f98e3add979e3b2eba6461fdaed2cfc80961ff6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.779111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.779392) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 08:07:14.790123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-29 08:07:14.790401) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:15 INFO - MultiFileLogger online at 20160429 08:07:15 in /builds/slave/test 08:07:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:07:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:07:15 INFO - {'append_to_log': False, 08:07:15 INFO - 'base_work_dir': '/builds/slave/test', 08:07:15 INFO - 'blob_upload_branch': 'Fx-Team', 08:07:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:07:15 INFO - 'branch': 'Fx-Team', 08:07:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:15 INFO - 'config_files': ('talos/linux_config.py',), 08:07:15 INFO - 'default_actions': ('clobber', 08:07:15 INFO - 'read-buildbot-config', 08:07:15 INFO - 'download-and-extract', 08:07:15 INFO - 'populate-webroot', 08:07:15 INFO - 'create-virtualenv', 08:07:15 INFO - 'install', 08:07:15 INFO - 'run-tests'), 08:07:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:15 INFO - 'download_minidump_stackwalk': True, 08:07:15 INFO - 'download_symbols': 'ondemand', 08:07:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:15 INFO - 'installer_path': 'installer.exe', 08:07:15 INFO - 'log_level': 'info', 08:07:15 INFO - 'log_name': 'talos', 08:07:15 INFO - 'log_to_console': True, 08:07:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:15 INFO - 'opt_config_files': (), 08:07:15 INFO - 'pip_index': False, 08:07:15 INFO - 'sps_profile': False, 08:07:15 INFO - 'sps_profile_interval': 0, 08:07:15 INFO - 'suite': 'dromaeojs-e10s', 08:07:15 INFO - 'system_bits': '32', 08:07:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:15 INFO - 'title': 'talos-linux64-ix-023', 08:07:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:15 INFO - 'use_talos_json': True, 08:07:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:07:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:15 INFO - 'work_dir': 'build'} 08:07:15 INFO - ##### 08:07:15 INFO - ##### Running clobber step. 08:07:15 INFO - ##### 08:07:15 INFO - Running pre-action listener: _resource_record_pre_action 08:07:15 INFO - Running main action method: clobber 08:07:15 INFO - rmtree: /builds/slave/test/build 08:07:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:07:16 INFO - Running post-action listener: _resource_record_post_action 08:07:16 INFO - ##### 08:07:16 INFO - ##### Running read-buildbot-config step. 08:07:16 INFO - ##### 08:07:16 INFO - Running pre-action listener: _resource_record_pre_action 08:07:16 INFO - Running main action method: read_buildbot_config 08:07:16 INFO - Using buildbot properties: 08:07:16 INFO - { 08:07:16 INFO - "project": "", 08:07:16 INFO - "product": "firefox", 08:07:16 INFO - "script_repo_revision": "production", 08:07:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:07:16 INFO - "repository": "", 08:07:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:07:16 INFO - "buildid": "20160429053011", 08:07:16 INFO - "pgo_build": "True", 08:07:16 INFO - "basedir": "/builds/slave/test", 08:07:16 INFO - "buildnumber": 301, 08:07:16 INFO - "slavename": "talos-linux64-ix-023", 08:07:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:07:16 INFO - "platform": "ubuntu64_hw", 08:07:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:07:16 INFO - "branch": "fx-team", 08:07:16 INFO - "repo_path": "integration/fx-team", 08:07:16 INFO - "revision": "f98e3add979e3b2eba6461fdaed2cfc80961ff6f", 08:07:16 INFO - "stage_platform": "linux64-pgo", 08:07:16 INFO - "builduid": "46eeb6e489be4ea2b9e626e8473b2090", 08:07:16 INFO - "slavebuilddir": "test" 08:07:16 INFO - } 08:07:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:07:16 INFO - Running post-action listener: _resource_record_post_action 08:07:16 INFO - ##### 08:07:16 INFO - ##### Running download-and-extract step. 08:07:16 INFO - ##### 08:07:16 INFO - Running pre-action listener: _resource_record_pre_action 08:07:16 INFO - Running main action method: download_and_extract 08:07:16 INFO - mkdir: /builds/slave/test/build/tests 08:07:16 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')]} 08:07:16 INFO - https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:07:26 INFO - Downloaded 1361 bytes. 08:07:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:07:26 INFO - Using the following test package requirements: 08:07:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:07:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:26 INFO - u'jsshell-linux-x86_64.zip'], 08:07:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:26 INFO - https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:36 INFO - Downloaded 23873634 bytes. 08:07:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:07:37 INFO - Return code: 0 08:07:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:07: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')]} 08:07:37 INFO - https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:39 INFO - Downloaded 23873634 bytes. 08:07:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:07:40 INFO - Return code: 0 08:07:40 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')]} 08:07:40 INFO - https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:07:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:07:41 INFO - Downloaded 10840145 bytes. 08:07:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:07:41 INFO - Return code: 0 08:07: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')]} 08:07:41 INFO - https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:07:43 INFO - Downloaded 58404206 bytes. 08:07:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:07:43 INFO - mkdir: /builds/slave/test/properties 08:07:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:07:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:07:43 INFO - Contents: 08:07:43 INFO - build_url:https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:07:43 INFO - Running post-action listener: _resource_record_post_action 08:07:43 INFO - Running post-action listener: set_extra_try_arguments 08:07:43 INFO - ##### 08:07:43 INFO - ##### Running populate-webroot step. 08:07:43 INFO - ##### 08:07:43 INFO - Running pre-action listener: _resource_record_pre_action 08:07:43 INFO - Running main action method: populate_webroot 08:07:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:43 INFO - '--tppagecycles', 08:07:43 INFO - '7'], 08:07:43 INFO - 'tests': ['tsvgm']}}, 08:07:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:07:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:07:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:07:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:07:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:07:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:43 INFO - 'talos_options': ['--disable-e10s'], 08:07:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:43 INFO - 'talos_options': ['--disable-e10s'], 08:07:43 INFO - 'tests': ['damp', 'tps']}, 08:07:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:43 INFO - 'tests': ['damp', 'tps']}, 08:07:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:07:43 INFO - 'tests': ['dromaeo_dom']}, 08:07:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:07:43 INFO - 'tests': ['a11yr', 08:07:43 INFO - 'ts_paint', 08:07:43 INFO - 'tpaint', 08:07:43 INFO - 'sessionrestore', 08:07:43 INFO - 'sessionrestore_no_auto_restore', 08:07:43 INFO - 'tabpaint']}, 08:07:43 INFO - 'other-e10s': {'tests': ['a11yr', 08:07:43 INFO - 'ts_paint', 08:07:43 INFO - 'tpaint', 08:07:43 INFO - 'sessionrestore', 08:07:43 INFO - 'sessionrestore_no_auto_restore', 08:07:43 INFO - 'tabpaint']}, 08:07:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:07:43 INFO - 'ts_paint', 08:07:43 INFO - 'tpaint', 08:07:43 INFO - 'sessionrestore', 08:07:43 INFO - 'sessionrestore_no_auto_restore', 08:07:43 INFO - 'tabpaint']}, 08:07:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:07:43 INFO - 'ts_paint', 08:07:43 INFO - 'tpaint', 08:07:43 INFO - 'sessionrestore', 08:07:43 INFO - 'sessionrestore_no_auto_restore', 08:07:43 INFO - 'tabpaint']}, 08:07:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:07:43 INFO - 'tests': ['a11yr', 08:07:43 INFO - 'ts_paint', 08:07:43 INFO - 'tpaint', 08:07:43 INFO - 'sessionrestore', 08:07:43 INFO - 'sessionrestore_no_auto_restore', 08:07:43 INFO - 'tabpaint']}, 08:07:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:07:43 INFO - 'tests': ['a11yr', 08:07:43 INFO - 'ts_paint', 08:07:43 INFO - 'tpaint', 08:07:43 INFO - 'sessionrestore', 08:07:43 INFO - 'sessionrestore_no_auto_restore', 08:07:43 INFO - 'tabpaint']}, 08:07:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:07:43 INFO - 'tests': ['tsvgx', 08:07:43 INFO - 'tsvgr_opacity', 08:07:43 INFO - 'tart', 08:07:43 INFO - 'tscrollx', 08:07:43 INFO - 'cart']}, 08:07:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:07:43 INFO - 'tsvgr_opacity', 08:07:43 INFO - 'tart', 08:07:43 INFO - 'tscrollx', 08:07:43 INFO - 'cart']}, 08:07:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:43 INFO - 'talos_options': ['--disable-e10s'], 08:07:43 INFO - 'tests': ['tp5o']}, 08:07:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:43 INFO - 'tests': ['tp5o']}, 08:07:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:43 INFO - 'talos_options': ['--disable-e10s', 08:07:43 INFO - '--xperf_path', 08:07:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:43 INFO - 'tests': ['tp5n']}, 08:07:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:43 INFO - 'talos_options': ['--xperf_path', 08:07:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:43 INFO - 'tests': ['tp5n']}}, 08:07:43 INFO - 'talos.zip': {'path': '', 08:07:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:43 INFO - Running post-action listener: _resource_record_post_action 08:07:43 INFO - ##### 08:07:43 INFO - ##### Running create-virtualenv step. 08:07:43 INFO - ##### 08:07:43 INFO - Running pre-action listener: _resource_record_pre_action 08:07:43 INFO - Running main action method: create_virtualenv 08:07:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:07:43 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 08:07:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:07:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:44 INFO - Using real prefix '/usr' 08:07:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:07:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:46 INFO - Installing pip.................done. 08:07:46 INFO - Return code: 0 08:07:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff27b7b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471410>, '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 0x1472310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14727a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', '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 08:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:07:46 INFO - Using env: {'DISPLAY': ':0', 08:07:46 INFO - 'HOME': '/home/cltbld', 08:07:46 INFO - 'LANG': 'en_US.UTF-8', 08:07:46 INFO - 'LANGUAGE': 'en_US:en', 08:07:46 INFO - 'LOGNAME': 'cltbld', 08:07:46 INFO - 'MAIL': '/var/mail/cltbld', 08:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:46 INFO - 'MOZ_NO_REMOTE': '1', 08:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:46 INFO - 'NO_EM_RESTART': '1', 08:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:46 INFO - 'PWD': '/builds/slave/test', 08:07:46 INFO - 'SHELL': '/bin/bash', 08:07:46 INFO - 'SHLVL': '1', 08:07:46 INFO - 'TERM': 'linux', 08:07:46 INFO - 'TMOUT': '86400', 08:07:46 INFO - 'USER': 'cltbld', 08:07:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', 08:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:46 INFO - '_': '/tools/buildbot/bin/python'} 08:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:46 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 08:07:46 INFO - Cleaning up... 08:07:46 INFO - Return code: 0 08:07:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff27b7b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471410>, '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 0x1472310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14727a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', '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 08:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:07:46 INFO - Using env: {'DISPLAY': ':0', 08:07:46 INFO - 'HOME': '/home/cltbld', 08:07:46 INFO - 'LANG': 'en_US.UTF-8', 08:07:46 INFO - 'LANGUAGE': 'en_US:en', 08:07:46 INFO - 'LOGNAME': 'cltbld', 08:07:46 INFO - 'MAIL': '/var/mail/cltbld', 08:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:46 INFO - 'MOZ_NO_REMOTE': '1', 08:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:46 INFO - 'NO_EM_RESTART': '1', 08:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:46 INFO - 'PWD': '/builds/slave/test', 08:07:46 INFO - 'SHELL': '/bin/bash', 08:07:46 INFO - 'SHLVL': '1', 08:07:46 INFO - 'TERM': 'linux', 08:07:46 INFO - 'TMOUT': '86400', 08:07:46 INFO - 'USER': 'cltbld', 08:07:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', 08:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:46 INFO - '_': '/tools/buildbot/bin/python'} 08:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:46 INFO - Downloading/unpacking psutil>=0.7.1 08:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:07:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:48 INFO - Installing collected packages: psutil 08:07:48 INFO - Running setup.py install for psutil 08:07:48 INFO - building 'psutil._psutil_linux' extension 08:07:48 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 08:07:49 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 08:07:49 INFO - building 'psutil._psutil_posix' extension 08:07:49 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 08:07:49 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 08:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:49 INFO - Successfully installed psutil 08:07:49 INFO - Cleaning up... 08:07:49 INFO - Return code: 0 08:07:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:07:49 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')]} 08:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:49 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')]} 08:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:49 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 0x7ff27b7b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471410>, '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 0x1472310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14727a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', '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 08:07:49 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 08:07:49 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 08:07:49 INFO - Using env: {'DISPLAY': ':0', 08:07:49 INFO - 'HOME': '/home/cltbld', 08:07:49 INFO - 'LANG': 'en_US.UTF-8', 08:07:49 INFO - 'LANGUAGE': 'en_US:en', 08:07:49 INFO - 'LOGNAME': 'cltbld', 08:07:49 INFO - 'MAIL': '/var/mail/cltbld', 08:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:49 INFO - 'MOZ_NO_REMOTE': '1', 08:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:49 INFO - 'NO_EM_RESTART': '1', 08:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:49 INFO - 'PWD': '/builds/slave/test', 08:07:49 INFO - 'SHELL': '/bin/bash', 08:07:49 INFO - 'SHLVL': '1', 08:07:49 INFO - 'TERM': 'linux', 08:07:49 INFO - 'TMOUT': '86400', 08:07:49 INFO - 'USER': 'cltbld', 08:07:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', 08:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:49 INFO - '_': '/tools/buildbot/bin/python'} 08:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:07:49 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 08:07:49 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 08:07:49 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 08:07:49 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 08:07:49 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 08:07:49 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 08:07:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:07:51 INFO - Installing collected packages: mozsystemmonitor 08:07:51 INFO - Running setup.py install for mozsystemmonitor 08:07:51 INFO - Successfully installed mozsystemmonitor 08:07:51 INFO - Cleaning up... 08:07:51 INFO - Return code: 0 08:07:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:51 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 0x7ff27b7b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471410>, '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 0x1472310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14727a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', '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 08:07:51 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 08:07:51 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 08:07:51 INFO - Using env: {'DISPLAY': ':0', 08:07:51 INFO - 'HOME': '/home/cltbld', 08:07:51 INFO - 'LANG': 'en_US.UTF-8', 08:07:51 INFO - 'LANGUAGE': 'en_US:en', 08:07:51 INFO - 'LOGNAME': 'cltbld', 08:07:51 INFO - 'MAIL': '/var/mail/cltbld', 08:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:51 INFO - 'MOZ_NO_REMOTE': '1', 08:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:51 INFO - 'NO_EM_RESTART': '1', 08:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:51 INFO - 'PWD': '/builds/slave/test', 08:07:51 INFO - 'SHELL': '/bin/bash', 08:07:51 INFO - 'SHLVL': '1', 08:07:51 INFO - 'TERM': 'linux', 08:07:51 INFO - 'TMOUT': '86400', 08:07:51 INFO - 'USER': 'cltbld', 08:07:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', 08:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:51 INFO - '_': '/tools/buildbot/bin/python'} 08:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:07:51 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 08:07:51 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 08:07:51 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 08:07:51 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 08:07:51 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 08:07:51 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 08:07:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:07:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:07:53 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 08:07:53 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 08:07:53 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 08:07:53 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 08:07:53 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 08:07:53 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 08:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:07:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07:54 INFO - Downloading docopt-0.6.1.tar.gz 08:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:07:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:07:54 INFO - Running setup.py install for blobuploader 08:07:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:07:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:07:54 INFO - Running setup.py install for requests 08:07:55 INFO - Running setup.py install for docopt 08:07:55 INFO - Successfully installed blobuploader requests docopt 08:07:55 INFO - Cleaning up... 08:07:55 INFO - Return code: 0 08:07:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:55 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 0x7ff27b7b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471410>, '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 0x1472310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14727a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', '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 08:07:55 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 08:07:55 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 08:07:55 INFO - Using env: {'DISPLAY': ':0', 08:07:55 INFO - 'HOME': '/home/cltbld', 08:07:55 INFO - 'LANG': 'en_US.UTF-8', 08:07:55 INFO - 'LANGUAGE': 'en_US:en', 08:07:55 INFO - 'LOGNAME': 'cltbld', 08:07:55 INFO - 'MAIL': '/var/mail/cltbld', 08:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:55 INFO - 'MOZ_NO_REMOTE': '1', 08:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:55 INFO - 'NO_EM_RESTART': '1', 08:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:55 INFO - 'PWD': '/builds/slave/test', 08:07:55 INFO - 'SHELL': '/bin/bash', 08:07:55 INFO - 'SHLVL': '1', 08:07:55 INFO - 'TERM': 'linux', 08:07:55 INFO - 'TMOUT': '86400', 08:07:55 INFO - 'USER': 'cltbld', 08:07:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', 08:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:55 INFO - '_': '/tools/buildbot/bin/python'} 08:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:55 INFO - Running setup.py (path:/tmp/pip-RcgvaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:55 INFO - Running setup.py (path:/tmp/pip-jGRRbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:55 INFO - Running setup.py (path:/tmp/pip-Ne_Kum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:55 INFO - Running setup.py (path:/tmp/pip-TR4qLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:55 INFO - Running setup.py (path:/tmp/pip-Upzq0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:55 INFO - Running setup.py (path:/tmp/pip-52K0DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:55 INFO - Running setup.py (path:/tmp/pip-s8Ijtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:55 INFO - Running setup.py (path:/tmp/pip-hJ7G9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:56 INFO - Running setup.py (path:/tmp/pip-mGb9r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:56 INFO - Running setup.py (path:/tmp/pip-odUYfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:56 INFO - Running setup.py (path:/tmp/pip-sY_GLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:56 INFO - Running setup.py (path:/tmp/pip-IXsRqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:56 INFO - Running setup.py (path:/tmp/pip-iyoxkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:56 INFO - Running setup.py (path:/tmp/pip-SHI7zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:56 INFO - Running setup.py (path:/tmp/pip-OOIB5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:56 INFO - Running setup.py (path:/tmp/pip-oSYO9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:56 INFO - Running setup.py (path:/tmp/pip-Gp1SYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:07:56 INFO - Running setup.py install for manifestparser 08:07:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:07:56 INFO - Running setup.py install for mozcrash 08:07:56 INFO - Running setup.py install for mozdebug 08:07:56 INFO - Running setup.py install for mozdevice 08:07:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:07:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:07:57 INFO - Running setup.py install for mozfile 08:07:57 INFO - Running setup.py install for mozhttpd 08:07:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:07:57 INFO - Running setup.py install for mozinfo 08:07:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:07:57 INFO - Running setup.py install for mozInstall 08:07:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:07:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:07:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:07:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:07:57 INFO - Running setup.py install for mozleak 08:07:57 INFO - Running setup.py install for mozlog 08:07:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:07:57 INFO - Running setup.py install for moznetwork 08:07:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:07:57 INFO - Running setup.py install for mozprocess 08:07:57 INFO - Running setup.py install for mozprofile 08:07:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:07:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:07:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:07:58 INFO - Running setup.py install for mozrunner 08:07:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:07:58 INFO - Running setup.py install for mozscreenshot 08:07:58 INFO - Running setup.py install for moztest 08:07:58 INFO - Running setup.py install for mozversion 08:07:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:07:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:07:58 INFO - Cleaning up... 08:07:58 INFO - Return code: 0 08:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:58 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 0x7ff27b7b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471410>, '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 0x1472310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14727a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', '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 08:07:58 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 08:07:58 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 08:07:58 INFO - Using env: {'DISPLAY': ':0', 08:07:58 INFO - 'HOME': '/home/cltbld', 08:07:58 INFO - 'LANG': 'en_US.UTF-8', 08:07:58 INFO - 'LANGUAGE': 'en_US:en', 08:07:58 INFO - 'LOGNAME': 'cltbld', 08:07:58 INFO - 'MAIL': '/var/mail/cltbld', 08:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:58 INFO - 'MOZ_NO_REMOTE': '1', 08:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:58 INFO - 'NO_EM_RESTART': '1', 08:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:58 INFO - 'PWD': '/builds/slave/test', 08:07:58 INFO - 'SHELL': '/bin/bash', 08:07:58 INFO - 'SHLVL': '1', 08:07:58 INFO - 'TERM': 'linux', 08:07:58 INFO - 'TMOUT': '86400', 08:07:58 INFO - 'USER': 'cltbld', 08:07:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', 08:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:58 INFO - '_': '/tools/buildbot/bin/python'} 08:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:58 INFO - Running setup.py (path:/tmp/pip-FYyFkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:58 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)) 08:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:58 INFO - Running setup.py (path:/tmp/pip-D94WaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:58 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)) 08:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:58 INFO - Running setup.py (path:/tmp/pip-vsroxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:58 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)) 08:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:58 INFO - Running setup.py (path:/tmp/pip-Gztz0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07: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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:59 INFO - Running setup.py (path:/tmp/pip-mE3JMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:59 INFO - Running setup.py (path:/tmp/pip-kBq56K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:59 INFO - Running setup.py (path:/tmp/pip-gXNAQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:59 INFO - Running setup.py (path:/tmp/pip-zwrwhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:59 INFO - Running setup.py (path:/tmp/pip-IMoAwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:59 INFO - Running setup.py (path:/tmp/pip-tytywn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:59 INFO - Running setup.py (path:/tmp/pip-QMjdhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:59 INFO - Running setup.py (path:/tmp/pip-paM2FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:59 INFO - Running setup.py (path:/tmp/pip-dfW9Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:59 INFO - Running setup.py (path:/tmp/pip-o2H56v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:59 INFO - Running setup.py (path:/tmp/pip-33SZJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:59 INFO - Running setup.py (path:/tmp/pip-cjUmFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:59 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)) 08:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:59 INFO - Running setup.py (path:/tmp/pip-OeEBfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:59 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)) 08:07:59 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)) 08:07:59 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)) 08:07:59 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)) 08:07:59 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)) 08:07:59 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)) 08:07:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:01 INFO - Downloading blessings-1.6.tar.gz 08:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:01 INFO - Installing collected packages: blessings 08:08:01 INFO - Running setup.py install for blessings 08:08:01 INFO - Successfully installed blessings 08:08:01 INFO - Cleaning up... 08:08:02 INFO - Return code: 0 08:08:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:02 INFO - Reading from file tmpfile_stdout 08:08:02 INFO - Current package versions: 08:08:02 INFO - argparse == 1.2.1 08:08:02 INFO - blessings == 1.6 08:08:02 INFO - blobuploader == 1.2.4 08:08:02 INFO - docopt == 0.6.1 08:08:02 INFO - manifestparser == 1.1 08:08:02 INFO - mozInstall == 1.12 08:08:02 INFO - mozcrash == 0.17 08:08:02 INFO - mozdebug == 0.1 08:08:02 INFO - mozdevice == 0.48 08:08:02 INFO - mozfile == 1.2 08:08:02 INFO - mozhttpd == 0.7 08:08:02 INFO - mozinfo == 0.9 08:08:02 INFO - mozleak == 0.1 08:08:02 INFO - mozlog == 3.1 08:08:02 INFO - moznetwork == 0.27 08:08:02 INFO - mozprocess == 0.22 08:08:02 INFO - mozprofile == 0.28 08:08:02 INFO - mozrunner == 6.11 08:08:02 INFO - mozscreenshot == 0.1 08:08:02 INFO - mozsystemmonitor == 0.0 08:08:02 INFO - moztest == 0.7 08:08:02 INFO - mozversion == 1.4 08:08:02 INFO - psutil == 3.1.1 08:08:02 INFO - requests == 1.2.3 08:08:02 INFO - wsgiref == 0.1.2 08:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:02 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 0x7ff27b7b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471410>, '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 0x1472310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14727a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', '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 08:08:02 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 08:08:02 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 08:08:02 INFO - Using env: {'DISPLAY': ':0', 08:08:02 INFO - 'HOME': '/home/cltbld', 08:08:02 INFO - 'LANG': 'en_US.UTF-8', 08:08:02 INFO - 'LANGUAGE': 'en_US:en', 08:08:02 INFO - 'LOGNAME': 'cltbld', 08:08:02 INFO - 'MAIL': '/var/mail/cltbld', 08:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:02 INFO - 'MOZ_NO_REMOTE': '1', 08:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:02 INFO - 'NO_EM_RESTART': '1', 08:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:02 INFO - 'PWD': '/builds/slave/test', 08:08:02 INFO - 'SHELL': '/bin/bash', 08:08:02 INFO - 'SHLVL': '1', 08:08:02 INFO - 'TERM': 'linux', 08:08:02 INFO - 'TMOUT': '86400', 08:08:02 INFO - 'USER': 'cltbld', 08:08:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', 08:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:02 INFO - '_': '/tools/buildbot/bin/python'} 08:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 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)) 08:08:02 INFO - Cleaning up... 08:08:02 INFO - Return code: 0 08:08:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:02 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 0x7ff27b7b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471410>, '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 0x1472310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14727a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', '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 08:08:02 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 08:08:02 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 08:08:02 INFO - Using env: {'DISPLAY': ':0', 08:08:02 INFO - 'HOME': '/home/cltbld', 08:08:02 INFO - 'LANG': 'en_US.UTF-8', 08:08:02 INFO - 'LANGUAGE': 'en_US:en', 08:08:02 INFO - 'LOGNAME': 'cltbld', 08:08:02 INFO - 'MAIL': '/var/mail/cltbld', 08:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:02 INFO - 'MOZ_NO_REMOTE': '1', 08:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:02 INFO - 'NO_EM_RESTART': '1', 08:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:02 INFO - 'PWD': '/builds/slave/test', 08:08:02 INFO - 'SHELL': '/bin/bash', 08:08:02 INFO - 'SHLVL': '1', 08:08:02 INFO - 'TERM': 'linux', 08:08:02 INFO - 'TMOUT': '86400', 08:08:02 INFO - 'USER': 'cltbld', 08:08:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', 08:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:02 INFO - '_': '/tools/buildbot/bin/python'} 08:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:02 INFO - Downloading/unpacking jsonschema 08:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:04 INFO - Downloading/unpacking functools32 (from jsonschema) 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:04 INFO - warning: no files found matching '*.txt' 08:08:04 INFO - no previously-included directories found matching 'build' 08:08:04 INFO - no previously-included directories found matching 'dist' 08:08:04 INFO - no previously-included directories found matching '.git*' 08:08:04 INFO - Installing collected packages: jsonschema, functools32 08:08:04 INFO - Running setup.py install for functools32 08:08:04 INFO - warning: no files found matching '*.txt' 08:08:04 INFO - no previously-included directories found matching 'build' 08:08:04 INFO - no previously-included directories found matching 'dist' 08:08:04 INFO - no previously-included directories found matching '.git*' 08:08:05 INFO - Successfully installed jsonschema functools32 08:08:05 INFO - Cleaning up... 08:08:05 INFO - Return code: 0 08:08:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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 0x7ff27b7b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471410>, '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 0x1472310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14727a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', '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 08:08: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 08:08: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 08:08:05 INFO - Using env: {'DISPLAY': ':0', 08:08:05 INFO - 'HOME': '/home/cltbld', 08:08:05 INFO - 'LANG': 'en_US.UTF-8', 08:08:05 INFO - 'LANGUAGE': 'en_US:en', 08:08:05 INFO - 'LOGNAME': 'cltbld', 08:08:05 INFO - 'MAIL': '/var/mail/cltbld', 08:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:05 INFO - 'MOZ_NO_REMOTE': '1', 08:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:05 INFO - 'NO_EM_RESTART': '1', 08:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:05 INFO - 'PWD': '/builds/slave/test', 08:08:05 INFO - 'SHELL': '/bin/bash', 08:08:05 INFO - 'SHLVL': '1', 08:08:05 INFO - 'TERM': 'linux', 08:08:05 INFO - 'TMOUT': '86400', 08:08:05 INFO - 'USER': 'cltbld', 08:08:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', 08:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:05 INFO - '_': '/tools/buildbot/bin/python'} 08:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:05 INFO - Downloading/unpacking flake8 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:08:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:08:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:07 INFO - no previously-included directories found matching 'docs/_build' 08:08:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:08:07 INFO - Running setup.py install for pep8 08:08:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:08 INFO - no previously-included directories found matching 'docs/_build' 08:08:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:08:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:08:08 INFO - Cleaning up... 08:08:08 INFO - Return code: 0 08:08:08 INFO - Running post-action listener: _resource_record_post_action 08:08:08 INFO - Running post-action listener: _start_resource_monitoring 08:08:08 INFO - Starting resource monitoring. 08:08:08 INFO - ##### 08:08:08 INFO - ##### Running install step. 08:08:08 INFO - ##### 08:08:08 INFO - Running pre-action listener: _resource_record_pre_action 08:08:08 INFO - Running main action method: install 08:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:08 INFO - Reading from file tmpfile_stdout 08:08:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:08 INFO - Reading from file tmpfile_stdout 08:08:08 INFO - Output received: 08:08:08 INFO - Usage: mozinstall [options] installer 08:08:08 INFO - Options: 08:08:08 INFO - -h, --help show this help message and exit 08:08:08 INFO - -d DEST, --destination=DEST 08:08:08 INFO - Directory to install application into. [default: 08:08:08 INFO - "/builds/slave/test"] 08:08:08 INFO - --app=APP Application being installed. [default: firefox] 08:08:08 INFO - mkdir: /builds/slave/test/build/application 08:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:08:25 INFO - Reading from file tmpfile_stdout 08:08:25 INFO - Output received: 08:08:25 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:25 INFO - Running post-action listener: _resource_record_post_action 08:08:25 INFO - ##### 08:08:25 INFO - ##### Running run-tests step. 08:08:25 INFO - ##### 08:08:25 INFO - Running pre-action listener: _resource_record_pre_action 08:08:25 INFO - Running main action method: run_tests 08:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:25 INFO - Python 2.7.3 08:08:25 INFO - Return code: 0 08:08:25 INFO - grabbing minidump binary from tooltool 08:08: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')]} 08:08: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 0x1471410>, '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 0x1472310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14727a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08: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 08:08: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 08:08:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:25 INFO - Return code: 0 08:08:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:08:26 INFO - Return code: 0 08:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 08:08:26 INFO - Using env: {'DISPLAY': ':0', 08:08:26 INFO - 'HOME': '/home/cltbld', 08:08:26 INFO - 'LANG': 'en_US.UTF-8', 08:08:26 INFO - 'LANGUAGE': 'en_US:en', 08:08:26 INFO - 'LOGNAME': 'cltbld', 08:08:26 INFO - 'MAIL': '/var/mail/cltbld', 08:08:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:26 INFO - 'MOZ_NO_REMOTE': '1', 08:08:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:26 INFO - 'NO_EM_RESTART': '1', 08:08:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:26 INFO - 'PWD': '/builds/slave/test', 08:08:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:26 INFO - 'SHELL': '/bin/bash', 08:08:26 INFO - 'SHLVL': '1', 08:08:26 INFO - 'TERM': 'linux', 08:08:26 INFO - 'TMOUT': '86400', 08:08:26 INFO - 'USER': 'cltbld', 08:08:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403', 08:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:26 INFO - '_': '/tools/buildbot/bin/python'} 08:08:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:08:26 INFO - mozversion application_buildid: 20160429053011 08:08:26 INFO - mozversion application_changeset: f98e3add979e3b2eba6461fdaed2cfc80961ff6f 08:08:26 INFO - mozversion application_display_name: Nightly 08:08:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:26 INFO - mozversion application_name: Firefox 08:08:26 INFO - mozversion application_remotingname: firefox 08:08:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:08:26 INFO - mozversion application_vendor: Mozilla 08:08:26 INFO - mozversion application_version: 49.0a1 08:08:26 INFO - mozversion platform_buildid: 20160429053011 08:08:26 INFO - mozversion platform_changeset: f98e3add979e3b2eba6461fdaed2cfc80961ff6f 08:08:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:08:26 INFO - mozversion platform_version: 49.0a1 08:08:26 INFO - using testdate: 1461942506 08:08:26 INFO - actual date: 1461942506 08:08:26 INFO - starting webserver on 'localhost:59117' 08:08:26 INFO - SUITE-START | Running 2 tests 08:08:26 INFO - TEST-START | dromaeo_css 08:08:26 INFO - operating with platform_type : linux_ 08:08:26 INFO - Initialising browser for dromaeo_css test... 08:08:26 INFO - TEST-INFO | started process 28902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM2zBIR/profile http://localhost:59117/getInfo.html) 08:08:29 INFO - PROCESS | 28902 | 08:08:29 INFO - PROCESS | 28902 | (process:28971): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:08:30 INFO - PROCESS | 28902 | __metrics Screen width/height:1600/1200 08:08:30 INFO - PROCESS | 28902 | colorDepth:24 08:08:30 INFO - PROCESS | 28902 | Browser inner width/height: 1024/697 08:08:30 INFO - PROCESS | 28902 | __metrics 08:08:31 ERROR - PROCESS | 28902 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:08:32 INFO - TEST-INFO | 28902: exit 0 08:08:32 INFO - Browser initialized. 08:08:32 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:32 INFO - TEST-INFO | started process 29023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM2zBIR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:34 INFO - PROCESS | 29023 | 08:08:34 INFO - PROCESS | 29023 | (process:29085): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:08:44 INFO - PROCESS | 29023 | RSS: Main: 164900864 08:08:44 INFO - PROCESS | 29023 | 08:09:33 INFO - PROCESS | 29023 | 1461942573760 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] 08:11:41 INFO - PROCESS | 29023 | Cycle 1(1): loaded http://localhost:59117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59117/tests/dromaeo/cssquery-ext.html) 08:11:42 INFO - PROCESS | 29023 | RSS: Main: 169611264 08:11:42 INFO - PROCESS | 29023 | 08:14:44 INFO - PROCESS | 29023 | Cycle 1(1): loaded http://localhost:59117/tests/dromaeo/cssquery-ext.html (next: http://localhost:59117/tests/dromaeo/cssquery-jquery.html) 08:14:44 INFO - PROCESS | 29023 | RSS: Main: 166760448 08:14:44 INFO - PROCESS | 29023 | 08:17:46 INFO - PROCESS | 29023 | Cycle 1(1): loaded http://localhost:59117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59117/tests/dromaeo/cssquery-mootools.html) 08:17:47 INFO - PROCESS | 29023 | RSS: Main: 167780352 08:17:47 INFO - PROCESS | 29023 | 08:20:48 INFO - PROCESS | 29023 | Cycle 1(1): loaded http://localhost:59117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59117/tests/dromaeo/cssquery-prototype.html) 08:20:49 INFO - PROCESS | 29023 | RSS: Main: 165236736 08:20:49 INFO - PROCESS | 29023 | 08:23:51 INFO - PROCESS | 29023 | Cycle 1(1): loaded http://localhost:59117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59117/tests/dromaeo/cssquery-yui.html) 08:23:52 INFO - PROCESS | 29023 | RSS: Main: 166383616 08:23:52 INFO - PROCESS | 29023 | 08:26:54 INFO - PROCESS | 29023 | Cycle 1(1): loaded http://localhost:59117/tests/dromaeo/cssquery-yui.html (next: http://localhost:59117/tests/dromaeo/cssquery-dojo.html) 08:26:54 INFO - PROCESS | 29023 | RSS: Main: 168095744 08:26:54 INFO - PROCESS | 29023 | 08:26:54 INFO - PROCESS | 29023 | __start_tp_report 08:26:54 INFO - PROCESS | 29023 | _x_x_mozilla_page_load 08:26:54 INFO - PROCESS | 29023 | _x_x_mozilla_page_load_details 08:26:54 INFO - PROCESS | 29023 | |i|pagename|runs| 08:26:54 INFO - PROCESS | 29023 | |0;dojo.html;3138.1370123216116;3190.984045079774;3222.7744057915947;3260.087175590834;3260.136063943054;5421.268128802611;5428.972855135724;5442.727863606824;5442.9727851360685;5459.317585301837;5358.33020872391;5396.271503347047;5446.591505637073;5487.588430867681;5506.504414602685;4858.975705121469;4904.435989861158;4960.60315174787;4980.850574482772;5034.169362055275;737.5914975208667;4919.631027672921;4935.457099719028;4966.180580204262;4981.925271120918;4918.655694101414;4921.384826896638;4933.309336692866;4947.975260123712;4981;4786.066716990188;4949.826756063557;4968.1554135797005;4970.15507363749;5010.749462526859;4929.704217746911;4932.778024988848;4948.38145231846;4962.578180854632;4970.130227210224;5221.530062294411;5231.843044708665;5249.816256431045;5266.368035835724;5292.44429334922;5744.368119506851;5753.741081651336;5756.510696590753;5765.1928729977835;5840.737166827503;5741.684207368593;5792.768289268424;5792.971035144839;5795.072788353886;5845.064789633639;5394.24480572724;5395.136778115482;5397.325334333208;5397.4062853086125;5414.07960646691;5774.220480235114;5874.500667443315;5902.055671092605;5998.610090344114;6013.218281623361;5708.4862362387585;5754.6547207167705;5774.653520788682;5782.045962416239;5796.1595568642315;5841.503472204825;5862.5896187267335;5862.912056319158;5869.618474799125;5874.823755287348;5696.857578560569;5832.475077242983;5869.090291004901;5900.380460051719;5923;5649.745761440745;5783.566232532577;5833.125031245348;5881.735321910524;5921.822345329647;4285.250081235771;4315.438992930899;4319.43847299849;4330.588594083557;4373.562643735665;3834.0989867381145;3876.7286289959998;3903.5706072332023;3921.9607803922167;3952.8023598819946;5500.367457742331;5508.44915508446;5509.834704958857;5509.889802203934;5545.251391062155;5735.655860648374;5752.28096487939;5759.568032397587;5785.190073389729;5785.681787501728;5569.777208911679;5570.888582228414;5592.217089607459;5644.6613203207935;5644.689542075225;4797.496262892416;4801.807927682923;4804.231322988305;4813.590844778163;4841.273808928619;5929.881402371929;6027.397260274025;6028.186194863637;6028.819135425944;6039.245094363205;5778.451047150514;5803.274590676166;5840.620359676607;5864.296284445893;5891.440313170242;5949.494292985145;5960.8807823844145;5961.582689211714;5973.611715238496;5973.970130149321;5648.604597678123;5658.547316214611;5662.971685141548;5665.546756259571;5665.915011274752;5715.599908006399;5869.530437564899;5942.049272116614;5975.193348898017;5980.970095149496;5630;5635.042042852643;5641.520470759867;5675.290588676416;5687.090065589486;5573.27547418833;5592.468715472024;5594.608377413542;5594.608377413705;5596.776128954959;5578.442155784389;5609.5512359012;5616.466435688603;5633.4084921082695;5633.408492108433;5641.746121424628;5665.801696940587;5666.065099258741;5676.063449530781;5698.572607054571;5361.115415956324;5555.083411237262;5559.27729395176;5562.249096371938;5566.276384070045 08:26:54 INFO - PROCESS | 29023 | |1;ext.html;598.8862116197922;623.3392603839927;640.113442881609;652.7193306878042;660.9933900660992;37328;38852.41721374175;38887.805560972156;38905.805470972606;38917.61082389175;41183.58816411835;41838.37242441366;41945.37081943773;42076;42224.577754222446;8625.95687021564;8762.780930476725;8762.956185219065;8835.116488351177;8848.690295839648;8515.701950431736;8572.871406928902;8659.870101948476;8684.478931264113;8812.823743525125;8903.287736981027;8934.419262747933;8957.37298389113;8991.235744961687;9036;8888.24449921751;8891;8936.151065648754;8936.776580585472;8968.955155224246;8918.19736223743;9006.639734410615;9013.324000699973;9023.187913087853;9045.276377889819;42294.731158065304;42636.78681606603;42862.142757145;42992;43000;3520.436730123168;3586.7668601540818;3601.1537288737127;3791.3554695701796;4388.429504164438;29679.25801854971;30774.692253077406;30958.380832383453;30959.38081238385;31060.844695776377;3816.103215744298;3825.7513261637905;3854.2914171656685;3871.496705428276;3918.235943990923;293757;294355;295462;296322;297107.99999999785;62789;63335.29982301615;63406;63505.68247158827;63571.36428635747;57013;58549.70725146347;58594;58657.41342586605;58864.70567647134;17299.394521191698;17489.912550437166;17516.737248941277;17548.912255438896;17556.473305800846;13375.598732038054;13408.731825363633;13419.127756695783;13438.126521776054;13452.932735336457;19155.529343556023;19579.490151795217;20090.296839610837;20204.191832326836;20276.594468110554;7174.820629484305;7191.352778249982;7457.403407727369;7578.204288549623;7686.769396918102;1038.4132964874973;1049.9395610433517;1070.4433694478982;1081.2809481694585;1145.931244125355;30757.231069223002;30938;31589.84205079006;32169.678303217137;33047.00858974235;1102.795982743195;1190.8392367030513;1197.5569039455456;1259.4206664934234;1277.3740866975302;16837.831621683872;17105;17124.657506849795;17282.567935801453;17408.303667853143;454627;462051;464843;465113;467846;57465;59014.70492647509;59389.406105939255;59469.40530594725;59499;1321.3723481346476;1403.880670143029;1406.901516893828;1410.8994983912564;1422.672785259396;30528.542071868495;30919.2270193247;31338.373232535676;31691.366172675956;31890.362192756478;51712;51921.740391297804;52162;52327.476725233784;52352;392140;394127;396288;396810;397311;28263.29341766472;28278;28681.856590716914;28699.713002869703;28845.423091538472;48756.5124348752;49062.26406603975;49383;49407.25889111594;50659;40283;41099.92415341868;41657.37513937354;41766.79116604398;42175;40026;40721.79639101786;40906.18187636171;41430.1713965725;41966;37079.814600926824;37670.62329376671;37865.81067094647;38283;40437.39343909785;30239.395212095194;32362.83818580892;32449;32548.674513254566;33407.331853363285;25934.481310374063;26707.369301714123;27905.581416278364;28014;28319 08:26:54 INFO - PROCESS | 29023 | |2;jquery.html;407.2201733680002;413.8406713415336;415.8939470435039;416.1136778661453;417.7597881218297;13600.93199534001;17861.910690446544;18743.4376968691;18767.2493100276;18781;17337.306507739675;17597.824021759778;17943.461696149105;18112.728309075374;18236.088195590233;5435.592330575223;5591.608587398884;5749.971250143743;5773.018586840247;5816.738246778884;5634.183043458716;5651.2935883014625;5662.235598194232;5712.428757124296;5713.71431428429;6409.391107844771;6449.709763060673;6450.4194622483965;6451.580647257937;6454.7413254415405;5714.314282286152;5727.198192253088;5957.285125784933;6375.808725738212;6388.680565971706;5562.221289019541;5567.415421380737;5596.188552659842;5602.859928501779;5631.239782629334;12603.306818125;13271.86728132716;13403.46386144553;13429.194248345131;13606.591802245948;2157.2880949286696;2181.8036376726172;2258.6499092640665;2382.4163080045328;2626.868656567164;9875;11039.282446640942;12534.874651253462;13415.530456433979;13771.517996870161;1897.990510047441;2001.259533972425;2013.9395818125479;2036.8472364572717;2042.6323261812868;76897.61551192208;78464.60767696182;79532;80656.59671701604;81220;10757.9462102689;10840.13278937683;10924.836127458095;11123.887611238812;11142.27575207609;15184.46854360092;15273.694526109415;15276.923615382075;15311.770323445156;15349.6162595936;8039.477433966774;8191.590420479071;8233.406476959739;8335.874961875577;8366.414350995494;7783.338416234684;7960.243776841191;8029.116797152308;8081.070676872235;8083.555404452694;4674.205385084544;4675.158471475167;4744.810207591658;4788.592969597554;4796.856094317176;1915.4636701723539;1975.6740137877089;1976.9802301977084;2053.414776788608;2063.2778527515547;944.9622015119318;1044.639599338227;1052.4001319247955;1067.8024565455416;1085.3759088523973;17993.460196194133;18718;18762.530936726416;18858.15138318779;18912;1021.8875923648393;1040.432964034603;1073.5974009746344;1082.1613249731363;1118.6308518188978;10259.487025648688;10530.15758739299;10562.683119506428;10612.628558000433;10642.680719578426;488352;493052;499036;502082;503733;75593;82665.58667206626;85555;90128.54935725279;93154;1032.6230925712061;1039.0907955538903;1069.1500257295468;1071.8552995345528;1077.4612693653173;16392.11490678587;16406.425775097814;16784.664306714043;16967.321307147577;16970.91514542469;36320;36580.451293231155;36825.81587092047;36862.94507604108;38331.041723957125;51084.744576276884;51658.48341516537;51812.22281665703;52746;52949;7989.560574168477;7998.880016799636;8018.238267364591;8064.758057258292;8148.592570371339;8624.439411438236;11270.323780573191;12099.092568057607;12392.442340094538;12416;10620;10803.729906752395;10886.564537418415;10957.342559446459;11134.721631959266;10481;10966.287191332856;11082.556697732;11082.778344433227;11147.609833655782;11076.169287303323;11261.831072534082;11405.942970285096;11488.080953523866;11563.248388854698;7666.4633475656165;7865.685372585262;7918.524888506708;7974.800629984296;8024.679012839421;8844.55777211124;10032.398056116657;10174.13519850821;10224.591016359262;10233.283670143317 08:26:54 INFO - PROCESS | 29023 | |3;mootools.html;1513.9924300378495;1541.560655213264;1638.9508314750553;1744.8342407471293;1785.6964316066267;7109.075820143387;7800.570968596725;7925.445218834684;8077.7576672699915;8102.5543595102245;7959.920400795991;7977.800554986128;8039.196080391958;8049.1950804919625;8055.476394034384;2274.1130958926033;2318.420394901275;2322.628379459287;2323.1984965186984;2324.883755812211;2284.49741056968;2288.8168946484243;2324.4421338878633;2335.696359473266;2338.0647740903605;2299.8850057497057;2308.2613563659634;2309.7690230976937;2326.4067662745974;2334.9533009339802;2220.966685499719;2263.4454558633242;2271.716035495563;2275.0672224388004;2279.1453205048024;2215.5679642469727;2216.1578600132007;2242.8990695418747;2243.4839986803127;2246.831487638434;8087.919120808834;8210.30212431944;8216.055153657346;8219.506829590244;8258.628361723737;4923.606111511071;5164.690118592896;5173.689578625257;5189.922151167735;5191.922121168185;3123.2348074721613;3184.50640150777;3312.138843900579;3331.5502407174963;3334.0164651427885;1039.5426012554528;1057.894210578936;1065.8134826405426;1089.4062735809002;1124.1568823382463;11045.39250341223;11065.336079835235;11101.500432480478;11122.49948752308;11123.221374503788;4416.823327066945;4473.507914129443;4535.682502224812;4603.861884143481;4604.815807367668;9473.621055157717;9507.904920950841;9531.428114313025;9533.237341012702;9533.618655253713;5056.924146137811;5128.282040514331;5147.2279158126585;5154.278401023859;5176.50823171798;4105.753654780723;4668.299755036704;4704;4792.329073929653;4793.32893394925;3788.9431658525145;3808.3716186828865;3831.6168383162017;3892.2215556888737;3914.6868250539887;1200.17188140183;1221.6640423883325;1229.3238718704856;1245.7197130645532;1266.3984607311638;898.851689471243;901.0944001278673;904.2088172848757;954.054483361132;957.8275910336206;5482.945170548243;5834.27071616048;5893.705314734246;5914.349421563625;6016.127661489059;933.883264591926;950.4819873169139;993.5926270229315;1010.8685870836745;1015.6648306058983;3871.903202419962;4091.3862920562156;4097.795110244476;4099.282625540519;4149.834006639761;9665.613375465044;10185.33795303303;10250.231232657581;10257.846132308021;10264.538095785707;10034.74913127163;10122.44326562046;10153.289269751194;10157.492125393701;10167.694969150938;7447.478676492594;7619.238076192337;7677.23227677239;7687.115981662068;7729.188435214334;5751.8562035949435;5800.738966746591;5904.675242861512;5963.075723262901;5991.520678345635;9223.907760922304;9353.859692104488;9442.763930901509;9449.385789923634;9497.810043799223;9277.443353398818;9554.331196816156;9630.903690963001;9713.854292185482;9753.366031207948;7099.246913641663;7175.067241258812;7205.891911621225;7216.5670059796585;7290.927090729025;7879.527228366316;7916.366690664618;7942.285194332538;7951.363890888831;7973.401994850526;7223.1693355264815;7364.116306043309;7401.0748656417945;7407.222241664547;7427.517211381243;6633.071370008299;6694.330566943267;6709.429698475684;6756.256811750802;6773.221079575912;6337.302896681269;6359.841003974938;6364.968175159094;6394.200724909387;6402.583832050902;4884.82347592803;5072.746362681925;5080.669756465818;5086.720230387365;5132.897342053064;5041.42023667283;5093.312402825572;5097.8215762448135;5202.791888324425;5211.009908117446 08:26:54 INFO - PROCESS | 29023 | |4;prototype.html;332.05364710574855;334.6954271612833;337.35733427820014;339.23333266816996;355.0750295480272;5376.892462150755;5416.618762215634;5434.184872269162;5507.972460137698;5546.278983732109;5493.7802487900435;5501.559875209983;5509.421510741375;5518.427248234254;5576.079946808772;4315.244832154376;4315.4605674290715;4330.155619654169;4336.97831510842;4337.761423121727;4210.263203939314;4341.110072435144;4364.825406983717;4369.410129632507;4386.605205531501;4300.419443375135;4309.159713855799;4326.242907491192;4341.565843415665;4357.912841743163;4315.424869922487;4318.201132790444;4337.826486940518;4341.218580655496;4347.2826983547675;3581.2658405026905;3831.4252862070634;3850.2299540091813;3852.749571277886;3855.6915446764474;5363.463653634644;5372.925414917032;5380.704061276629;5397.757100930428;5403.567714582824;4898.24077268024;4907.337509436216;4927.802887884516;4932.827351042696;4958.900821983576;5524.309461317335;5801.187833703285;5838.182654428383;5838.941610583882;5853.9170253503235;4118.75287482752;4129.442525259082;4137.965508622844;4143.6685065195015;4161.708680392374;5983.611065280743;6012.78955236569;6062.181605483292;6074.3925607438905;6091.451769340736;4155.709100363006;4200.5799420058365;4207.810648520824;4242.787860606957;4255.723377980421;4267.146570685875;4282.250606143913;4282.764447955392;4290.871273861727;4303.376010478463;4923.335349727741;4928.975355123202;4935.407751069823;4935.4570997190995;4965.404151501771;5500.22996780451;5694.259746232963;5843.824685259449;5869.7945571904775;5900.232969713909;1552.3712896277025;1552.9922350388176;1554.7201503729436;1556.3385561136472;1556.836532164129;1016.9559186036121;1034.912032477248;1048.6786648822538;1053.578568572577;1053.7312985188728;6020.909686354708;6035.969820150871;6038.33578306386;6049.758009679564;6070.3019152798;6382.978723404233;6395.16862807832;6405.807825765234;6422.2293324800385;6447.903281450782;5885.176075349455;5994.460498555064;5999.910001349983;6031.612729072338;6041.24484439445;3378.391889459921;3413.368526822546;3416.8633254669535;3417.111550996709;3432.982835085809;6447.743289848516;6538.411542961061;6614.404703576605;6626.801195964033;6640.83397915056;6524.608523488606;6525.608463492205;6547.639879806657;6573.112629795012;6583.604983700993;5950.613210141327;6234.352903551473;6613.173353330833;6623.138991931018;6625.569337993015;6028.939710602838;6031.336552979256;6036.8188954331445;6077.51379889599;6100.1459795629535;5957.493613042767;5983.820485385445;5988.431099045583;6000.609960352563;6013.969930150496;5854.619449735754;6211.409916057967;6229.844253893689;6259.405356491126;6269.811905642838;4268.061026574149;4306.763128027988;4310.116426132698;4325.329573916048;4328.177646247203;5893.469587736953;6005.819825405245;6012.458878700938;6020.30766461845;6071.392860713893;5787.3411903418155;5856.531477481706;5871.412858714094;5877.882442351043;5915.585908986502;5789.3921138279875;5844.47399734026;5895.351511333835;5899.734511947058;5910;5657.3776884543495;5762.081784386657;5799.5070419014855;5829.59192856496;5829.737661805144;5898.8230353089475;5909.261342332208;5915.733791979285;5934.525237980864;5943.732532035982;5657.5473962082115;5761.164631128547;5765.5675824314185;5790.507806836466;5807.82576522705 08:26:54 INFO - PROCESS | 29023 | |5;yui.html;694.6353164588587;725.5102805606211;760.6805141840426;837.8617528107862;853.9871901921471;14202.857971420282;14665.413383464649;14747.262636868167;14755.631109222248;14772.409103635842;12261.080418968591;13351.799723004162;14246.857531424683;14270.429182832675;14323.928380358084;826.2274773087153;828.0436096308742;831.6922738586732;833.0253603284142;835.1564919431388;807.3823525003377;810.4326971120239;815;815.1237419773737;817.8364327134567;865.5931712095337;867.6746220167437;869.0310304011045;869.9217070463657;871.5816408124105;860.6299291304737;861.5519929636586;862.8188080503134;863.3956230638578;864.5374724522413;635.3741564558906;639.2361128451503;639.3606393606393;639.9904001439982;640.9230892292908;12026.879731202664;12077.637670869888;12114.81827772584;13372.799408008888;13669.794953075612;11772.234804737665;11808;11919.642410727693;11965.102617303737;12085.456154472982;10557.155427565853;10662.73343166427;10711.732206694816;10830.241883068189;10882.510287037023;3758.906027349311;4468.508464068982;4516.322551617251;4548.11311794197;4776.880577985578;47895.76052119752;51369.743151284376;53146.468535314925;53551.732241338934;53891.730541347046;11377.715557111138;11503.654890353302;11739.647810565697;11816.291022538675;11931.343776092224;20404.97975101239;20467.590648186953;20534.58930821405;20629.79370206309;20633.071511782007;8913.153250441197;8919.108089191159;8966.730998070068;9215.216706580015;9351;4877.487863774252;4904.288878112654;4927.384076990376;4982.177940639826;4995.575376093073;3423.880164194291;3530.735194860396;3542.5040494330815;3542.840572174207;3543.7696549724187;614.3764079459353;624.6626821516421;630.5680608782999;639.1850390751829;643.2217017408894;642.4892210692417;695.9164900212007;704.8660754456739;762.2482836958575;768.5542385416556;8925;9011.504367259864;9108.225800806873;9272.629094836266;9285.907140928639;654.8362909272682;706.7702996526046;747.0624366420108;758.7003133762133;761.9238076192447;4061.918761624751;4227.492700875853;4246.363045543131;4257.765822879709;4283.7001409901;58839.70580147072;59595.702021490484;61226;61344.69327653333;62119.68940155361;48837.755811221425;48868.26697599468;51262.48737512652;55265.1710224347;55787;40055;44912;49984.25023624649;50166.24750628744;50234.49765502371;8974.19232269099;9295.628174872929;9406;9409.294302927445;9444.197243234126;32362.83818580892;32707.672923270464;33156.83421582876;33525;33799.83100084484;41374.79312603418;44100.55899441093;44146.558534415526;44637;45001.77499112483;12504.74990500203;12653.810192847299;12745.681357966125;12915.895915057845;13043.869561304266;12886.355682216039;13056.738865222833;13636.318184090558;13950.302484875512;14140.78788818148;12556.309402982924;12685.619431417072;12782.488700451877;12804.679883003;12959.222446653232;11737.88262117368;11768.293902365886;11791.823122652995;12141;12165.513379465076;10739.624113156002;10959.178061645249;11672.766544669228;11895.167338286583;11913.344766037604;10621.734456638645;10669.003914225683;10695.572177112828;10792.352458852494;11070.225084244026;10219.897801022193;10355.119814815524;10457.163426925676;10464.529096190538;10490 08:26:54 INFO - PROCESS | 29023 | __end_tp_report 08:26:54 INFO - PROCESS | 29023 | __start_cc_report 08:26:54 INFO - PROCESS | 29023 | _x_x_mozilla_cycle_collect,346 08:26:54 INFO - PROCESS | 29023 | __end_cc_report 08:26:54 INFO - PROCESS | 29023 | __startTimestamp1461943614739__endTimestamp 08:26:54 INFO - PROCESS | 29023 | 08:26:54 INFO - PROCESS | 29023 | ------- Summary: start ------- 08:26:54 INFO - PROCESS | 29023 | Number of tests: 6 08:26:54 INFO - PROCESS | 29023 | 08:26:54 INFO - PROCESS | 29023 | [#0] dojo.html Cycles:165 Average:5355.21 Median:5596.78 stddev:715.51 (12.8%) stddev-sans-first:696.24 08:26:54 INFO - PROCESS | 29023 | Values: 3138.1 3191.0 3222.8 3260.1 3260.1 5421.3 5429.0 5442.7 5443.0 5459.3 5358.3 5396.3 5446.6 5487.6 5506.5 4859.0 4904.4 4960.6 4980.9 5034.2 737.6 4919.6 4935.5 4966.2 4981.9 4918.7 4921.4 4933.3 4948.0 4981.0 4786.1 4949.8 4968.2 4970.2 5010.7 4929.7 4932.8 4948.4 4962.6 4970.1 5221.5 5231.8 5249.8 5266.4 5292.4 5744.4 5753.7 5756.5 5765.2 5840.7 5741.7 5792.8 5793.0 5795.1 5845.1 5394.2 5395.1 5397.3 5397.4 5414.1 5774.2 5874.5 5902.1 5998.6 6013.2 5708.5 5754.7 5774.7 5782.0 5796.2 5841.5 5862.6 5862.9 5869.6 5874.8 5696.9 5832.5 5869.1 5900.4 5923.0 5649.7 5783.6 5833.1 5881.7 5921.8 4285.3 4315.4 4319.4 4330.6 4373.6 3834.1 3876.7 3903.6 3922.0 3952.8 5500.4 5508.4 5509.8 5509.9 5545.3 5735.7 5752.3 5759.6 5785.2 5785.7 5569.8 5570.9 5592.2 5644.7 5644.7 4797.5 4801.8 4804.2 4813.6 4841.3 5929.9 6027.4 6028.2 6028.8 6039.2 5778.5 5803.3 5840.6 5864.3 5891.4 5949.5 5960.9 5961.6 5973.6 5974.0 5648.6 5658.5 5663.0 5665.5 5665.9 5715.6 5869.5 5942.0 5975.2 5981.0 5630.0 5635.0 5641.5 5675.3 5687.1 5573.3 5592.5 5594.6 5594.6 5596.8 5578.4 5609.6 5616.5 5633.4 5633.4 5641.7 5665.8 5666.1 5676.1 5698.6 5361.1 5555.1 5559.3 5562.2 5566.3 08:26:54 INFO - PROCESS | 29023 | 08:26:54 INFO - PROCESS | 29023 | [#1] ext.html Cycles:180 Average:55362.33 Median:396549.00 stddev:103118.73 (26.0%) stddev-sans-first:103326.03 08:26:54 INFO - PROCESS | 29023 | Values: 598.9 623.3 640.1 652.7 661.0 37328.0 38852.4 38887.8 38905.8 38917.6 41183.6 41838.4 41945.4 42076.0 42224.6 8626.0 8762.8 8763.0 8835.1 8848.7 8515.7 8572.9 8659.9 8684.5 8812.8 8903.3 8934.4 8957.4 8991.2 9036.0 8888.2 8891.0 8936.2 8936.8 8969.0 8918.2 9006.6 9013.3 9023.2 9045.3 42294.7 42636.8 42862.1 42992.0 43000.0 3520.4 3586.8 3601.2 3791.4 4388.4 29679.3 30774.7 30958.4 30959.4 31060.8 3816.1 3825.8 3854.3 3871.5 3918.2 293757.0 294355.0 295462.0 296322.0 297108.0 62789.0 63335.3 63406.0 63505.7 63571.4 57013.0 58549.7 58594.0 58657.4 58864.7 17299.4 17489.9 17516.7 17548.9 17556.5 13375.6 13408.7 13419.1 13438.1 13452.9 19155.5 19579.5 20090.3 20204.2 20276.6 7174.8 7191.4 7457.4 7578.2 7686.8 1038.4 1049.9 1070.4 1081.3 1145.9 30757.2 30938.0 31589.8 32169.7 33047.0 1102.8 1190.8 1197.6 1259.4 1277.4 16837.8 17105.0 17124.7 17282.6 17408.3 454627.0 462051.0 464843.0 465113.0 467846.0 57465.0 59014.7 59389.4 59469.4 59499.0 1321.4 1403.9 1406.9 1410.9 1422.7 30528.5 30919.2 31338.4 31691.4 31890.4 51712.0 51921.7 52162.0 52327.5 52352.0 392140.0 394127.0 396288.0 396810.0 397311.0 28263.3 28278.0 28681.9 28699.7 28845.4 48756.5 49062.3 49383.0 49407.3 50659.0 40283.0 41099.9 41657.4 41766.8 42175.0 40026.0 40721.8 40906.2 41430.2 41966.0 37079.8 37670.6 37865.8 38283.0 40437.4 30239.4 32362.8 32449.0 32548.7 33407.3 25934.5 26707.4 27905.6 28014.0 28319.0 08:26:54 INFO - PROCESS | 29023 | 08:26:54 INFO - PROCESS | 29023 | [#2] jquery.html Cycles:180 Average:28183.69 Median:2110.28 stddev:81796.00 (3876.1%) stddev-sans-first:81998.87 08:26:54 INFO - PROCESS | 29023 | Values: 407.2 413.8 415.9 416.1 417.8 13600.9 17861.9 18743.4 18767.2 18781.0 17337.3 17597.8 17943.5 18112.7 18236.1 5435.6 5591.6 5750.0 5773.0 5816.7 5634.2 5651.3 5662.2 5712.4 5713.7 6409.4 6449.7 6450.4 6451.6 6454.7 5714.3 5727.2 5957.3 6375.8 6388.7 5562.2 5567.4 5596.2 5602.9 5631.2 12603.3 13271.9 13403.5 13429.2 13606.6 2157.3 2181.8 2258.6 2382.4 2626.9 9875.0 11039.3 12534.9 13415.5 13771.5 1898.0 2001.3 2013.9 2036.8 2042.6 76897.6 78464.6 79532.0 80656.6 81220.0 10757.9 10840.1 10924.8 11123.9 11142.3 15184.5 15273.7 15276.9 15311.8 15349.6 8039.5 8191.6 8233.4 8335.9 8366.4 7783.3 7960.2 8029.1 8081.1 8083.6 4674.2 4675.2 4744.8 4788.6 4796.9 1915.5 1975.7 1977.0 2053.4 2063.3 945.0 1044.6 1052.4 1067.8 1085.4 17993.5 18718.0 18762.5 18858.2 18912.0 1021.9 1040.4 1073.6 1082.2 1118.6 10259.5 10530.2 10562.7 10612.6 10642.7 488352.0 493052.0 499036.0 502082.0 503733.0 75593.0 82665.6 85555.0 90128.5 93154.0 1032.6 1039.1 1069.2 1071.9 1077.5 16392.1 16406.4 16784.7 16967.3 16970.9 36320.0 36580.5 36825.8 36862.9 38331.0 51084.7 51658.5 51812.2 52746.0 52949.0 7989.6 7998.9 8018.2 8064.8 8148.6 8624.4 11270.3 12099.1 12392.4 12416.0 10620.0 10803.7 10886.6 10957.3 11134.7 10481.0 10966.3 11082.6 11082.8 11147.6 11076.2 11261.8 11405.9 11488.1 11563.2 7666.5 7865.7 7918.5 7974.8 8024.7 8844.6 10032.4 10174.1 10224.6 10233.3 08:26:54 INFO - PROCESS | 29023 | 08:26:54 INFO - PROCESS | 29023 | [#3] mootools.html Cycles:180 Average:5467.29 Median:5130.59 stddev:2982.54 (58.1%) stddev-sans-first:2976.11 08:26:54 INFO - PROCESS | 29023 | Values: 1514.0 1541.6 1639.0 1744.8 1785.7 7109.1 7800.6 7925.4 8077.8 8102.6 7959.9 7977.8 8039.2 8049.2 8055.5 2274.1 2318.4 2322.6 2323.2 2324.9 2284.5 2288.8 2324.4 2335.7 2338.1 2299.9 2308.3 2309.8 2326.4 2335.0 2221.0 2263.4 2271.7 2275.1 2279.1 2215.6 2216.2 2242.9 2243.5 2246.8 8087.9 8210.3 8216.1 8219.5 8258.6 4923.6 5164.7 5173.7 5189.9 5191.9 3123.2 3184.5 3312.1 3331.6 3334.0 1039.5 1057.9 1065.8 1089.4 1124.2 11045.4 11065.3 11101.5 11122.5 11123.2 4416.8 4473.5 4535.7 4603.9 4604.8 9473.6 9507.9 9531.4 9533.2 9533.6 5056.9 5128.3 5147.2 5154.3 5176.5 4105.8 4668.3 4704.0 4792.3 4793.3 3788.9 3808.4 3831.6 3892.2 3914.7 1200.2 1221.7 1229.3 1245.7 1266.4 898.9 901.1 904.2 954.1 957.8 5482.9 5834.3 5893.7 5914.3 6016.1 933.9 950.5 993.6 1010.9 1015.7 3871.9 4091.4 4097.8 4099.3 4149.8 9665.6 10185.3 10250.2 10257.8 10264.5 10034.7 10122.4 10153.3 10157.5 10167.7 7447.5 7619.2 7677.2 7687.1 7729.2 5751.9 5800.7 5904.7 5963.1 5991.5 9223.9 9353.9 9442.8 9449.4 9497.8 9277.4 9554.3 9630.9 9713.9 9753.4 7099.2 7175.1 7205.9 7216.6 7290.9 7879.5 7916.4 7942.3 7951.4 7973.4 7223.2 7364.1 7401.1 7407.2 7427.5 6633.1 6694.3 6709.4 6756.3 6773.2 6337.3 6359.8 6365.0 6394.2 6402.6 4884.8 5072.7 5080.7 5086.7 5132.9 5041.4 5093.3 5097.8 5202.8 5211.0 08:26:54 INFO - PROCESS | 29023 | 08:26:54 INFO - PROCESS | 29023 | [#4] prototype.html Cycles:180 Average:4988.24 Median:5561.18 stddev:1488.89 (26.8%) stddev-sans-first:1451.47 08:26:54 INFO - PROCESS | 29023 | Values: 332.1 334.7 337.4 339.2 355.1 5376.9 5416.6 5434.2 5508.0 5546.3 5493.8 5501.6 5509.4 5518.4 5576.1 4315.2 4315.5 4330.2 4337.0 4337.8 4210.3 4341.1 4364.8 4369.4 4386.6 4300.4 4309.2 4326.2 4341.6 4357.9 4315.4 4318.2 4337.8 4341.2 4347.3 3581.3 3831.4 3850.2 3852.7 3855.7 5363.5 5372.9 5380.7 5397.8 5403.6 4898.2 4907.3 4927.8 4932.8 4958.9 5524.3 5801.2 5838.2 5838.9 5853.9 4118.8 4129.4 4138.0 4143.7 4161.7 5983.6 6012.8 6062.2 6074.4 6091.5 4155.7 4200.6 4207.8 4242.8 4255.7 4267.1 4282.3 4282.8 4290.9 4303.4 4923.3 4929.0 4935.4 4935.5 4965.4 5500.2 5694.3 5843.8 5869.8 5900.2 1552.4 1553.0 1554.7 1556.3 1556.8 1017.0 1034.9 1048.7 1053.6 1053.7 6020.9 6036.0 6038.3 6049.8 6070.3 6383.0 6395.2 6405.8 6422.2 6447.9 5885.2 5994.5 5999.9 6031.6 6041.2 3378.4 3413.4 3416.9 3417.1 3433.0 6447.7 6538.4 6614.4 6626.8 6640.8 6524.6 6525.6 6547.6 6573.1 6583.6 5950.6 6234.4 6613.2 6623.1 6625.6 6028.9 6031.3 6036.8 6077.5 6100.1 5957.5 5983.8 5988.4 6000.6 6014.0 5854.6 6211.4 6229.8 6259.4 6269.8 4268.1 4306.8 4310.1 4325.3 4328.2 5893.5 6005.8 6012.5 6020.3 6071.4 5787.3 5856.5 5871.4 5877.9 5915.6 5789.4 5844.5 5895.4 5899.7 5910.0 5657.4 5762.1 5799.5 5829.6 5829.7 5898.8 5909.3 5915.7 5934.5 5943.7 5657.5 5761.2 5765.6 5790.5 5807.8 08:26:54 INFO - PROCESS | 29023 | 08:26:54 INFO - PROCESS | 29023 | [#5] yui.html Cycles:180 Average:14430.09 Median:24552.75 stddev:16349.27 (66.6%) stddev-sans-first:16362.59 08:26:54 INFO - PROCESS | 29023 | Values: 694.6 725.5 760.7 837.9 854.0 14202.9 14665.4 14747.3 14755.6 14772.4 12261.1 13351.8 14246.9 14270.4 14323.9 826.2 828.0 831.7 833.0 835.2 807.4 810.4 815.0 815.1 817.8 865.6 867.7 869.0 869.9 871.6 860.6 861.6 862.8 863.4 864.5 635.4 639.2 639.4 640.0 640.9 12026.9 12077.6 12114.8 13372.8 13669.8 11772.2 11808.0 11919.6 11965.1 12085.5 10557.2 10662.7 10711.7 10830.2 10882.5 3758.9 4468.5 4516.3 4548.1 4776.9 47895.8 51369.7 53146.5 53551.7 53891.7 11377.7 11503.7 11739.6 11816.3 11931.3 20405.0 20467.6 20534.6 20629.8 20633.1 8913.2 8919.1 8966.7 9215.2 9351.0 4877.5 4904.3 4927.4 4982.2 4995.6 3423.9 3530.7 3542.5 3542.8 3543.8 614.4 624.7 630.6 639.2 643.2 642.5 695.9 704.9 762.2 768.6 8925.0 9011.5 9108.2 9272.6 9285.9 654.8 706.8 747.1 758.7 761.9 4061.9 4227.5 4246.4 4257.8 4283.7 58839.7 59595.7 61226.0 61344.7 62119.7 48837.8 48868.3 51262.5 55265.2 55787.0 40055.0 44912.0 49984.3 50166.2 50234.5 8974.2 9295.6 9406.0 9409.3 9444.2 32362.8 32707.7 33156.8 33525.0 33799.8 41374.8 44100.6 44146.6 44637.0 45001.8 12504.7 12653.8 12745.7 12915.9 13043.9 12886.4 13056.7 13636.3 13950.3 14140.8 12556.3 12685.6 12782.5 12804.7 12959.2 11737.9 11768.3 11791.8 12141.0 12165.5 10739.6 10959.2 11672.8 11895.2 11913.3 10621.7 10669.0 10695.6 10792.4 11070.2 10219.9 10355.1 10457.2 10464.5 10490.0 08:26:54 INFO - PROCESS | 29023 | -------- Summary: end -------- 08:26:54 INFO - PROCESS | 29023 | 08:26:55 INFO - TEST-INFO | 29023: exit 0 08:26:55 INFO - TEST-OK | dromaeo_css | took 1109175ms 08:26:55 INFO - TEST-START | kraken 08:26:55 INFO - operating with platform_type : linux_ 08:26:55 INFO - Initialising browser for kraken test... 08:26:55 INFO - TEST-INFO | started process 29262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hlT0v/profile http://localhost:59117/getInfo.html) 08:26:58 INFO - PROCESS | 29262 | 08:26:58 INFO - PROCESS | 29262 | (process:29330): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:26:59 INFO - PROCESS | 29262 | __metrics Screen width/height:1600/1200 08:26:59 INFO - PROCESS | 29262 | colorDepth:24 08:26:59 INFO - PROCESS | 29262 | Browser inner width/height: 1024/697 08:26:59 INFO - PROCESS | 29262 | __metrics 08:27:00 ERROR - PROCESS | 29262 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:27:01 INFO - TEST-INFO | 29262: exit 0 08:27:01 INFO - Browser initialized. 08:27:01 INFO - Running cycle 1/1 for kraken test... 08:27:01 INFO - TEST-INFO | started process 29381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hlT0v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:03 INFO - PROCESS | 29381 | 08:27:03 INFO - PROCESS | 29381 | (process:29443): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:27:13 INFO - PROCESS | 29381 | RSS: Main: 165036032 08:27:13 INFO - PROCESS | 29381 | 08:27:15 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59117/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:16 INFO - PROCESS | 29381 | RSS: Main: 169148416 08:27:16 INFO - PROCESS | 29381 | 08:27:19 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59117/tests/kraken/driver.html?testName=audio-dft) 08:27:19 INFO - PROCESS | 29381 | RSS: Main: 172974080 08:27:19 INFO - PROCESS | 29381 | 08:27:22 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59117/tests/kraken/driver.html?testName=audio-fft) 08:27:23 INFO - PROCESS | 29381 | RSS: Main: 162754560 08:27:23 INFO - PROCESS | 29381 | 08:27:25 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59117/tests/kraken/driver.html?testName=audio-oscillator) 08:27:25 INFO - PROCESS | 29381 | RSS: Main: 163229696 08:27:25 INFO - PROCESS | 29381 | 08:27:28 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:28 INFO - PROCESS | 29381 | RSS: Main: 164950016 08:27:28 INFO - PROCESS | 29381 | 08:27:31 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59117/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:32 INFO - PROCESS | 29381 | RSS: Main: 165085184 08:27:32 INFO - PROCESS | 29381 | 08:27:35 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59117/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:36 INFO - PROCESS | 29381 | RSS: Main: 164999168 08:27:36 INFO - PROCESS | 29381 | 08:27:39 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59117/tests/kraken/driver.html?testName=json-parse-financial) 08:27:39 INFO - PROCESS | 29381 | RSS: Main: 167280640 08:27:39 INFO - PROCESS | 29381 | 08:27:41 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:42 INFO - PROCESS | 29381 | RSS: Main: 167346176 08:27:42 INFO - PROCESS | 29381 | 08:27:43 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59117/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:44 INFO - PROCESS | 29381 | RSS: Main: 167198720 08:27:44 INFO - PROCESS | 29381 | 08:27:46 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:27:47 INFO - PROCESS | 29381 | RSS: Main: 167411712 08:27:47 INFO - PROCESS | 29381 | 08:27:49 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:27:50 INFO - PROCESS | 29381 | RSS: Main: 168153088 08:27:50 INFO - PROCESS | 29381 | 08:27:53 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:27:53 INFO - PROCESS | 29381 | RSS: Main: 168206336 08:27:53 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:59117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59117/tests/kraken/driver.html?testName=ai-astar) 08:27:55 INFO - PROCESS | 29381 | RSS: Main: 169881600 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | __start_tp_report 08:27:55 INFO - PROCESS | 29381 | _x_x_mozilla_page_load 08:27:55 INFO - PROCESS | 29381 | _x_x_mozilla_page_load_details 08:27:55 INFO - PROCESS | 29381 | |i|pagename|runs| 08:27:55 INFO - PROCESS | 29381 | |0;ai-astar;110;104;110;111;111;123;111;112;110;109 08:27:55 INFO - PROCESS | 29381 | |1;audio-beat-detection;151;129;152;180;129;162;161;124;186;128 08:27:55 INFO - PROCESS | 29381 | |2;audio-dft;162;163;162;161;164;165;175;162;172;162 08:27:55 INFO - PROCESS | 29381 | |3;audio-fft;73;78;73;166;75;73;77;77;163;78 08:27:55 INFO - PROCESS | 29381 | |4;audio-oscillator;93;92;165;93;93;93;148;93;93;147 08:27:55 INFO - PROCESS | 29381 | |5;imaging-gaussian-blur;117;117;118;116;117;117;117;117;117;117 08:27:55 INFO - PROCESS | 29381 | |6;imaging-darkroom;146;147;147;146;146;147;149;148;147;146 08:27:55 INFO - PROCESS | 29381 | |7;imaging-desaturate;95;95;96;95;96;95;95;95;95;95 08:27:55 INFO - PROCESS | 29381 | |8;json-parse-financial;60;69;63;61;60;69;63;85;59;67 08:27:55 INFO - PROCESS | 29381 | |9;json-stringify-tinderbox;61;62;63;62;62;62;62;62;63;63 08:27:55 INFO - PROCESS | 29381 | |10;stanford-crypto-aes;76;86;83;77;79;77;78;76;78;78 08:27:55 INFO - PROCESS | 29381 | |11;stanford-crypto-ccm;131;136;134;128;124;124;128;122;170;137 08:27:55 INFO - PROCESS | 29381 | |12;stanford-crypto-pbkdf2;169;167;172;167;168;169;169;168;168;169 08:27:55 INFO - PROCESS | 29381 | |13;stanford-crypto-sha256-iterative;71;70;77;74;76;70;67;68;73;70 08:27:55 INFO - PROCESS | 29381 | __end_tp_report 08:27:55 INFO - PROCESS | 29381 | __start_cc_report 08:27:55 INFO - PROCESS | 29381 | _x_x_mozilla_cycle_collect,839 08:27:55 INFO - PROCESS | 29381 | __end_cc_report 08:27:55 INFO - PROCESS | 29381 | __startTimestamp1461943675808__endTimestamp 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | ------- Summary: start ------- 08:27:55 INFO - PROCESS | 29381 | Number of tests: 14 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:4.72 (4.3%) stddev-sans-first:4.99 08:27:55 INFO - PROCESS | 29381 | Values: 110.0 104.0 110.0 111.0 111.0 123.0 111.0 112.0 110.0 109.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:156.50 stddev:22.38 (14.3%) stddev-sans-first:23.74 08:27:55 INFO - PROCESS | 29381 | Values: 151.0 129.0 152.0 180.0 129.0 162.0 161.0 124.0 186.0 128.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:4.78 (2.9%) stddev-sans-first:4.96 08:27:55 INFO - PROCESS | 29381 | Values: 162.0 163.0 162.0 161.0 164.0 165.0 175.0 162.0 172.0 162.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:37.59 (49.5%) stddev-sans-first:39.14 08:27:55 INFO - PROCESS | 29381 | Values: 73.0 78.0 73.0 166.0 75.0 73.0 77.0 77.0 163.0 78.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:93.00 stddev:29.60 (31.8%) stddev-sans-first:30.67 08:27:55 INFO - PROCESS | 29381 | Values: 93.0 92.0 165.0 93.0 93.0 93.0 148.0 93.0 93.0 147.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 08:27:55 INFO - PROCESS | 29381 | Values: 117.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 08:27:55 INFO - PROCESS | 29381 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 149.0 148.0 147.0 146.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:27:55 INFO - PROCESS | 29381 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:7.76 (11.9%) stddev-sans-first:7.97 08:27:55 INFO - PROCESS | 29381 | Values: 60.0 69.0 63.0 61.0 60.0 69.0 63.0 85.0 59.0 67.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 08:27:55 INFO - PROCESS | 29381 | Values: 61.0 62.0 63.0 62.0 62.0 62.0 62.0 62.0 63.0 63.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:3.22 (4.1%) stddev-sans-first:3.26 08:27:55 INFO - PROCESS | 29381 | Values: 76.0 86.0 83.0 77.0 79.0 77.0 78.0 76.0 78.0 78.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:132.50 stddev:13.87 (10.5%) stddev-sans-first:14.68 08:27:55 INFO - PROCESS | 29381 | Values: 131.0 136.0 134.0 128.0 124.0 124.0 128.0 122.0 170.0 137.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.00 stddev:1.43 (0.8%) stddev-sans-first:1.51 08:27:55 INFO - PROCESS | 29381 | Values: 169.0 167.0 172.0 167.0 168.0 169.0 169.0 168.0 168.0 169.0 08:27:55 INFO - PROCESS | 29381 | 08:27:55 INFO - PROCESS | 29381 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:3.31 (4.6%) stddev-sans-first:3.50 08:27:55 INFO - PROCESS | 29381 | Values: 71.0 70.0 77.0 74.0 76.0 70.0 67.0 68.0 73.0 70.0 08:27:55 INFO - PROCESS | 29381 | -------- Summary: end -------- 08:27:55 INFO - PROCESS | 29381 | 08:27:56 INFO - TEST-INFO | 29381: exit 0 08:27:56 INFO - TEST-OK | kraken | took 61379ms 08:27:56 INFO - SUITE-END | took 1170s 08:27:56 INFO - Completed test suite (00:19:30) 08:27:56 INFO - javascript benchmark 08:27:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.1370123216116, 3190.984045079774, 3222.7744057915947, 3260.087175590834, 3260.136063943054, 5421.268128802611, 5428.972855135724, 5442.727863606824, 5442.9727851360685, 5459.317585301837, 5358.33020872391, 5396.271503347047, 5446.591505637073, 5487.588430867681, 5506.504414602685, 4858.975705121469, 4904.435989861158, 4960.60315174787, 4980.850574482772, 5034.169362055275, 737.5914975208667, 4919.631027672921, 4935.457099719028, 4966.180580204262, 4981.925271120918, 4918.655694101414, 4921.384826896638, 4933.309336692866, 4947.975260123712, 4981.0, 4786.066716990188, 4949.826756063557, 4968.1554135797005, 4970.15507363749, 5010.749462526859, 4929.704217746911, 4932.778024988848, 4948.38145231846, 4962.578180854632, 4970.130227210224, 5221.530062294411, 5231.843044708665, 5249.816256431045, 5266.368035835724, 5292.44429334922, 5744.368119506851, 5753.741081651336, 5756.510696590753, 5765.1928729977835, 5840.737166827503, 5741.684207368593, 5792.768289268424, 5792.971035144839, 5795.072788353886, 5845.064789633639, 5394.24480572724, 5395.136778115482, 5397.325334333208, 5397.4062853086125, 5414.07960646691, 5774.220480235114, 5874.500667443315, 5902.055671092605, 5998.610090344114, 6013.218281623361, 5708.4862362387585, 5754.6547207167705, 5774.653520788682, 5782.045962416239, 5796.1595568642315, 5841.503472204825, 5862.5896187267335, 5862.912056319158, 5869.618474799125, 5874.823755287348, 5696.857578560569, 5832.475077242983, 5869.090291004901, 5900.380460051719, 5923.0, 5649.745761440745, 5783.566232532577, 5833.125031245348, 5881.735321910524, 5921.822345329647, 4285.250081235771, 4315.438992930899, 4319.43847299849, 4330.588594083557, 4373.562643735665, 3834.0989867381145, 3876.7286289959998, 3903.5706072332023, 3921.9607803922167, 3952.8023598819946, 5500.367457742331, 5508.44915508446, 5509.834704958857, 5509.889802203934, 5545.251391062155, 5735.655860648374, 5752.28096487939, 5759.568032397587, 5785.190073389729, 5785.681787501728, 5569.777208911679, 5570.888582228414, 5592.217089607459, 5644.6613203207935, 5644.689542075225, 4797.496262892416, 4801.807927682923, 4804.231322988305, 4813.590844778163, 4841.273808928619, 5929.881402371929, 6027.397260274025, 6028.186194863637, 6028.819135425944, 6039.245094363205, 5778.451047150514, 5803.274590676166, 5840.620359676607, 5864.296284445893, 5891.440313170242, 5949.494292985145, 5960.8807823844145, 5961.582689211714, 5973.611715238496, 5973.970130149321, 5648.604597678123, 5658.547316214611, 5662.971685141548, 5665.546756259571, 5665.915011274752, 5715.599908006399, 5869.530437564899, 5942.049272116614, 5975.193348898017, 5980.970095149496, 5630.0, 5635.042042852643, 5641.520470759867, 5675.290588676416, 5687.090065589486, 5573.27547418833, 5592.468715472024, 5594.608377413542, 5594.608377413705, 5596.776128954959, 5578.442155784389, 5609.5512359012, 5616.466435688603, 5633.4084921082695, 5633.408492108433, 5641.746121424628, 5665.801696940587, 5666.065099258741, 5676.063449530781, 5698.572607054571, 5361.115415956324, 5555.083411237262, 5559.27729395176, 5562.249096371938, 5566.276384070045], "value": 5308.898104978305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.8862116197922, 623.3392603839927, 640.113442881609, 652.7193306878042, 660.9933900660992, 37328.0, 38852.41721374175, 38887.805560972156, 38905.805470972606, 38917.61082389175, 41183.58816411835, 41838.37242441366, 41945.37081943773, 42076.0, 42224.577754222446, 8625.95687021564, 8762.780930476725, 8762.956185219065, 8835.116488351177, 8848.690295839648, 8515.701950431736, 8572.871406928902, 8659.870101948476, 8684.478931264113, 8812.823743525125, 8903.287736981027, 8934.419262747933, 8957.37298389113, 8991.235744961687, 9036.0, 8888.24449921751, 8891.0, 8936.151065648754, 8936.776580585472, 8968.955155224246, 8918.19736223743, 9006.639734410615, 9013.324000699973, 9023.187913087853, 9045.276377889819, 42294.731158065304, 42636.78681606603, 42862.142757145, 42992.0, 43000.0, 3520.436730123168, 3586.7668601540818, 3601.1537288737127, 3791.3554695701796, 4388.429504164438, 29679.25801854971, 30774.692253077406, 30958.380832383453, 30959.38081238385, 31060.844695776377, 3816.103215744298, 3825.7513261637905, 3854.2914171656685, 3871.496705428276, 3918.235943990923, 293757.0, 294355.0, 295462.0, 296322.0, 297107.99999999785, 62789.0, 63335.29982301615, 63406.0, 63505.68247158827, 63571.36428635747, 57013.0, 58549.70725146347, 58594.0, 58657.41342586605, 58864.70567647134, 17299.394521191698, 17489.912550437166, 17516.737248941277, 17548.912255438896, 17556.473305800846, 13375.598732038054, 13408.731825363633, 13419.127756695783, 13438.126521776054, 13452.932735336457, 19155.529343556023, 19579.490151795217, 20090.296839610837, 20204.191832326836, 20276.594468110554, 7174.820629484305, 7191.352778249982, 7457.403407727369, 7578.204288549623, 7686.769396918102, 1038.4132964874973, 1049.9395610433517, 1070.4433694478982, 1081.2809481694585, 1145.931244125355, 30757.231069223002, 30938.0, 31589.84205079006, 32169.678303217137, 33047.00858974235, 1102.795982743195, 1190.8392367030513, 1197.5569039455456, 1259.4206664934234, 1277.3740866975302, 16837.831621683872, 17105.0, 17124.657506849795, 17282.567935801453, 17408.303667853143, 454627.0, 462051.0, 464843.0, 465113.0, 467846.0, 57465.0, 59014.70492647509, 59389.406105939255, 59469.40530594725, 59499.0, 1321.3723481346476, 1403.880670143029, 1406.901516893828, 1410.8994983912564, 1422.672785259396, 30528.542071868495, 30919.2270193247, 31338.373232535676, 31691.366172675956, 31890.362192756478, 51712.0, 51921.740391297804, 52162.0, 52327.476725233784, 52352.0, 392140.0, 394127.0, 396288.0, 396810.0, 397311.0, 28263.29341766472, 28278.0, 28681.856590716914, 28699.713002869703, 28845.423091538472, 48756.5124348752, 49062.26406603975, 49383.0, 49407.25889111594, 50659.0, 40283.0, 41099.92415341868, 41657.37513937354, 41766.79116604398, 42175.0, 40026.0, 40721.79639101786, 40906.18187636171, 41430.1713965725, 41966.0, 37079.814600926824, 37670.62329376671, 37865.81067094647, 38283.0, 40437.39343909785, 30239.395212095194, 32362.83818580892, 32449.0, 32548.674513254566, 33407.331853363285, 25934.481310374063, 26707.369301714123, 27905.581416278364, 28014.0, 28319.0], "value": 19893.556101089536, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.2201733680002, 413.8406713415336, 415.8939470435039, 416.1136778661453, 417.7597881218297, 13600.93199534001, 17861.910690446544, 18743.4376968691, 18767.2493100276, 18781.0, 17337.306507739675, 17597.824021759778, 17943.461696149105, 18112.728309075374, 18236.088195590233, 5435.592330575223, 5591.608587398884, 5749.971250143743, 5773.018586840247, 5816.738246778884, 5634.183043458716, 5651.2935883014625, 5662.235598194232, 5712.428757124296, 5713.71431428429, 6409.391107844771, 6449.709763060673, 6450.4194622483965, 6451.580647257937, 6454.7413254415405, 5714.314282286152, 5727.198192253088, 5957.285125784933, 6375.808725738212, 6388.680565971706, 5562.221289019541, 5567.415421380737, 5596.188552659842, 5602.859928501779, 5631.239782629334, 12603.306818125, 13271.86728132716, 13403.46386144553, 13429.194248345131, 13606.591802245948, 2157.2880949286696, 2181.8036376726172, 2258.6499092640665, 2382.4163080045328, 2626.868656567164, 9875.0, 11039.282446640942, 12534.874651253462, 13415.530456433979, 13771.517996870161, 1897.990510047441, 2001.259533972425, 2013.9395818125479, 2036.8472364572717, 2042.6323261812868, 76897.61551192208, 78464.60767696182, 79532.0, 80656.59671701604, 81220.0, 10757.9462102689, 10840.13278937683, 10924.836127458095, 11123.887611238812, 11142.27575207609, 15184.46854360092, 15273.694526109415, 15276.923615382075, 15311.770323445156, 15349.6162595936, 8039.477433966774, 8191.590420479071, 8233.406476959739, 8335.874961875577, 8366.414350995494, 7783.338416234684, 7960.243776841191, 8029.116797152308, 8081.070676872235, 8083.555404452694, 4674.205385084544, 4675.158471475167, 4744.810207591658, 4788.592969597554, 4796.856094317176, 1915.4636701723539, 1975.6740137877089, 1976.9802301977084, 2053.414776788608, 2063.2778527515547, 944.9622015119318, 1044.639599338227, 1052.4001319247955, 1067.8024565455416, 1085.3759088523973, 17993.460196194133, 18718.0, 18762.530936726416, 18858.15138318779, 18912.0, 1021.8875923648393, 1040.432964034603, 1073.5974009746344, 1082.1613249731363, 1118.6308518188978, 10259.487025648688, 10530.15758739299, 10562.683119506428, 10612.628558000433, 10642.680719578426, 488352.0, 493052.0, 499036.0, 502082.0, 503733.0, 75593.0, 82665.58667206626, 85555.0, 90128.54935725279, 93154.0, 1032.6230925712061, 1039.0907955538903, 1069.1500257295468, 1071.8552995345528, 1077.4612693653173, 16392.11490678587, 16406.425775097814, 16784.664306714043, 16967.321307147577, 16970.91514542469, 36320.0, 36580.451293231155, 36825.81587092047, 36862.94507604108, 38331.041723957125, 51084.744576276884, 51658.48341516537, 51812.22281665703, 52746.0, 52949.0, 7989.560574168477, 7998.880016799636, 8018.238267364591, 8064.758057258292, 8148.592570371339, 8624.439411438236, 11270.323780573191, 12099.092568057607, 12392.442340094538, 12416.0, 10620.0, 10803.729906752395, 10886.564537418415, 10957.342559446459, 11134.721631959266, 10481.0, 10966.287191332856, 11082.556697732, 11082.778344433227, 11147.609833655782, 11076.169287303323, 11261.831072534082, 11405.942970285096, 11488.080953523866, 11563.248388854698, 7666.4633475656165, 7865.685372585262, 7918.524888506708, 7974.800629984296, 8024.679012839421, 8844.55777211124, 10032.398056116657, 10174.13519850821, 10224.591016359262, 10233.283670143317], "value": 8931.359066499084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.9924300378495, 1541.560655213264, 1638.9508314750553, 1744.8342407471293, 1785.6964316066267, 7109.075820143387, 7800.570968596725, 7925.445218834684, 8077.7576672699915, 8102.5543595102245, 7959.920400795991, 7977.800554986128, 8039.196080391958, 8049.1950804919625, 8055.476394034384, 2274.1130958926033, 2318.420394901275, 2322.628379459287, 2323.1984965186984, 2324.883755812211, 2284.49741056968, 2288.8168946484243, 2324.4421338878633, 2335.696359473266, 2338.0647740903605, 2299.8850057497057, 2308.2613563659634, 2309.7690230976937, 2326.4067662745974, 2334.9533009339802, 2220.966685499719, 2263.4454558633242, 2271.716035495563, 2275.0672224388004, 2279.1453205048024, 2215.5679642469727, 2216.1578600132007, 2242.8990695418747, 2243.4839986803127, 2246.831487638434, 8087.919120808834, 8210.30212431944, 8216.055153657346, 8219.506829590244, 8258.628361723737, 4923.606111511071, 5164.690118592896, 5173.689578625257, 5189.922151167735, 5191.922121168185, 3123.2348074721613, 3184.50640150777, 3312.138843900579, 3331.5502407174963, 3334.0164651427885, 1039.5426012554528, 1057.894210578936, 1065.8134826405426, 1089.4062735809002, 1124.1568823382463, 11045.39250341223, 11065.336079835235, 11101.500432480478, 11122.49948752308, 11123.221374503788, 4416.823327066945, 4473.507914129443, 4535.682502224812, 4603.861884143481, 4604.815807367668, 9473.621055157717, 9507.904920950841, 9531.428114313025, 9533.237341012702, 9533.618655253713, 5056.924146137811, 5128.282040514331, 5147.2279158126585, 5154.278401023859, 5176.50823171798, 4105.753654780723, 4668.299755036704, 4704.0, 4792.329073929653, 4793.32893394925, 3788.9431658525145, 3808.3716186828865, 3831.6168383162017, 3892.2215556888737, 3914.6868250539887, 1200.17188140183, 1221.6640423883325, 1229.3238718704856, 1245.7197130645532, 1266.3984607311638, 898.851689471243, 901.0944001278673, 904.2088172848757, 954.054483361132, 957.8275910336206, 5482.945170548243, 5834.27071616048, 5893.705314734246, 5914.349421563625, 6016.127661489059, 933.883264591926, 950.4819873169139, 993.5926270229315, 1010.8685870836745, 1015.6648306058983, 3871.903202419962, 4091.3862920562156, 4097.795110244476, 4099.282625540519, 4149.834006639761, 9665.613375465044, 10185.33795303303, 10250.231232657581, 10257.846132308021, 10264.538095785707, 10034.74913127163, 10122.44326562046, 10153.289269751194, 10157.492125393701, 10167.694969150938, 7447.478676492594, 7619.238076192337, 7677.23227677239, 7687.115981662068, 7729.188435214334, 5751.8562035949435, 5800.738966746591, 5904.675242861512, 5963.075723262901, 5991.520678345635, 9223.907760922304, 9353.859692104488, 9442.763930901509, 9449.385789923634, 9497.810043799223, 9277.443353398818, 9554.331196816156, 9630.903690963001, 9713.854292185482, 9753.366031207948, 7099.246913641663, 7175.067241258812, 7205.891911621225, 7216.5670059796585, 7290.927090729025, 7879.527228366316, 7916.366690664618, 7942.285194332538, 7951.363890888831, 7973.401994850526, 7223.1693355264815, 7364.116306043309, 7401.0748656417945, 7407.222241664547, 7427.517211381243, 6633.071370008299, 6694.330566943267, 6709.429698475684, 6756.256811750802, 6773.221079575912, 6337.302896681269, 6359.841003974938, 6364.968175159094, 6394.200724909387, 6402.583832050902, 4884.82347592803, 5072.746362681925, 5080.669756465818, 5086.720230387365, 5132.897342053064, 5041.42023667283, 5093.312402825572, 5097.8215762448135, 5202.791888324425, 5211.009908117446], "value": 4445.475407021061, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.05364710574855, 334.6954271612833, 337.35733427820014, 339.23333266816996, 355.0750295480272, 5376.892462150755, 5416.618762215634, 5434.184872269162, 5507.972460137698, 5546.278983732109, 5493.7802487900435, 5501.559875209983, 5509.421510741375, 5518.427248234254, 5576.079946808772, 4315.244832154376, 4315.4605674290715, 4330.155619654169, 4336.97831510842, 4337.761423121727, 4210.263203939314, 4341.110072435144, 4364.825406983717, 4369.410129632507, 4386.605205531501, 4300.419443375135, 4309.159713855799, 4326.242907491192, 4341.565843415665, 4357.912841743163, 4315.424869922487, 4318.201132790444, 4337.826486940518, 4341.218580655496, 4347.2826983547675, 3581.2658405026905, 3831.4252862070634, 3850.2299540091813, 3852.749571277886, 3855.6915446764474, 5363.463653634644, 5372.925414917032, 5380.704061276629, 5397.757100930428, 5403.567714582824, 4898.24077268024, 4907.337509436216, 4927.802887884516, 4932.827351042696, 4958.900821983576, 5524.309461317335, 5801.187833703285, 5838.182654428383, 5838.941610583882, 5853.9170253503235, 4118.75287482752, 4129.442525259082, 4137.965508622844, 4143.6685065195015, 4161.708680392374, 5983.611065280743, 6012.78955236569, 6062.181605483292, 6074.3925607438905, 6091.451769340736, 4155.709100363006, 4200.5799420058365, 4207.810648520824, 4242.787860606957, 4255.723377980421, 4267.146570685875, 4282.250606143913, 4282.764447955392, 4290.871273861727, 4303.376010478463, 4923.335349727741, 4928.975355123202, 4935.407751069823, 4935.4570997190995, 4965.404151501771, 5500.22996780451, 5694.259746232963, 5843.824685259449, 5869.7945571904775, 5900.232969713909, 1552.3712896277025, 1552.9922350388176, 1554.7201503729436, 1556.3385561136472, 1556.836532164129, 1016.9559186036121, 1034.912032477248, 1048.6786648822538, 1053.578568572577, 1053.7312985188728, 6020.909686354708, 6035.969820150871, 6038.33578306386, 6049.758009679564, 6070.3019152798, 6382.978723404233, 6395.16862807832, 6405.807825765234, 6422.2293324800385, 6447.903281450782, 5885.176075349455, 5994.460498555064, 5999.910001349983, 6031.612729072338, 6041.24484439445, 3378.391889459921, 3413.368526822546, 3416.8633254669535, 3417.111550996709, 3432.982835085809, 6447.743289848516, 6538.411542961061, 6614.404703576605, 6626.801195964033, 6640.83397915056, 6524.608523488606, 6525.608463492205, 6547.639879806657, 6573.112629795012, 6583.604983700993, 5950.613210141327, 6234.352903551473, 6613.173353330833, 6623.138991931018, 6625.569337993015, 6028.939710602838, 6031.336552979256, 6036.8188954331445, 6077.51379889599, 6100.1459795629535, 5957.493613042767, 5983.820485385445, 5988.431099045583, 6000.609960352563, 6013.969930150496, 5854.619449735754, 6211.409916057967, 6229.844253893689, 6259.405356491126, 6269.811905642838, 4268.061026574149, 4306.763128027988, 4310.116426132698, 4325.329573916048, 4328.177646247203, 5893.469587736953, 6005.819825405245, 6012.458878700938, 6020.30766461845, 6071.392860713893, 5787.3411903418155, 5856.531477481706, 5871.412858714094, 5877.882442351043, 5915.585908986502, 5789.3921138279875, 5844.47399734026, 5895.351511333835, 5899.734511947058, 5910.0, 5657.3776884543495, 5762.081784386657, 5799.5070419014855, 5829.59192856496, 5829.737661805144, 5898.8230353089475, 5909.261342332208, 5915.733791979285, 5934.525237980864, 5943.732532035982, 5657.5473962082115, 5761.164631128547, 5765.5675824314185, 5790.507806836466, 5807.82576522705], "value": 4516.015041171266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.6353164588587, 725.5102805606211, 760.6805141840426, 837.8617528107862, 853.9871901921471, 14202.857971420282, 14665.413383464649, 14747.262636868167, 14755.631109222248, 14772.409103635842, 12261.080418968591, 13351.799723004162, 14246.857531424683, 14270.429182832675, 14323.928380358084, 826.2274773087153, 828.0436096308742, 831.6922738586732, 833.0253603284142, 835.1564919431388, 807.3823525003377, 810.4326971120239, 815.0, 815.1237419773737, 817.8364327134567, 865.5931712095337, 867.6746220167437, 869.0310304011045, 869.9217070463657, 871.5816408124105, 860.6299291304737, 861.5519929636586, 862.8188080503134, 863.3956230638578, 864.5374724522413, 635.3741564558906, 639.2361128451503, 639.3606393606393, 639.9904001439982, 640.9230892292908, 12026.879731202664, 12077.637670869888, 12114.81827772584, 13372.799408008888, 13669.794953075612, 11772.234804737665, 11808.0, 11919.642410727693, 11965.102617303737, 12085.456154472982, 10557.155427565853, 10662.73343166427, 10711.732206694816, 10830.241883068189, 10882.510287037023, 3758.906027349311, 4468.508464068982, 4516.322551617251, 4548.11311794197, 4776.880577985578, 47895.76052119752, 51369.743151284376, 53146.468535314925, 53551.732241338934, 53891.730541347046, 11377.715557111138, 11503.654890353302, 11739.647810565697, 11816.291022538675, 11931.343776092224, 20404.97975101239, 20467.590648186953, 20534.58930821405, 20629.79370206309, 20633.071511782007, 8913.153250441197, 8919.108089191159, 8966.730998070068, 9215.216706580015, 9351.0, 4877.487863774252, 4904.288878112654, 4927.384076990376, 4982.177940639826, 4995.575376093073, 3423.880164194291, 3530.735194860396, 3542.5040494330815, 3542.840572174207, 3543.7696549724187, 614.3764079459353, 624.6626821516421, 630.5680608782999, 639.1850390751829, 643.2217017408894, 642.4892210692417, 695.9164900212007, 704.8660754456739, 762.2482836958575, 768.5542385416556, 8925.0, 9011.504367259864, 9108.225800806873, 9272.629094836266, 9285.907140928639, 654.8362909272682, 706.7702996526046, 747.0624366420108, 758.7003133762133, 761.9238076192447, 4061.918761624751, 4227.492700875853, 4246.363045543131, 4257.765822879709, 4283.7001409901, 58839.70580147072, 59595.702021490484, 61226.0, 61344.69327653333, 62119.68940155361, 48837.755811221425, 48868.26697599468, 51262.48737512652, 55265.1710224347, 55787.0, 40055.0, 44912.0, 49984.25023624649, 50166.24750628744, 50234.49765502371, 8974.19232269099, 9295.628174872929, 9406.0, 9409.294302927445, 9444.197243234126, 32362.83818580892, 32707.672923270464, 33156.83421582876, 33525.0, 33799.83100084484, 41374.79312603418, 44100.55899441093, 44146.558534415526, 44637.0, 45001.77499112483, 12504.74990500203, 12653.810192847299, 12745.681357966125, 12915.895915057845, 13043.869561304266, 12886.355682216039, 13056.738865222833, 13636.318184090558, 13950.302484875512, 14140.78788818148, 12556.309402982924, 12685.619431417072, 12782.488700451877, 12804.679883003, 12959.222446653232, 11737.88262117368, 11768.293902365886, 11791.823122652995, 12141.0, 12165.513379465076, 10739.624113156002, 10959.178061645249, 11672.766544669228, 11895.167338286583, 11913.344766037604, 10621.734456638645, 10669.003914225683, 10695.572177112828, 10792.352458852494, 11070.225084244026, 10219.897801022193, 10355.119814815524, 10457.163426925676, 10464.529096190538, 10490.0], "value": 6717.588296971239, "unit": "score"}], "name": "dromaeo_css", "value": 7091.870199722725, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 111.0, 111.0, 123.0, 111.0, 112.0, 110.0, 109.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 152.0, 180.0, 129.0, 162.0, 161.0, 124.0, 186.0, 128.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 164.0, 165.0, 175.0, 162.0, 172.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 73.0, 166.0, 75.0, 73.0, 77.0, 77.0, 163.0, 78.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 165.0, 93.0, 93.0, 93.0, 148.0, 93.0, 93.0, 147.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 149.0, 148.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 69.0, 63.0, 61.0, 60.0, 69.0, 63.0, 85.0, 59.0, 67.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 86.0, 83.0, 77.0, 79.0, 77.0, 78.0, 76.0, 78.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 136.0, 134.0, 128.0, 124.0, 124.0, 128.0, 122.0, 170.0, 137.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 172.0, 167.0, 168.0, 169.0, 169.0, 168.0, 168.0, 169.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 77.0, 74.0, 76.0, 70.0, 67.0, 68.0, 73.0, 70.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1569.6999999999998, "alertThreshold": 2.0}]} 08:27:57 INFO - Return code: 0 08:27:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:27:57 ERROR - # TBPL SUCCESS # 08:27:57 INFO - Running post-action listener: _resource_record_post_action 08:27:57 INFO - Running post-run listener: _resource_record_post_run 08:27:58 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 538079232; Read time: 216; Write time: 497908 08:27:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 244736000; Read time: 204; Write time: 243760 08:27:58 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293257216; Read time: 12; Write time: 254124 08:27:58 INFO - Running post-run listener: _upload_blobber_files 08:27:58 INFO - Blob upload gear active. 08:27:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:27:58 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 08:27:58 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:27:58 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:27:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:27:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:27:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:27:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:59 INFO - (blobuploader) - INFO - Done attempting. 08:27:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:27:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:00 INFO - (blobuploader) - INFO - Done attempting. 08:28:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:00 INFO - Return code: 0 08:28:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:28:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e79e8af18692ad0a7a7de84601bb6b82e5ccbb61e7cab62d48947d0faadf3ab3c63c1006eb32fe32b850c3737b9192ecda5dbc74f6dfcecd17ffb670cab9c835", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1c5cd2901c8b0506ba3a723418466310af1ba83dd31ec2eba99bb93a3b6a9b3d19b1b202565e3aedfab783150946101f12de894c0547f541e428d8261a3474c"} 08:28:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:28:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:28:00 INFO - Contents: 08:28:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e79e8af18692ad0a7a7de84601bb6b82e5ccbb61e7cab62d48947d0faadf3ab3c63c1006eb32fe32b850c3737b9192ecda5dbc74f6dfcecd17ffb670cab9c835", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1c5cd2901c8b0506ba3a723418466310af1ba83dd31ec2eba99bb93a3b6a9b3d19b1b202565e3aedfab783150946101f12de894c0547f541e428d8261a3474c"} 08:28:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:28:00 INFO - Copying logs to upload dir... 08:28:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:28:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.967611 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-29 08:27:59.772389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 08:27:59.776044) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403 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/sha512/e79e8af18692ad0a7a7de84601bb6b82e5ccbb61e7cab62d48947d0faadf3ab3c63c1006eb32fe32b850c3737b9192ecda5dbc74f6dfcecd17ffb670cab9c835", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1c5cd2901c8b0506ba3a723418466310af1ba83dd31ec2eba99bb93a3b6a9b3d19b1b202565e3aedfab783150946101f12de894c0547f541e428d8261a3474c"} build_url:https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/adTBqv4ITFixW9svyYsvwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e79e8af18692ad0a7a7de84601bb6b82e5ccbb61e7cab62d48947d0faadf3ab3c63c1006eb32fe32b850c3737b9192ecda5dbc74f6dfcecd17ffb670cab9c835", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1c5cd2901c8b0506ba3a723418466310af1ba83dd31ec2eba99bb93a3b6a9b3d19b1b202565e3aedfab783150946101f12de894c0547f541e428d8261a3474c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 08:27:59.804933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:27:59.805685) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461939919.337040-1561870403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:27:59.889023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 08:27:59.889737) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 08:27:59.890363) ========= ========= Total master_lag: 0.17 =========