builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1462871860.89 results: success (0) buildid: 20160510014205 builduid: 2b9ef505fdaf4b6dba114cbc4a6d89fd revision: f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:40.893994) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:40.894493) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:40.894823) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:40.955358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:40.956818) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 02:17:41-- 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% 165M=0s 2016-05-10 02:17:41 (165 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133183 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.117927) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.118611) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009454 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.229901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.230273) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 --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 f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 --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=03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 02:17:41,379 truncating revision to first 12 chars 2016-05-10 02:17:41,379 Setting DEBUG logging. 2016-05-10 02:17:41,380 attempt 1/10 2016-05-10 02:17:41,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f612200731ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 02:17:41,691 unpacking tar archive at: fx-team-f612200731ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565694 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.810365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.810746) ========= script_repo_revision: f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.811203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.811503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 02:17:41.827406) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-10 02:17:41.827753) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:17:42 INFO - MultiFileLogger online at 20160510 02:17:42 in /builds/slave/test 02:17:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:17:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:17:42 INFO - {'append_to_log': False, 02:17:42 INFO - 'base_work_dir': '/builds/slave/test', 02:17:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:17:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:17:42 INFO - 'branch': 'Fx-Team-Non-PGO', 02:17:42 INFO - 'buildbot_json_path': 'buildprops.json', 02:17:42 INFO - 'config_files': ('talos/linux_config.py',), 02:17:42 INFO - 'default_actions': ('clobber', 02:17:42 INFO - 'read-buildbot-config', 02:17:42 INFO - 'download-and-extract', 02:17:42 INFO - 'populate-webroot', 02:17:42 INFO - 'create-virtualenv', 02:17:42 INFO - 'install', 02:17:42 INFO - 'run-tests'), 02:17:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:17:42 INFO - 'download_minidump_stackwalk': True, 02:17:42 INFO - 'download_symbols': 'ondemand', 02:17:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:17:42 INFO - 'tooltool.py': '/tools/tooltool.py', 02:17:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:17:42 INFO - '/tools/misc-python/virtualenv.py')}, 02:17:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:17:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:17:42 INFO - 'installer_path': 'installer.exe', 02:17:42 INFO - 'log_level': 'info', 02:17:42 INFO - 'log_name': 'talos', 02:17:42 INFO - 'log_to_console': True, 02:17:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:17:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:17:42 INFO - 'opt_config_files': (), 02:17:42 INFO - 'pip_index': False, 02:17:42 INFO - 'sps_profile': False, 02:17:42 INFO - 'sps_profile_interval': 0, 02:17:42 INFO - 'suite': 'dromaeojs', 02:17:42 INFO - 'system_bits': '32', 02:17:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:17:42 INFO - 'title': 'talos-linux64-ix-047', 02:17:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:17:42 INFO - 'use_talos_json': True, 02:17:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:17:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:17:42 INFO - 'work_dir': 'build'} 02:17:42 INFO - ##### 02:17:42 INFO - ##### Running clobber step. 02:17:42 INFO - ##### 02:17:42 INFO - Running pre-action listener: _resource_record_pre_action 02:17:42 INFO - Running main action method: clobber 02:17:42 INFO - rmtree: /builds/slave/test/build 02:17:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:17:42 INFO - Running post-action listener: _resource_record_post_action 02:17:42 INFO - ##### 02:17:42 INFO - ##### Finished clobber step (success) 02:17:42 INFO - ##### 02:17:42 INFO - ##### 02:17:42 INFO - ##### Running read-buildbot-config step. 02:17:42 INFO - ##### 02:17:42 INFO - Running pre-action listener: _resource_record_pre_action 02:17:42 INFO - Running main action method: read_buildbot_config 02:17:42 INFO - Using buildbot properties: 02:17:42 INFO - { 02:17:42 INFO - "project": "", 02:17:42 INFO - "product": "firefox", 02:17:42 INFO - "script_repo_revision": "production", 02:17:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:17:42 INFO - "repository": "", 02:17:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:17:42 INFO - "buildid": "20160510014205", 02:17:42 INFO - "pgo_build": "False", 02:17:42 INFO - "basedir": "/builds/slave/test", 02:17:42 INFO - "buildnumber": 2944, 02:17:42 INFO - "slavename": "talos-linux64-ix-047", 02:17:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:17:42 INFO - "platform": "ubuntu64_hw", 02:17:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:17:42 INFO - "branch": "fx-team", 02:17:42 INFO - "repo_path": "integration/fx-team", 02:17:42 INFO - "revision": "f612200731ad2e125e9ae23ecc4f4a6e7110d8d7", 02:17:42 INFO - "stage_platform": "linux64", 02:17:42 INFO - "builduid": "2b9ef505fdaf4b6dba114cbc4a6d89fd", 02:17:42 INFO - "slavebuilddir": "test" 02:17:42 INFO - } 02:17:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:17:42 INFO - Running post-action listener: _resource_record_post_action 02:17:42 INFO - ##### 02:17:42 INFO - ##### Finished read-buildbot-config step (success) 02:17:42 INFO - ##### 02:17:42 INFO - ##### 02:17:42 INFO - ##### Running download-and-extract step. 02:17:42 INFO - ##### 02:17:42 INFO - Running pre-action listener: _resource_record_pre_action 02:17:42 INFO - Running main action method: download_and_extract 02:17:42 INFO - mkdir: /builds/slave/test/build/tests 02:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:42 INFO - https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:17:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:17:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:17:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/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 02:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/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 02:17:49 INFO - Downloaded 1361 bytes. 02:17:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:17:49 INFO - Using the following test package requirements: 02:17:49 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:17:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:17:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:49 INFO - u'jsshell-linux-x86_64.zip'], 02:17:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:17:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:17:49 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:17:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:17:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:17:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:17: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')]} 02:17:49 INFO - https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:17:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/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 02:17:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/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 02:18:00 INFO - Downloaded 22322863 bytes. 02:18:00 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'] 02:18:00 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 02:18:01 INFO - Return code: 0 02:18:01 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 02:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:01 INFO - https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:18:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:18:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:18:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/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 02:18:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/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 02:18:03 INFO - Downloaded 22322863 bytes. 02:18:03 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'] 02:18:03 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 02:18:05 INFO - Return code: 0 02:18: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')]} 02:18:05 INFO - https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/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 02:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/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 02:18:06 INFO - Downloaded 10840152 bytes. 02:18:06 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'] 02:18:06 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 02:18:06 INFO - Return code: 0 02:18:06 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')]} 02:18:06 INFO - https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:18:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:18:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:18:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/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 02:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPI9EJIzTySdJQqmaoahUw/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 02:18:07 INFO - Downloaded 54863255 bytes. 02:18:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:18:07 INFO - mkdir: /builds/slave/test/properties 02:18:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:18:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:18:07 INFO - Contents: 02:18:07 INFO - build_url:https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:18:08 INFO - Running post-action listener: _resource_record_post_action 02:18:08 INFO - Running post-action listener: set_extra_try_arguments 02:18:08 INFO - ##### 02:18:08 INFO - ##### Finished download-and-extract step (success) 02:18:08 INFO - ##### 02:18:08 INFO - ##### 02:18:08 INFO - ##### Running populate-webroot step. 02:18:08 INFO - ##### 02:18:08 INFO - Running pre-action listener: _resource_record_pre_action 02:18:08 INFO - Running main action method: populate_webroot 02:18:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:18:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:18:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:18:08 INFO - '--tppagecycles', 02:18:08 INFO - '7'], 02:18:08 INFO - 'tests': ['tsvgm']}}, 02:18:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:18:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:18:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:18:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:18:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:18:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:18:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:08 INFO - 'talos_options': ['--disable-e10s'], 02:18:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:18:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:18:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:08 INFO - 'talos_options': ['--disable-e10s'], 02:18:08 INFO - 'tests': ['damp', 'tps']}, 02:18:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:08 INFO - 'tests': ['damp', 'tps']}, 02:18:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:18:08 INFO - 'tests': ['dromaeo_dom']}, 02:18:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:18:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:18:08 INFO - 'tests': ['a11yr', 02:18:08 INFO - 'ts_paint', 02:18:08 INFO - 'tpaint', 02:18:08 INFO - 'sessionrestore', 02:18:08 INFO - 'sessionrestore_no_auto_restore', 02:18:08 INFO - 'tabpaint']}, 02:18:08 INFO - 'other-e10s': {'tests': ['a11yr', 02:18:08 INFO - 'ts_paint', 02:18:08 INFO - 'tpaint', 02:18:08 INFO - 'sessionrestore', 02:18:08 INFO - 'sessionrestore_no_auto_restore', 02:18:08 INFO - 'tabpaint']}, 02:18:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:18:08 INFO - 'ts_paint', 02:18:08 INFO - 'tpaint', 02:18:08 INFO - 'sessionrestore', 02:18:08 INFO - 'sessionrestore_no_auto_restore', 02:18:08 INFO - 'tabpaint']}, 02:18:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:18:08 INFO - 'ts_paint', 02:18:08 INFO - 'tpaint', 02:18:08 INFO - 'sessionrestore', 02:18:08 INFO - 'sessionrestore_no_auto_restore', 02:18:08 INFO - 'tabpaint']}, 02:18:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:18:08 INFO - 'tests': ['a11yr', 02:18:08 INFO - 'ts_paint', 02:18:08 INFO - 'tpaint', 02:18:08 INFO - 'sessionrestore', 02:18:08 INFO - 'sessionrestore_no_auto_restore', 02:18:08 INFO - 'tabpaint']}, 02:18:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:18:08 INFO - 'tests': ['a11yr', 02:18:08 INFO - 'ts_paint', 02:18:08 INFO - 'tpaint', 02:18:08 INFO - 'sessionrestore', 02:18:08 INFO - 'sessionrestore_no_auto_restore', 02:18:08 INFO - 'tabpaint']}, 02:18:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:18:08 INFO - 'tests': ['tsvgx', 02:18:08 INFO - 'tsvgr_opacity', 02:18:08 INFO - 'tart', 02:18:08 INFO - 'tscrollx', 02:18:08 INFO - 'cart']}, 02:18:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:18:08 INFO - 'tsvgr_opacity', 02:18:08 INFO - 'tart', 02:18:08 INFO - 'tscrollx', 02:18:08 INFO - 'cart']}, 02:18:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:08 INFO - 'talos_options': ['--disable-e10s'], 02:18:08 INFO - 'tests': ['tp5o']}, 02:18:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:08 INFO - 'tests': ['tp5o']}, 02:18:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:08 INFO - 'talos_options': ['--disable-e10s', 02:18:08 INFO - '--xperf_path', 02:18:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:18:08 INFO - 'tests': ['tp5n']}, 02:18:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:08 INFO - 'talos_options': ['--xperf_path', 02:18:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:18:08 INFO - 'tests': ['tp5n']}}, 02:18:08 INFO - 'talos.zip': {'path': '', 02:18:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:18:08 INFO - Running post-action listener: _resource_record_post_action 02:18:08 INFO - ##### 02:18:08 INFO - ##### Finished populate-webroot step (success) 02:18:08 INFO - ##### 02:18:08 INFO - ##### 02:18:08 INFO - ##### Running create-virtualenv step. 02:18:08 INFO - ##### 02:18:08 INFO - Running pre-action listener: _resource_record_pre_action 02:18:08 INFO - Running main action method: create_virtualenv 02:18:08 INFO - Creating virtualenv /builds/slave/test/build/venv 02:18:08 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 02:18:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:18:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:18:08 INFO - Using real prefix '/usr' 02:18:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:18:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:18:10 INFO - Installing pip.................done. 02:18:10 INFO - Return code: 0 02:18:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:18:10 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')]} 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:10 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')]} 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:10 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 0x7f7b15ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18009c0>, '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 0x18018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', '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 02:18:10 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 02:18:10 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 02:18:10 INFO - Using env: {'DISPLAY': ':0', 02:18:10 INFO - 'HOME': '/home/cltbld', 02:18:10 INFO - 'LANG': 'en_US.UTF-8', 02:18:10 INFO - 'LANGUAGE': 'en_US:en', 02:18:10 INFO - 'LOGNAME': 'cltbld', 02:18:10 INFO - 'MAIL': '/var/mail/cltbld', 02:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:10 INFO - 'MOZ_NO_REMOTE': '1', 02:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:10 INFO - 'NO_EM_RESTART': '1', 02:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:10 INFO - 'PWD': '/builds/slave/test', 02:18:10 INFO - 'SHELL': '/bin/bash', 02:18:10 INFO - 'SHLVL': '1', 02:18:10 INFO - 'TERM': 'linux', 02:18:10 INFO - 'TMOUT': '86400', 02:18:10 INFO - 'USER': 'cltbld', 02:18:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', 02:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:10 INFO - '_': '/tools/buildbot/bin/python'} 02:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:11 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 02:18:11 INFO - Cleaning up... 02:18:11 INFO - Return code: 0 02:18:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7b15ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18009c0>, '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 0x18018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', '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 02:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:18:11 INFO - Using env: {'DISPLAY': ':0', 02:18:11 INFO - 'HOME': '/home/cltbld', 02:18:11 INFO - 'LANG': 'en_US.UTF-8', 02:18:11 INFO - 'LANGUAGE': 'en_US:en', 02:18:11 INFO - 'LOGNAME': 'cltbld', 02:18:11 INFO - 'MAIL': '/var/mail/cltbld', 02:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:11 INFO - 'MOZ_NO_REMOTE': '1', 02:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:11 INFO - 'NO_EM_RESTART': '1', 02:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:11 INFO - 'PWD': '/builds/slave/test', 02:18:11 INFO - 'SHELL': '/bin/bash', 02:18:11 INFO - 'SHLVL': '1', 02:18:11 INFO - 'TERM': 'linux', 02:18:11 INFO - 'TMOUT': '86400', 02:18:11 INFO - 'USER': 'cltbld', 02:18:11 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', 02:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:11 INFO - '_': '/tools/buildbot/bin/python'} 02:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:11 INFO - Downloading/unpacking psutil>=0.7.1 02:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:18:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:18:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:18:13 INFO - Installing collected packages: psutil 02:18:13 INFO - Running setup.py install for psutil 02:18:13 INFO - building 'psutil._psutil_linux' extension 02:18:13 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 02:18:13 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 02:18:13 INFO - building 'psutil._psutil_posix' extension 02:18:13 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 02:18:13 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 02:18:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:18:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:18:13 INFO - Successfully installed psutil 02:18:13 INFO - Cleaning up... 02:18:13 INFO - Return code: 0 02:18:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7b15ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18009c0>, '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 0x18018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', '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 02:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:18:13 INFO - Using env: {'DISPLAY': ':0', 02:18:13 INFO - 'HOME': '/home/cltbld', 02:18:13 INFO - 'LANG': 'en_US.UTF-8', 02:18:13 INFO - 'LANGUAGE': 'en_US:en', 02:18:13 INFO - 'LOGNAME': 'cltbld', 02:18:13 INFO - 'MAIL': '/var/mail/cltbld', 02:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:13 INFO - 'MOZ_NO_REMOTE': '1', 02:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:13 INFO - 'NO_EM_RESTART': '1', 02:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:13 INFO - 'PWD': '/builds/slave/test', 02:18:13 INFO - 'SHELL': '/bin/bash', 02:18:13 INFO - 'SHLVL': '1', 02:18:13 INFO - 'TERM': 'linux', 02:18:13 INFO - 'TMOUT': '86400', 02:18:13 INFO - 'USER': 'cltbld', 02:18:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', 02:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:13 INFO - '_': '/tools/buildbot/bin/python'} 02:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:18:15 INFO - Installing collected packages: mozsystemmonitor 02:18:15 INFO - Running setup.py install for mozsystemmonitor 02:18:15 INFO - Successfully installed mozsystemmonitor 02:18:15 INFO - Cleaning up... 02:18:15 INFO - Return code: 0 02:18:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:15 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 0x7f7b15ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18009c0>, '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 0x18018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', '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 02:18:15 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 02:18:15 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 02:18:15 INFO - Using env: {'DISPLAY': ':0', 02:18:15 INFO - 'HOME': '/home/cltbld', 02:18:15 INFO - 'LANG': 'en_US.UTF-8', 02:18:15 INFO - 'LANGUAGE': 'en_US:en', 02:18:15 INFO - 'LOGNAME': 'cltbld', 02:18:15 INFO - 'MAIL': '/var/mail/cltbld', 02:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:15 INFO - 'MOZ_NO_REMOTE': '1', 02:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:15 INFO - 'NO_EM_RESTART': '1', 02:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:15 INFO - 'PWD': '/builds/slave/test', 02:18:15 INFO - 'SHELL': '/bin/bash', 02:18:15 INFO - 'SHLVL': '1', 02:18:15 INFO - 'TERM': 'linux', 02:18:15 INFO - 'TMOUT': '86400', 02:18:15 INFO - 'USER': 'cltbld', 02:18:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', 02:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:15 INFO - '_': '/tools/buildbot/bin/python'} 02:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:16 INFO - Downloading/unpacking blobuploader==1.2.4 02:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:18 INFO - Downloading blobuploader-1.2.4.tar.gz 02:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:18:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:18:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 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 02:18:18 INFO - Downloading docopt-0.6.1.tar.gz 02:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:18:18 INFO - Installing collected packages: blobuploader, requests, docopt 02:18:18 INFO - Running setup.py install for blobuploader 02:18:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:18:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:18:18 INFO - Running setup.py install for requests 02:18:19 INFO - Running setup.py install for docopt 02:18:19 INFO - Successfully installed blobuploader requests docopt 02:18:19 INFO - Cleaning up... 02:18:19 INFO - Return code: 0 02:18:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:19 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')]} 02:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:19 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')]} 02:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:19 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 0x7f7b15ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18009c0>, '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 0x18018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', '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 02:18:19 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 02:18:19 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 02:18:19 INFO - Using env: {'DISPLAY': ':0', 02:18:19 INFO - 'HOME': '/home/cltbld', 02:18:19 INFO - 'LANG': 'en_US.UTF-8', 02:18:19 INFO - 'LANGUAGE': 'en_US:en', 02:18:19 INFO - 'LOGNAME': 'cltbld', 02:18:19 INFO - 'MAIL': '/var/mail/cltbld', 02:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:19 INFO - 'MOZ_NO_REMOTE': '1', 02:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:19 INFO - 'NO_EM_RESTART': '1', 02:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:19 INFO - 'PWD': '/builds/slave/test', 02:18:19 INFO - 'SHELL': '/bin/bash', 02:18:19 INFO - 'SHLVL': '1', 02:18:19 INFO - 'TERM': 'linux', 02:18:19 INFO - 'TMOUT': '86400', 02:18:19 INFO - 'USER': 'cltbld', 02:18:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', 02:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:19 INFO - '_': '/tools/buildbot/bin/python'} 02:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:19 INFO - Running setup.py (path:/tmp/pip-w9yHHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:19 INFO - Running setup.py (path:/tmp/pip-YXmX_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:19 INFO - Running setup.py (path:/tmp/pip-rWS8xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:19 INFO - Running setup.py (path:/tmp/pip-GpRiuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:19 INFO - Running setup.py (path:/tmp/pip-KnPosI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:19 INFO - Running setup.py (path:/tmp/pip-BIc1_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:19 INFO - Running setup.py (path:/tmp/pip-OMCtaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:19 INFO - Running setup.py (path:/tmp/pip-5_hrV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:19 INFO - Running setup.py (path:/tmp/pip-UXLXfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:19 INFO - Running setup.py (path:/tmp/pip-ibU65T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:20 INFO - Running setup.py (path:/tmp/pip-8l2pzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:20 INFO - Running setup.py (path:/tmp/pip-OYS_Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:20 INFO - Running setup.py (path:/tmp/pip-1UlIeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:20 INFO - Running setup.py (path:/tmp/pip-m0g8D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:20 INFO - Running setup.py (path:/tmp/pip-2bityJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:20 INFO - Running setup.py (path:/tmp/pip-MxmorE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:20 INFO - Running setup.py (path:/tmp/pip-8OrGyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:18:20 INFO - Running setup.py install for manifestparser 02:18:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:18:20 INFO - Running setup.py install for mozcrash 02:18:20 INFO - Running setup.py install for mozdebug 02:18:20 INFO - Running setup.py install for mozdevice 02:18:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:18:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:18:20 INFO - Running setup.py install for mozfile 02:18:20 INFO - Running setup.py install for mozhttpd 02:18:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:18:20 INFO - Running setup.py install for mozinfo 02:18:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozInstall 02:18:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozleak 02:18:21 INFO - Running setup.py install for mozlog 02:18:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for moznetwork 02:18:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozprocess 02:18:21 INFO - Running setup.py install for mozprofile 02:18:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozrunner 02:18:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:18:21 INFO - Running setup.py install for mozscreenshot 02:18:21 INFO - Running setup.py install for moztest 02:18:21 INFO - Running setup.py install for mozversion 02:18:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:18:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:18:22 INFO - Cleaning up... 02:18:22 INFO - Return code: 0 02:18:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:22 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')]} 02:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:22 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')]} 02:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:22 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 0x7f7b15ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18009c0>, '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 0x18018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', '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 02:18:22 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 02:18:22 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 02:18:22 INFO - Using env: {'DISPLAY': ':0', 02:18:22 INFO - 'HOME': '/home/cltbld', 02:18:22 INFO - 'LANG': 'en_US.UTF-8', 02:18:22 INFO - 'LANGUAGE': 'en_US:en', 02:18:22 INFO - 'LOGNAME': 'cltbld', 02:18:22 INFO - 'MAIL': '/var/mail/cltbld', 02:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:22 INFO - 'MOZ_NO_REMOTE': '1', 02:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:22 INFO - 'NO_EM_RESTART': '1', 02:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:22 INFO - 'PWD': '/builds/slave/test', 02:18:22 INFO - 'SHELL': '/bin/bash', 02:18:22 INFO - 'SHLVL': '1', 02:18:22 INFO - 'TERM': 'linux', 02:18:22 INFO - 'TMOUT': '86400', 02:18:22 INFO - 'USER': 'cltbld', 02:18:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', 02:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:22 INFO - '_': '/tools/buildbot/bin/python'} 02:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:22 INFO - Running setup.py (path:/tmp/pip-Ke841K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:22 INFO - Running setup.py (path:/tmp/pip-XLTamT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:22 INFO - Running setup.py (path:/tmp/pip-Ce25ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:22 INFO - Running setup.py (path:/tmp/pip-cnm2Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:22 INFO - Running setup.py (path:/tmp/pip-q8fhdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:22 INFO - Running setup.py (path:/tmp/pip-bapKNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:22 INFO - Running setup.py (path:/tmp/pip-qFOufR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:22 INFO - Running setup.py (path:/tmp/pip-3JKoVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:22 INFO - Running setup.py (path:/tmp/pip-0lNg1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:22 INFO - Running setup.py (path:/tmp/pip-3Q8uk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:22 INFO - Running setup.py (path:/tmp/pip-V9N9NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:22 INFO - Running setup.py (path:/tmp/pip-Uig_bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:22 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)) 02:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:22 INFO - Running setup.py (path:/tmp/pip-sYr0_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:23 INFO - Running setup.py (path:/tmp/pip-b_Fy0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:23 INFO - Running setup.py (path:/tmp/pip-XpmaUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:23 INFO - Running setup.py (path:/tmp/pip-gTndpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:23 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)) 02:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:23 INFO - Running setup.py (path:/tmp/pip-KbJtEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:23 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)) 02:18:23 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)) 02:18:23 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)) 02:18:23 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)) 02:18:23 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)) 02:18:23 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)) 02:18:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:18:23 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 02:18:23 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 02:18:23 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 02:18:23 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 02:18:23 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 02:18:23 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 02:18:25 INFO - Downloading blessings-1.6.tar.gz 02:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:18:25 INFO - Installing collected packages: blessings 02:18:25 INFO - Running setup.py install for blessings 02:18:25 INFO - Successfully installed blessings 02:18:25 INFO - Cleaning up... 02:18:25 INFO - Return code: 0 02:18:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:25 INFO - Reading from file tmpfile_stdout 02:18:25 INFO - Current package versions: 02:18:25 INFO - argparse == 1.2.1 02:18:25 INFO - blessings == 1.6 02:18:25 INFO - blobuploader == 1.2.4 02:18:25 INFO - docopt == 0.6.1 02:18:25 INFO - manifestparser == 1.1 02:18:25 INFO - mozInstall == 1.12 02:18:25 INFO - mozcrash == 0.17 02:18:25 INFO - mozdebug == 0.1 02:18:25 INFO - mozdevice == 0.48 02:18:25 INFO - mozfile == 1.2 02:18:25 INFO - mozhttpd == 0.7 02:18:25 INFO - mozinfo == 0.9 02:18:25 INFO - mozleak == 0.1 02:18:25 INFO - mozlog == 3.1 02:18:25 INFO - moznetwork == 0.27 02:18:25 INFO - mozprocess == 0.22 02:18:25 INFO - mozprofile == 0.28 02:18:25 INFO - mozrunner == 6.11 02:18:25 INFO - mozscreenshot == 0.1 02:18:25 INFO - mozsystemmonitor == 0.0 02:18:25 INFO - moztest == 0.7 02:18:25 INFO - mozversion == 1.4 02:18:25 INFO - psutil == 3.1.1 02:18:25 INFO - requests == 1.2.3 02:18:25 INFO - wsgiref == 0.1.2 02:18:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:25 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 0x7f7b15ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18009c0>, '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 0x18018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', '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 02:18:25 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 02:18:25 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 02:18:25 INFO - Using env: {'DISPLAY': ':0', 02:18:25 INFO - 'HOME': '/home/cltbld', 02:18:25 INFO - 'LANG': 'en_US.UTF-8', 02:18:25 INFO - 'LANGUAGE': 'en_US:en', 02:18:25 INFO - 'LOGNAME': 'cltbld', 02:18:25 INFO - 'MAIL': '/var/mail/cltbld', 02:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:25 INFO - 'MOZ_NO_REMOTE': '1', 02:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:25 INFO - 'NO_EM_RESTART': '1', 02:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:25 INFO - 'PWD': '/builds/slave/test', 02:18:25 INFO - 'SHELL': '/bin/bash', 02:18:25 INFO - 'SHLVL': '1', 02:18:25 INFO - 'TERM': 'linux', 02:18:25 INFO - 'TMOUT': '86400', 02:18:25 INFO - 'USER': 'cltbld', 02:18:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', 02:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:25 INFO - '_': '/tools/buildbot/bin/python'} 02:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:25 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)) 02:18:25 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)) 02:18:25 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)) 02:18:25 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)) 02:18:25 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)) 02:18:25 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)) 02:18:25 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)) 02:18:25 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)) 02:18:25 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)) 02:18:25 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)) 02:18:25 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)) 02:18:25 INFO - Cleaning up... 02:18:25 INFO - Return code: 0 02:18:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:25 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 0x7f7b15ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18009c0>, '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 0x18018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', '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 02:18:25 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 02:18:25 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 02:18:25 INFO - Using env: {'DISPLAY': ':0', 02:18:25 INFO - 'HOME': '/home/cltbld', 02:18:25 INFO - 'LANG': 'en_US.UTF-8', 02:18:25 INFO - 'LANGUAGE': 'en_US:en', 02:18:25 INFO - 'LOGNAME': 'cltbld', 02:18:25 INFO - 'MAIL': '/var/mail/cltbld', 02:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:25 INFO - 'MOZ_NO_REMOTE': '1', 02:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:25 INFO - 'NO_EM_RESTART': '1', 02:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:25 INFO - 'PWD': '/builds/slave/test', 02:18:25 INFO - 'SHELL': '/bin/bash', 02:18:25 INFO - 'SHLVL': '1', 02:18:25 INFO - 'TERM': 'linux', 02:18:25 INFO - 'TMOUT': '86400', 02:18:25 INFO - 'USER': 'cltbld', 02:18:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', 02:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:25 INFO - '_': '/tools/buildbot/bin/python'} 02:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:25 INFO - Downloading/unpacking jsonschema 02:18:25 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 02:18:25 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 02:18:25 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 02:18:25 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 02:18:25 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 02:18:25 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 02:18:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:18:27 INFO - Downloading/unpacking functools32 (from jsonschema) 02:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:18:27 INFO - warning: no files found matching '*.txt' 02:18:27 INFO - no previously-included directories found matching 'build' 02:18:27 INFO - no previously-included directories found matching 'dist' 02:18:27 INFO - no previously-included directories found matching '.git*' 02:18:28 INFO - Installing collected packages: jsonschema, functools32 02:18:28 INFO - Running setup.py install for functools32 02:18:28 INFO - warning: no files found matching '*.txt' 02:18:28 INFO - no previously-included directories found matching 'build' 02:18:28 INFO - no previously-included directories found matching 'dist' 02:18:28 INFO - no previously-included directories found matching '.git*' 02:18:28 INFO - Successfully installed jsonschema functools32 02:18:28 INFO - Cleaning up... 02:18:28 INFO - Return code: 0 02:18:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:18:28 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')]} 02:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:28 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')]} 02:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:28 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 0x7f7b15ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1771770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18009c0>, '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 0x18018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', '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 02:18:28 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 02:18:28 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 02:18:28 INFO - Using env: {'DISPLAY': ':0', 02:18:28 INFO - 'HOME': '/home/cltbld', 02:18:28 INFO - 'LANG': 'en_US.UTF-8', 02:18:28 INFO - 'LANGUAGE': 'en_US:en', 02:18:28 INFO - 'LOGNAME': 'cltbld', 02:18:28 INFO - 'MAIL': '/var/mail/cltbld', 02:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:28 INFO - 'MOZ_NO_REMOTE': '1', 02:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:28 INFO - 'NO_EM_RESTART': '1', 02:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:28 INFO - 'PWD': '/builds/slave/test', 02:18:28 INFO - 'SHELL': '/bin/bash', 02:18:28 INFO - 'SHLVL': '1', 02:18:28 INFO - 'TERM': 'linux', 02:18:28 INFO - 'TMOUT': '86400', 02:18:28 INFO - 'USER': 'cltbld', 02:18:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', 02:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:28 INFO - '_': '/tools/buildbot/bin/python'} 02:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:28 INFO - Downloading/unpacking flake8 02:18:28 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 02:18:28 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 02:18:28 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 02:18:28 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 02:18:28 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 02:18:28 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 02:18:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:18:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:18:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 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 02:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:18:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:18:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:18:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:18:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:18:30 INFO - no previously-included directories found matching 'docs/_build' 02:18:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:18:31 INFO - Running setup.py install for pep8 02:18:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:18:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:18:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:18:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:18:31 INFO - no previously-included directories found matching 'docs/_build' 02:18:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:18:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:18:31 INFO - Cleaning up... 02:18:31 INFO - Return code: 0 02:18:31 INFO - Running post-action listener: _resource_record_post_action 02:18:31 INFO - Running post-action listener: _start_resource_monitoring 02:18:31 INFO - Starting resource monitoring. 02:18:31 INFO - ##### 02:18:31 INFO - ##### Finished create-virtualenv step (success) 02:18:31 INFO - ##### 02:18:31 INFO - ##### 02:18:31 INFO - ##### Running install step. 02:18:31 INFO - ##### 02:18:31 INFO - Running pre-action listener: _resource_record_pre_action 02:18:31 INFO - Running main action method: install 02:18:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:31 INFO - Reading from file tmpfile_stdout 02:18:31 INFO - Detecting whether we're running mozinstall >=1.0... 02:18:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:18:31 INFO - Reading from file tmpfile_stdout 02:18:31 INFO - Output received: 02:18:31 INFO - Usage: mozinstall [options] installer 02:18:31 INFO - Options: 02:18:31 INFO - -h, --help show this help message and exit 02:18:31 INFO - -d DEST, --destination=DEST 02:18:31 INFO - Directory to install application into. [default: 02:18:31 INFO - "/builds/slave/test"] 02:18:31 INFO - --app=APP Application being installed. [default: firefox] 02:18:31 INFO - mkdir: /builds/slave/test/build/application 02:18:31 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'] 02:18:31 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 02:18:47 INFO - Reading from file tmpfile_stdout 02:18:47 INFO - Output received: 02:18:47 INFO - /builds/slave/test/build/application/firefox/firefox 02:18:47 INFO - Running post-action listener: _resource_record_post_action 02:18:47 INFO - ##### 02:18:47 INFO - ##### Finished install step (success) 02:18:47 INFO - ##### 02:18:47 INFO - ##### 02:18:47 INFO - ##### Running run-tests step. 02:18:47 INFO - ##### 02:18:47 INFO - Running pre-action listener: _resource_record_pre_action 02:18:47 INFO - Running main action method: run_tests 02:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:18:47 INFO - Python 2.7.3 02:18:47 INFO - Return code: 0 02:18:47 INFO - grabbing minidump binary from tooltool 02:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:47 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 0x18009c0>, '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 0x18018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:18:47 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 02:18:47 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 02:18:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:18:47 INFO - Return code: 0 02:18:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:18:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:18:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:18:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:18:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:18:48 INFO - Return code: 0 02:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:18:48 INFO - Using env: {'DISPLAY': ':0', 02:18:48 INFO - 'HOME': '/home/cltbld', 02:18:48 INFO - 'LANG': 'en_US.UTF-8', 02:18:48 INFO - 'LANGUAGE': 'en_US:en', 02:18:48 INFO - 'LOGNAME': 'cltbld', 02:18:48 INFO - 'MAIL': '/var/mail/cltbld', 02:18:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:18:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:48 INFO - 'MOZ_NO_REMOTE': '1', 02:18:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:48 INFO - 'NO_EM_RESTART': '1', 02:18:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:48 INFO - 'PWD': '/builds/slave/test', 02:18:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:18:48 INFO - 'SHELL': '/bin/bash', 02:18:48 INFO - 'SHLVL': '1', 02:18:48 INFO - 'TERM': 'linux', 02:18:48 INFO - 'TMOUT': '86400', 02:18:48 INFO - 'USER': 'cltbld', 02:18:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266', 02:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:48 INFO - '_': '/tools/buildbot/bin/python'} 02:18:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:18:48 INFO - mozversion application_buildid: 20160510014205 02:18:48 INFO - mozversion application_changeset: f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 02:18:48 INFO - mozversion application_display_name: Nightly 02:18:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:18:48 INFO - mozversion application_name: Firefox 02:18:48 INFO - mozversion application_remotingname: firefox 02:18:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:18:48 INFO - mozversion application_vendor: Mozilla 02:18:48 INFO - mozversion application_version: 49.0a1 02:18:48 INFO - mozversion platform_buildid: 20160510014205 02:18:48 INFO - mozversion platform_changeset: f612200731ad2e125e9ae23ecc4f4a6e7110d8d7 02:18:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:18:48 INFO - mozversion platform_version: 49.0a1 02:18:48 INFO - using testdate: 1462871928 02:18:48 INFO - actual date: 1462871928 02:18:48 INFO - starting webserver on 'localhost:53961' 02:18:48 INFO - SUITE-START | Running 2 tests 02:18:48 INFO - TEST-START | dromaeo_css 02:18:48 INFO - operating with platform_type : linux_ 02:18:48 INFO - Initialising browser for dromaeo_css test... 02:18:48 INFO - TEST-INFO | started process 6845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplDzF1P/profile http://localhost:53961/getInfo.html) 02:18:52 INFO - PROCESS | 6845 | __metrics Screen width/height:1600/1200 02:18:52 INFO - PROCESS | 6845 | colorDepth:24 02:18:52 INFO - PROCESS | 6845 | Browser inner width/height: 1024/697 02:18:52 INFO - PROCESS | 6845 | __metrics 02:18:53 ERROR - PROCESS | 6845 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:18:54 INFO - TEST-INFO | 6845: exit 0 02:18:54 INFO - Browser initialized. 02:18:54 INFO - Running cycle 1/1 for dromaeo_css test... 02:18:54 INFO - TEST-INFO | started process 6927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplDzF1P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:05 INFO - PROCESS | 6927 | RSS: Main: 153374720 02:19:05 INFO - PROCESS | 6927 | 02:19:56 INFO - PROCESS | 6927 | 1462871996787 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] 02:22:08 INFO - PROCESS | 6927 | Cycle 1(1): loaded http://localhost:53961/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53961/tests/dromaeo/cssquery-ext.html) 02:22:09 INFO - PROCESS | 6927 | RSS: Main: 228368384 02:22:09 INFO - PROCESS | 6927 | 02:25:12 INFO - PROCESS | 6927 | Cycle 1(1): loaded http://localhost:53961/tests/dromaeo/cssquery-ext.html (next: http://localhost:53961/tests/dromaeo/cssquery-jquery.html) 02:25:12 INFO - PROCESS | 6927 | RSS: Main: 236244992 02:25:12 INFO - PROCESS | 6927 | 02:28:14 INFO - PROCESS | 6927 | Cycle 1(1): loaded http://localhost:53961/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53961/tests/dromaeo/cssquery-mootools.html) 02:28:15 INFO - PROCESS | 6927 | RSS: Main: 245956608 02:28:15 INFO - PROCESS | 6927 | 02:31:17 INFO - PROCESS | 6927 | Cycle 1(1): loaded http://localhost:53961/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53961/tests/dromaeo/cssquery-prototype.html) 02:31:17 INFO - PROCESS | 6927 | RSS: Main: 239013888 02:31:17 INFO - PROCESS | 6927 | 02:34:20 INFO - PROCESS | 6927 | Cycle 1(1): loaded http://localhost:53961/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53961/tests/dromaeo/cssquery-yui.html) 02:34:21 INFO - PROCESS | 6927 | RSS: Main: 216219648 02:34:21 INFO - PROCESS | 6927 | 02:37:24 INFO - PROCESS | 6927 | Cycle 1(1): loaded http://localhost:53961/tests/dromaeo/cssquery-yui.html (next: http://localhost:53961/tests/dromaeo/cssquery-dojo.html) 02:37:24 INFO - PROCESS | 6927 | RSS: Main: 273199104 02:37:24 INFO - PROCESS | 6927 | 02:37:24 INFO - PROCESS | 6927 | __start_tp_report 02:37:24 INFO - PROCESS | 6927 | _x_x_mozilla_page_load 02:37:24 INFO - PROCESS | 6927 | _x_x_mozilla_page_load_details 02:37:24 INFO - PROCESS | 6927 | |i|pagename|runs| 02:37:24 INFO - PROCESS | 6927 | |0;dojo.html;2620.004398328635;2628.5531459651856;2648.748368904954;2657.4817910507445;2673.933151671208;4481.798319075641;4501.617362524181;4514.345419914111;4653.511381304961;4679.719216846992;4608.07838432314;4612.308153776927;4635;4724.338592597039;4749.097671442423;4122.989867482471;4190.790460476979;4322.654187664995;4387.903024243939;4415.558444155591;4265.87202383929;4370.56294370562;4385.364122202279;4386.363977223316;4424.80088396023;4144.5855414458465;4199.139176468817;4225.408442817978;4239.40648309237;4311.1593239318345;4262.126264115849;4295.2912769393015;4311.051568654891;4321.2653848845775;4366.563343665608;4263.211305908417;4298.699091063627;4311.8706438806885;4322.308430651081;4331.436913201263;4336.696431249782;4561.429821272341;4582.221022426163;4606.424196975378;4699.718016918996;5038.370203724535;5063.949360506384;5090.414602320743;5127.102757017507;5134.794608215667;4877.902441951142;5030.773615187325;5057.645964782467;5069.087564238435;5071.695698258116;4702.623790096784;4732.148213321566;4750.287456881495;4855.830045948445;4855.878603034952;5228.712420816815;5231.24146998683;5261.4738526147075;5312.893742125136;5313.335833020872;4737.9052418952115;4883.169861123618;4919.163742163841;4973.5523802857915;5064.442911279756;4946.851594452172;4966.354373931365;4997.2254300582745;5000.074986127578;5064.1897296433135;4948.777305021283;4996.075725990703;5003.399592048978;5012.949870501321;5014.724190169502;4734.502877197913;4780.020095880336;4790.377250957354;4923.08922849274;5052.115879721034;4252.149570085933;4270.466191726035;4289.227938970953;4324.459442569679;4329.134173165379;3707.1844194277214;3728.9745320037205;3738.0467980664757;3764.284785890672;3771.6794072503594;4172.4784401949755;4231.682623803227;4273.316269396882;4313.827446902152;4325;4906.460289368167;5001.149804533238;5028.472010438924;5039.496050394931;5048.242763585492;4308.052228509723;4308.763018034038;4313.439252897103;4315.697901146889;4334.978325108417;4400.383946247528;4560.247559152769;4593.678442509059;4606.700564463299;4641.303804429363;4718.882027949328;4789.808407663724;4800.7599620019555;4804;4823;5056.266841307916;5083.875470475306;5103.948960510495;5105.566026887756;5152.227165925141;4568.634509239319;4679.695819771704;4785;4821.035792841376;4851.369321988119;4943.65394422387;4976.402831660224;5025.321581586439;5027.572656324253;5065.113605119016;5061.797528098835;5062.594992400673;5072.163093089746;5077.695338279715;5133.2300154975555;4535.773211339354;4782.665213435026;4810.374651295309;4866.951330486791;4899.093667671492;4835.516448355136;4848.200046992207;4883.072216278895;4890.804367825247;4921.926171107365;4657.883552911204;4800.087983283165;4801.51984801517;4803.183458811941;4878.268259761065;4759.857204283877;4796.664233503621;4830.7826147824135;4832.202686556679;4961.5534601886;4734.73958932262;4743.857684269477;4776.928346074742;4778.187708089703;4811.422629284369 02:37:24 INFO - PROCESS | 6927 | |1;ext.html;558.5699011760944;568.2953138108746;571.885622875425;577.7948828166002;586.1793489115241;26720;29715;29826.55260171099;29991.400171996574;30000.249993750167;30178.547321790134;42864.57135428645;43727.78136109323;44476;48908.51091489084;7875.369970402383;7925.682972681086;7929.682812687485;7945.721899733481;7983.920160798405;7432.293932076444;7715.614219289041;7770.494917830323;7798.181190974951;7801.453898227126;10030.097291243786;10110.191184705243;10353.844692329621;10575.73560660982;10648.57405703771;9902.10881020708;9979.800403991916;9994.650187243484;10002.649907253211;10044.648437304731;7370.410367170613;9603.18372938301;9856.408615483095;9927.354721943051;10013.198944084455;38368.80815595932;38843.8057809712;38849.80575097106;38991.61008389908;39132.60867391318;3189.3621275744945;3200.959688101353;3223.871045158191;3312.5528053712924;3808.923821523554;29266.561001584992;29788.255293617618;30177;30224.24439389011;30307.848460757774;2823.251838262862;2857.100013495763;2867.6845546989816;2915.1546051644996;2916.8979085732108;238365;238438;239596;239817;240762.7961860197;57411;57451.71274143602;57999.130013049835;58355.99999999915;58385.41614583885;59633.403665963655;59719.40280597138;59854.40145598488;60078.399216008154;60234.39765602376;12872.485100596059;14528.782068268985;14808;14879.03286286388;14906.180160091299;9646.469444180497;10037;10063.798724025624;10951.56193752241;11142.777144457228;17874.731879021823;18158.182881770354;18247.81752182461;18383.448496545127;19276.32532861343;5886.911696324559;5939.049752039653;5971.581989260797;5985.6408615483215;5987.143985364551;891.777055736066;903.1690844423015;911.1435250864166;988.4464699768153;1003.5684655598163;28041;29070;29548.12031569937;29564.556531652044;29575.556366654517;996.3125443444001;1011.3830563356347;1032.1381646325403;1043.2019505078622;1118.5693507999479;15155.848441515664;15524.146171960425;15562.610934726723;15666.764998525032;15811.920940395225;354922;359734;360199;360386;360504;51590.226146607834;51596.48403515917;51688.83111688876;51714.48285517172;51745.74127129416;1112.2103306652207;1213.6116442738416;1260.218664428042;1271.319843883518;1272.4337669737063;29049.564256536592;29340;30164.84917575398;30187.698123019367;30542.84728576343;44195.558044419144;44608.33087503755;44667.32999005083;44705;44868.55131448774;289656;291308;291729;294375;294531;32531.674683253812;38449.4232586517;39733.2053358937;39800.60199397969;42857.57142428661;43404.13191736084;43594.56405435905;43907.560924390345;44250.55749442464;45043.32435013412;36967.630323696416;37559.43660845035;37736.81131594325;38193.23613527658;38264.426033608965;35800.92597222087;36750.26499469942;37119.44320835244;37547.43678844765;37638.24723505569;36174.276514469035;36867;36912.81543592372;37875.242495150495;37932.43101353537;30846;32582.185445363106;33081.36105028493;33552.16119597029;33744.662553375136;25253.87373063123;25415.36461588475;25736.742632573434;25869.482610348063;26022.089226876968 02:37:24 INFO - PROCESS | 6927 | |2;jquery.html;379.96010418905996;381.211438328626;383.45549319965653;390.5996353737417;398.710934572435;15723.764143537855;17236;17344.65310693787;17756.556086097837;17857.374991875287;16757.83242167578;17026.318947242096;17372.913135434304;17471.126443677796;17574.121293935284;4952.851414457563;5094.668846524983;5111.2333150027425;5132.948670513284;5170.172772356424;3615.1685112424157;5559.16612508125;5891.05743081105;5903.88192236155;5991.820245392645;5906.9704651476895;5968.7612495500125;5971.4625683688455;5974.253218347707;5975.372585878464;5647.322321321447;5789.45000224978;5797.275340582427;5895.793647222348;5923.851903702421;3315.353506066318;4845.830395936126;5149.562287205592;5153.3558305211845;5259.868503287448;20216.19135234589;20490.795092049037;20680.17279308826;20726.067326970322;20842.687359689466;2011.8012360346972;2035.1757538197053;2041.9897900510402;2063.10255039057;2226.3432287475234;8732.694355697584;9137.314701397356;9410.576524056434;9897.35667181631;12969.221846689228;1722.939697110595;1795.1742198588665;1833.4224719213405;1867.673157197485;1881.3415304643402;39940.60059399398;40956.18087638231;60093.69953150206;68593;71755.64122179356;10317.896821031694;10352.327098738559;10441.895581044093;10460.68617941463;10496.68509944703;14280.143191408548;14294.642633934234;14357;14378.568642940729;14388.136711797326;7085.751998680022;7521.135069466972;7524.473286869976;7552.433567482461;7583.2416758323725;7112.57324560528;7160.820979475555;7220.638968051577;7229.385502232369;7241.710331586678;4488.932666010012;4552.430946131733;4557.544245575482;4569.771511424416;4607;1698.4819630012964;1738.9826101739075;1849.657813304543;1863.897485638303;1887.103625777772;854.8803167556547;869.0570730757199;881.4711173296099;932.6922115701802;974.8147851908114;16094.114823684575;16321.755173672404;16406.425775097814;16582.170891455622;16790.0765457901;884.1026358246385;891.527490430073;904.3307952115518;905.3300557587338;980.9019098090276;9088.954555227181;9496.810063798684;9582.377145485521;9617.182539484082;9648.179904708179;404124;410148.6447974366;414419;422417;435263;74377;75561.62219188869;75777;75824;75844.24155758483;918.2011649864661;923.6213152607398;946.6213514594217;949.4113649537331;963.7976025034822;14901.850981490046;15109.54671359861;15169.696606068037;15198;15662.295196715948;23773;23845.165419210243;33249.833750831094;34670.65329346674;36589.26821463609;47007;48150.518494816;48210.517894822005;48254.517454826404;49053.2642010363;7541.321281084729;7705.267999540035;7771.106322772954;7838;7964.482308649919;9326.020767819282;11111.555537778722;11243.269187502787;11368.94315528417;11637.185397022127;5258.342707161605;7288.416926645749;9252.149570086145;10065.949670251603;10150.340227885164;9739.220862330854;9762;9790.51047447639;9990;10219.642312519027;9848.655297064568;10316.071553560216;10429.322094063862;10526.263161578921;10811.56753729842;7732.226777322448;7759.418043646862;7777.444511097916;7844.862494938317;7886.960565197137;9969.750756231153;10534.104601108991;10572.524236409534;10580.15358771312;10750.086242669147 02:37:24 INFO - PROCESS | 6927 | |3;mootools.html;1265.0701734225338;1419.900606957513;1451.8257809062911;1574.5276417074874;1761.2690733345655;6217.62694238346;6971.372576468117;7007.369336759691;7031.50779445439;7082.185548661905;6768.4246839018615;7015.263397343282;7020.894686579705;7164.176119746231;7190.316919892615;2156.9029393677324;2200.5708886767006;2203.6474164133742;2217.8891055447243;2218.057325636606;2158.3093410108772;2176.0207906442083;2176.1186719378675;2182.3889310992868;2185.694002839604;2165.6210163221454;2176.771438998906;2190.0144934779332;2203.8567493112896;2211.3587059752654;2110.3774386556;2149.6668016457475;2149.9140034398606;2150.2474134053114;2160.1467420368867;2138.625740495407;2154;2161.070739581979;2166.859154154991;2171.522265101675;6896.103506544167;7068.893966590505;7125.9287407125785;7129.287071292881;7180.497365184439;4321.330193819963;4411.470623525198;4433;4441.644668426518;4485;2833.3483298841384;2858.1139846647397;2879.3441383358804;2921.649402071765;2952.2619345163707;912.6082723846122;923.4920793563513;928.4800511713462;929.3958926697633;931.7670582354411;9033.548322583845;9229.953850230706;9330.206932410752;9342.205912497446;9681.903180968242;4060.898477538026;4103.056297051635;4194.098268872207;4213.747175169499;4226.6829987750425;8222.259996600214;8426.831463370698;8504.31965442763;8529.317654587618;8552.102029286836;4500.954990450054;4531;4534.161180181677;4550;4574.588287054181;3471.392506311385;3883.5339759229073;3991.9002024949027;4037.0916543777416;4040.797960102042;3572.4105522589;3644.526211592476;3675.209829886587;3714.7399682022537;3813.7521061130938;1095.3044816541553;1177.9705507362214;1181.344353883603;1207.957721479744;1212.9757404851853;735.481485552684;850.1371108325055;861.3711990247155;863.8142799298181;867.2541614211773;4700.435947686231;4770.403699537558;4901.1913034349645;4932;4958.082754690394;408.0207501995176;419.1909614444152;423.8156401965155;433.51662895871505;433.6314132986999;3211.550382946389;3328.267781088205;3356.0770788033487;3369.629340772513;3398.3543126805826;8405.369597280229;8860.246879015356;8879.600417981206;8941.687040953535;8989.05614910438;8663.35024873137;8762.780930476789;8867.91132088671;8900.554972251362;8900.976387715365;6711.765088221889;6719.832004199934;6778.661066946633;6801.251862295144;6828.180618325832;4854.101991131652;5032.471590483093;5214.2960700304975;5229.241759944863;5293.994141113176;7970.960145199237;8187.918120818716;8212.384071194565;8215.260626543639;8226.424150309422;8134.10524842255;8479.830403392021;8529.488230706178;8562.78593035179;8581.91418085836;5609.186667933209;6198.473129784019;6392.3927226913365;6424.839379015562;6543.738250470118;7072.151341838807;7077.292270772881;7144.142702875688;7145.285471452813;7168.713251469882;6272.749090036347;6501.642409667514;6530.314316996647;6542.901856472252;6558.114654521579;6169;6237.7193026314835;6304.779332723516;6431.260405053479;6464.741410343721;5818.185454036523;5903.291605007426;5911.320198177093;5919.763209471573;5927.614705044331;4261.87214383569;4292.399064131087;4332.003639162947;4382.6932114752935;4430.224710675554;4143.440635514287;4211.136716973075;4238.385434111975;4423.5576442355505;4426.690131690751 02:37:24 INFO - PROCESS | 6927 | |4;prototype.html;299.3504096111438;308.1894617156877;312.7669885934978;315.5424634280294;315.909965659787;4593.563611456911;4615.676902616819;4641.419822522184;4660.930086048712;4662.5546080715;4383.2548466760645;4383.517813040563;4484.327350897367;4539.160255352762;4613.892665760219;3623.3840247158046;3651.050726811028;3673.412254039354;3687.244114956441;3697.352963231424;3662.230931504387;3662.7619204751604;3688.17016171362;3690.833912473932;3692.4461330800327;3455.773200513819;3518.1204698825295;3675.154714415686;3677.9080522986874;3687.631236876318;3651.233241019376;3664.8350824212976;3668.4313931340416;3674.375356189441;3685.3182161300247;3269.182704323919;3271.656476070002;3274.787138835968;3275.5086736989406;3279.7868138570916;4305.547917468652;4395.802188901507;4432.911341773147;4434.645228381754;4457.754823484707;4128.153728485683;4148.149629326011;4149.170165966789;4208.852690155861;4218.704690671654;4753.786079626425;4785.904281914377;4798.136335459616;4856.490068542787;4884.487128851455;3577.2130131371055;3583.283343331344;3589.335972845032;3598.514200582914;3607;4775.9761201194115;4996.500349965011;5027.924581131286;5031.622628302892;5046.2178362353525;3507.737214602741;3523.6300188480354;3528.894133176009;3541.610422853484;3545.3618348697482;3542.8582856685443;3568.4468907319406;3580.7314451415727;3580.9283814323567;3588.964110358863;3929.410588411704;4074.4703188585295;4083.9183216335505;4091.89770255746;4101.5488296287385;4804.822818409442;4818.084563932842;4841.6350636307425;4850.320955066293;4861.805527778849;1194.5162209305245;1209.9939500302442;1217.2939694976892;1236.9072319575887;1246.1588427811373;873.6068769053824;888.9333300002526;895.2390468102061;898.384606544506;905.1988989744124;4023.93964090533;4067.349224124126;4077.408775727503;4101.892489027946;4106.809025382665;4757;4760.976195119002;4777.259524773665;4777.522247775195;4803.255495398219;4011.3982902564267;4040.515138183378;4071.75569465833;4089.26393249218;4098.52866920302;2399.9400014999765;2508.3603681061213;2531;2534.100394359976;2557.4757174779124;4488.788027232694;4539.84110556129;4560.224761790503;4568.771561421916;4577.29051996941;4941.555260026615;4958.45456999737;4966.453690094087;4968.826091086795;5001.274815151855;4314.676399270004;4464.776761161994;4469;4511.278195488706;4591.461860276778;4800.399950006249;4836.685615434985;4840.6127509798425;4843.491433399442;4847.2729090636685;4693.296005599187;4708.798017348099;4741.525847415231;4780.498047704941;4781.760911954458;4428.977855110704;4491.30384790358;4528.547145285445;4733.07704997536;4762.738049407316;3519.1905861652476;3538.8584456622475;3546.219831637036;3546.333223385005;3574.1779390739757;4828.130936431476;5027.924581131213;5095.617828662791;5105.846824595268;5119.668886089569;4739.928901066418;4878.682885612424;4889.951100488949;4911.926321105258;4912.1158191525865;4800.543948325043;4831.589314908272;4843.443004054438;4877.6585639004925;4883.536064073907;4580.63354931598;4777.761111944319;4788.401449818773;4857.154281373197;4867.634927380532;4937.851864444073;4941.357623508921;4941.629377796751;4955.231939049453;4963.553280204799;4857.057177129035;4859.538343857328;4887.169181239126;4887.560119589254;4892.45887545422 02:37:24 INFO - PROCESS | 6927 | |5;yui.html;726.7638017644267;755.6410704915165;774.7404619452483;795.252462685076;811.4725428471489;10428.009339112781;11119.777604447916;11133.944330278337;11223.663290101289;11230.55077796887;10960.342379457237;12379.25724456531;12380.257184568909;12401.193922395038;12522.749545009094;842.4987132656075;848.4697064334791;855.9015713192969;860.2687715441887;861.7845538615346;853.564682012172;854.0818619983543;857.2927334948693;858.9055203927563;859.1108203009886;834.3950635789034;885.7387070814093;886.4858382138344;886.8758373827669;888.3381880499037;871.3682580129419;873.4453621950043;874.0778478704964;879.7360791762478;882.3426547222329;646.285854131183;647.3785166240415;647.8186107889799;649.0167396394467;649.6167261315846;10306.690799276033;10508.789824203473;10554.313969592029;10635.840462393071;10664.253502254845;10234;10310.793784124351;10404.635837745642;10416;10439.530221140067;9059.547022648841;9065.637374505011;9245.299883800619;9415.811683766286;9505.619775208983;3133.5143052826847;3210.325831575372;3229.3864165808654;3282.3107147499054;3301.6368199498274;33990;36947.815260923795;37739.24521509582;38358.6164138355;41904;10163.54445435614;10237.062503747808;10337.22470814692;10534.420606866695;10592.470376481146;17256;17378.65242695139;17993.19030643624;18136.274549017893;18186.090695465173;6145.201123853871;6257.843553911189;6422.807315780534;6433.871322573522;6674.432673222734;3521.4013617685055;3550.8934731958084;3616.1863580694135;3645.5625324961175;3659.634036596319;2740.9588856167175;2841.587969744417;2862.6278583783974;2863.55614879694;2954.615899932995;563.6364544868619;565.5277843001057;567.9744411501492;576.5704550110111;579.1891352107084;542.9457054294539;544.3603765575433;608.1485919712438;629.7732816186169;630.2972186012655;7816.921830781619;7936.920630793618;8046.114927357986;8145.185481451807;8412.495250284881;458.51168505541494;576.7750577274866;596.3023262782555;608.7139044649008;618.1315252070848;3511.7717348372275;3555.6977656899453;3596.819341574011;3637.890863274106;3657.250263695936;53072.46927530752;54095.72952135214;55033.1745023825;55304.44695553074;55317.72341138349;47461.76269118701;47721;49939.25091123636;50230.74884625627;51394;45535.316970245476;45800.54199458029;46406.07187856224;46431.53568464407;46949.76525117353;7108.857822843411;7267.60028198433;7387.852242955219;7407.370373518312;7436.330730234305;29199.416011680074;29222.707772922;29535.704642953297;30114.397712046073;30712;36306;39413;40086.599134009455;40149;40683;9389.436633801994;9561.665341713007;9576.377535460173;9617;9780;10514.947425262824;10607.469626518798;10841.891581084088;10956.616518421817;11263.774724505627;9693.6122555097;9834.655787047419;9920.851187232052;10240.129588985019;10417.47912604382;9796.65711700087;9847.162991145546;9975.650852220137;10312.432816194882;10329.793404132026;9422.340436169676;9468.337216394786;9577.042295770367;9752.073553012453;10041.74895627586;8339.082700902774;8451.070382257823;8553.828923421372;8655.95672021661;8686.348523860863;9203.585838637144;9432.669856554987;9445.386049906734;9548.665796697082;9777.560009799718 02:37:24 INFO - PROCESS | 6927 | __end_tp_report 02:37:24 INFO - PROCESS | 6927 | __start_cc_report 02:37:24 INFO - PROCESS | 6927 | _x_x_mozilla_cycle_collect,978 02:37:24 INFO - PROCESS | 6927 | __end_cc_report 02:37:24 INFO - PROCESS | 6927 | __startTimestamp1462873044295__endTimestamp 02:37:24 INFO - PROCESS | 6927 | 02:37:24 INFO - PROCESS | 6927 | ------- Summary: start ------- 02:37:24 INFO - PROCESS | 6927 | Number of tests: 6 02:37:24 INFO - PROCESS | 6927 | 02:37:24 INFO - PROCESS | 6927 | [#0] dojo.html Cycles:165 Average:4630.28 Median:4759.86 stddev:490.77 (10.3%) stddev-sans-first:466.25 02:37:24 INFO - PROCESS | 6927 | Values: 2620.0 2628.6 2648.7 2657.5 2673.9 4481.8 4501.6 4514.3 4653.5 4679.7 4608.1 4612.3 4635.0 4724.3 4749.1 4123.0 4190.8 4322.7 4387.9 4415.6 4265.9 4370.6 4385.4 4386.4 4424.8 4144.6 4199.1 4225.4 4239.4 4311.2 4262.1 4295.3 4311.1 4321.3 4366.6 4263.2 4298.7 4311.9 4322.3 4331.4 4336.7 4561.4 4582.2 4606.4 4699.7 5038.4 5063.9 5090.4 5127.1 5134.8 4877.9 5030.8 5057.6 5069.1 5071.7 4702.6 4732.1 4750.3 4855.8 4855.9 5228.7 5231.2 5261.5 5312.9 5313.3 4737.9 4883.2 4919.2 4973.6 5064.4 4946.9 4966.4 4997.2 5000.1 5064.2 4948.8 4996.1 5003.4 5012.9 5014.7 4734.5 4780.0 4790.4 4923.1 5052.1 4252.1 4270.5 4289.2 4324.5 4329.1 3707.2 3729.0 3738.0 3764.3 3771.7 4172.5 4231.7 4273.3 4313.8 4325.0 4906.5 5001.1 5028.5 5039.5 5048.2 4308.1 4308.8 4313.4 4315.7 4335.0 4400.4 4560.2 4593.7 4606.7 4641.3 4718.9 4789.8 4800.8 4804.0 4823.0 5056.3 5083.9 5103.9 5105.6 5152.2 4568.6 4679.7 4785.0 4821.0 4851.4 4943.7 4976.4 5025.3 5027.6 5065.1 5061.8 5062.6 5072.2 5077.7 5133.2 4535.8 4782.7 4810.4 4867.0 4899.1 4835.5 4848.2 4883.1 4890.8 4921.9 4657.9 4800.1 4801.5 4803.2 4878.3 4759.9 4796.7 4830.8 4832.2 4961.6 4734.7 4743.9 4776.9 4778.2 4811.4 02:37:24 INFO - PROCESS | 6927 | 02:37:24 INFO - PROCESS | 6927 | [#1] ext.html Cycles:180 Average:46584.19 Median:359966.50 stddev:78884.40 (21.9%) stddev-sans-first:79030.00 02:37:24 INFO - PROCESS | 6927 | Values: 558.6 568.3 571.9 577.8 586.2 26720.0 29715.0 29826.6 29991.4 30000.2 30178.5 42864.6 43727.8 44476.0 48908.5 7875.4 7925.7 7929.7 7945.7 7983.9 7432.3 7715.6 7770.5 7798.2 7801.5 10030.1 10110.2 10353.8 10575.7 10648.6 9902.1 9979.8 9994.7 10002.6 10044.6 7370.4 9603.2 9856.4 9927.4 10013.2 38368.8 38843.8 38849.8 38991.6 39132.6 3189.4 3201.0 3223.9 3312.6 3808.9 29266.6 29788.3 30177.0 30224.2 30307.8 2823.3 2857.1 2867.7 2915.2 2916.9 238365.0 238438.0 239596.0 239817.0 240762.8 57411.0 57451.7 57999.1 58356.0 58385.4 59633.4 59719.4 59854.4 60078.4 60234.4 12872.5 14528.8 14808.0 14879.0 14906.2 9646.5 10037.0 10063.8 10951.6 11142.8 17874.7 18158.2 18247.8 18383.4 19276.3 5886.9 5939.0 5971.6 5985.6 5987.1 891.8 903.2 911.1 988.4 1003.6 28041.0 29070.0 29548.1 29564.6 29575.6 996.3 1011.4 1032.1 1043.2 1118.6 15155.8 15524.1 15562.6 15666.8 15811.9 354922.0 359734.0 360199.0 360386.0 360504.0 51590.2 51596.5 51688.8 51714.5 51745.7 1112.2 1213.6 1260.2 1271.3 1272.4 29049.6 29340.0 30164.8 30187.7 30542.8 44195.6 44608.3 44667.3 44705.0 44868.6 289656.0 291308.0 291729.0 294375.0 294531.0 32531.7 38449.4 39733.2 39800.6 42857.6 43404.1 43594.6 43907.6 44250.6 45043.3 36967.6 37559.4 37736.8 38193.2 38264.4 35800.9 36750.3 37119.4 37547.4 37638.2 36174.3 36867.0 36912.8 37875.2 37932.4 30846.0 32582.2 33081.4 33552.2 33744.7 25253.9 25415.4 25736.7 25869.5 26022.1 02:37:24 INFO - PROCESS | 6927 | 02:37:24 INFO - PROCESS | 6927 | [#2] jquery.html Cycles:180 Average:24423.11 Median:47578.76 stddev:68508.86 (144.0%) stddev-sans-first:68677.26 02:37:24 INFO - PROCESS | 6927 | Values: 380.0 381.2 383.5 390.6 398.7 15723.8 17236.0 17344.7 17756.6 17857.4 16757.8 17026.3 17372.9 17471.1 17574.1 4952.9 5094.7 5111.2 5132.9 5170.2 3615.2 5559.2 5891.1 5903.9 5991.8 5907.0 5968.8 5971.5 5974.3 5975.4 5647.3 5789.5 5797.3 5895.8 5923.9 3315.4 4845.8 5149.6 5153.4 5259.9 20216.2 20490.8 20680.2 20726.1 20842.7 2011.8 2035.2 2042.0 2063.1 2226.3 8732.7 9137.3 9410.6 9897.4 12969.2 1722.9 1795.2 1833.4 1867.7 1881.3 39940.6 40956.2 60093.7 68593.0 71755.6 10317.9 10352.3 10441.9 10460.7 10496.7 14280.1 14294.6 14357.0 14378.6 14388.1 7085.8 7521.1 7524.5 7552.4 7583.2 7112.6 7160.8 7220.6 7229.4 7241.7 4488.9 4552.4 4557.5 4569.8 4607.0 1698.5 1739.0 1849.7 1863.9 1887.1 854.9 869.1 881.5 932.7 974.8 16094.1 16321.8 16406.4 16582.2 16790.1 884.1 891.5 904.3 905.3 980.9 9089.0 9496.8 9582.4 9617.2 9648.2 404124.0 410148.6 414419.0 422417.0 435263.0 74377.0 75561.6 75777.0 75824.0 75844.2 918.2 923.6 946.6 949.4 963.8 14901.9 15109.5 15169.7 15198.0 15662.3 23773.0 23845.2 33249.8 34670.7 36589.3 47007.0 48150.5 48210.5 48254.5 49053.3 7541.3 7705.3 7771.1 7838.0 7964.5 9326.0 11111.6 11243.3 11368.9 11637.2 5258.3 7288.4 9252.1 10065.9 10150.3 9739.2 9762.0 9790.5 9990.0 10219.6 9848.7 10316.1 10429.3 10526.3 10811.6 7732.2 7759.4 7777.4 7844.9 7887.0 9969.8 10534.1 10572.5 10580.2 10750.1 02:37:24 INFO - PROCESS | 6927 | 02:37:24 INFO - PROCESS | 6927 | [#3] mootools.html Cycles:180 Average:4807.08 Median:4995.28 stddev:2594.20 (51.9%) stddev-sans-first:2587.82 02:37:24 INFO - PROCESS | 6927 | Values: 1265.1 1419.9 1451.8 1574.5 1761.3 6217.6 6971.4 7007.4 7031.5 7082.2 6768.4 7015.3 7020.9 7164.2 7190.3 2156.9 2200.6 2203.6 2217.9 2218.1 2158.3 2176.0 2176.1 2182.4 2185.7 2165.6 2176.8 2190.0 2203.9 2211.4 2110.4 2149.7 2149.9 2150.2 2160.1 2138.6 2154.0 2161.1 2166.9 2171.5 6896.1 7068.9 7125.9 7129.3 7180.5 4321.3 4411.5 4433.0 4441.6 4485.0 2833.3 2858.1 2879.3 2921.6 2952.3 912.6 923.5 928.5 929.4 931.8 9033.5 9230.0 9330.2 9342.2 9681.9 4060.9 4103.1 4194.1 4213.7 4226.7 8222.3 8426.8 8504.3 8529.3 8552.1 4501.0 4531.0 4534.2 4550.0 4574.6 3471.4 3883.5 3991.9 4037.1 4040.8 3572.4 3644.5 3675.2 3714.7 3813.8 1095.3 1178.0 1181.3 1208.0 1213.0 735.5 850.1 861.4 863.8 867.3 4700.4 4770.4 4901.2 4932.0 4958.1 408.0 419.2 423.8 433.5 433.6 3211.6 3328.3 3356.1 3369.6 3398.4 8405.4 8860.2 8879.6 8941.7 8989.1 8663.4 8762.8 8867.9 8900.6 8901.0 6711.8 6719.8 6778.7 6801.3 6828.2 4854.1 5032.5 5214.3 5229.2 5294.0 7971.0 8187.9 8212.4 8215.3 8226.4 8134.1 8479.8 8529.5 8562.8 8581.9 5609.2 6198.5 6392.4 6424.8 6543.7 7072.2 7077.3 7144.1 7145.3 7168.7 6272.7 6501.6 6530.3 6542.9 6558.1 6169.0 6237.7 6304.8 6431.3 6464.7 5818.2 5903.3 5911.3 5919.8 5927.6 4261.9 4292.4 4332.0 4382.7 4430.2 4143.4 4211.1 4238.4 4423.6 4426.7 02:37:24 INFO - PROCESS | 6927 | 02:37:24 INFO - PROCESS | 6927 | [#4] prototype.html Cycles:180 Average:3995.65 Median:4476.66 stddev:1142.47 (25.5%) stddev-sans-first:1111.48 02:37:24 INFO - PROCESS | 6927 | Values: 299.4 308.2 312.8 315.5 315.9 4593.6 4615.7 4641.4 4660.9 4662.6 4383.3 4383.5 4484.3 4539.2 4613.9 3623.4 3651.1 3673.4 3687.2 3697.4 3662.2 3662.8 3688.2 3690.8 3692.4 3455.8 3518.1 3675.2 3677.9 3687.6 3651.2 3664.8 3668.4 3674.4 3685.3 3269.2 3271.7 3274.8 3275.5 3279.8 4305.5 4395.8 4432.9 4434.6 4457.8 4128.2 4148.1 4149.2 4208.9 4218.7 4753.8 4785.9 4798.1 4856.5 4884.5 3577.2 3583.3 3589.3 3598.5 3607.0 4776.0 4996.5 5027.9 5031.6 5046.2 3507.7 3523.6 3528.9 3541.6 3545.4 3542.9 3568.4 3580.7 3580.9 3589.0 3929.4 4074.5 4083.9 4091.9 4101.5 4804.8 4818.1 4841.6 4850.3 4861.8 1194.5 1210.0 1217.3 1236.9 1246.2 873.6 888.9 895.2 898.4 905.2 4023.9 4067.3 4077.4 4101.9 4106.8 4757.0 4761.0 4777.3 4777.5 4803.3 4011.4 4040.5 4071.8 4089.3 4098.5 2399.9 2508.4 2531.0 2534.1 2557.5 4488.8 4539.8 4560.2 4568.8 4577.3 4941.6 4958.5 4966.5 4968.8 5001.3 4314.7 4464.8 4469.0 4511.3 4591.5 4800.4 4836.7 4840.6 4843.5 4847.3 4693.3 4708.8 4741.5 4780.5 4781.8 4429.0 4491.3 4528.5 4733.1 4762.7 3519.2 3538.9 3546.2 3546.3 3574.2 4828.1 5027.9 5095.6 5105.8 5119.7 4739.9 4878.7 4890.0 4911.9 4912.1 4800.5 4831.6 4843.4 4877.7 4883.5 4580.6 4777.8 4788.4 4857.2 4867.6 4937.9 4941.4 4941.6 4955.2 4963.6 4857.1 4859.5 4887.2 4887.6 4892.5 02:37:24 INFO - PROCESS | 6927 | 02:37:24 INFO - PROCESS | 6927 | [#5] yui.html Cycles:180 Average:12453.38 Median:55168.81 stddev:14677.67 (26.6%) stddev-sans-first:14692.43 02:37:24 INFO - PROCESS | 6927 | Values: 726.8 755.6 774.7 795.3 811.5 10428.0 11119.8 11133.9 11223.7 11230.6 10960.3 12379.3 12380.3 12401.2 12522.7 842.5 848.5 855.9 860.3 861.8 853.6 854.1 857.3 858.9 859.1 834.4 885.7 886.5 886.9 888.3 871.4 873.4 874.1 879.7 882.3 646.3 647.4 647.8 649.0 649.6 10306.7 10508.8 10554.3 10635.8 10664.3 10234.0 10310.8 10404.6 10416.0 10439.5 9059.5 9065.6 9245.3 9415.8 9505.6 3133.5 3210.3 3229.4 3282.3 3301.6 33990.0 36947.8 37739.2 38358.6 41904.0 10163.5 10237.1 10337.2 10534.4 10592.5 17256.0 17378.7 17993.2 18136.3 18186.1 6145.2 6257.8 6422.8 6433.9 6674.4 3521.4 3550.9 3616.2 3645.6 3659.6 2741.0 2841.6 2862.6 2863.6 2954.6 563.6 565.5 568.0 576.6 579.2 542.9 544.4 608.1 629.8 630.3 7816.9 7936.9 8046.1 8145.2 8412.5 458.5 576.8 596.3 608.7 618.1 3511.8 3555.7 3596.8 3637.9 3657.3 53072.5 54095.7 55033.2 55304.4 55317.7 47461.8 47721.0 49939.3 50230.7 51394.0 45535.3 45800.5 46406.1 46431.5 46949.8 7108.9 7267.6 7387.9 7407.4 7436.3 29199.4 29222.7 29535.7 30114.4 30712.0 36306.0 39413.0 40086.6 40149.0 40683.0 9389.4 9561.7 9576.4 9617.0 9780.0 10514.9 10607.5 10841.9 10956.6 11263.8 9693.6 9834.7 9920.9 10240.1 10417.5 9796.7 9847.2 9975.7 10312.4 10329.8 9422.3 9468.3 9577.0 9752.1 10041.7 8339.1 8451.1 8553.8 8656.0 8686.3 9203.6 9432.7 9445.4 9548.7 9777.6 02:37:24 INFO - PROCESS | 6927 | -------- Summary: end -------- 02:37:24 INFO - PROCESS | 6927 | 02:37:24 INFO - TEST-INFO | 6927: exit 0 02:37:24 INFO - TEST-OK | dromaeo_css | took 1116440ms 02:37:24 INFO - TEST-START | kraken 02:37:24 INFO - operating with platform_type : linux_ 02:37:24 INFO - Initialising browser for kraken test... 02:37:24 INFO - TEST-INFO | started process 7103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTdTNsD/profile http://localhost:53961/getInfo.html) 02:37:28 INFO - PROCESS | 7103 | __metrics Screen width/height:1600/1200 02:37:28 INFO - PROCESS | 7103 | colorDepth:24 02:37:28 INFO - PROCESS | 7103 | Browser inner width/height: 1024/697 02:37:28 INFO - PROCESS | 7103 | __metrics 02:37:29 ERROR - PROCESS | 7103 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:37:30 INFO - TEST-INFO | 7103: exit 0 02:37:30 INFO - Browser initialized. 02:37:30 INFO - Running cycle 1/1 for kraken test... 02:37:30 INFO - TEST-INFO | started process 7181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTdTNsD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:42 INFO - PROCESS | 7181 | RSS: Main: 153415680 02:37:42 INFO - PROCESS | 7181 | 02:37:44 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53961/tests/kraken/driver.html?testName=audio-beat-detection) 02:37:45 INFO - PROCESS | 7181 | RSS: Main: 209121280 02:37:45 INFO - PROCESS | 7181 | 02:37:48 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53961/tests/kraken/driver.html?testName=audio-dft) 02:37:49 INFO - PROCESS | 7181 | RSS: Main: 197058560 02:37:49 INFO - PROCESS | 7181 | 02:37:52 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53961/tests/kraken/driver.html?testName=audio-fft) 02:37:53 INFO - PROCESS | 7181 | RSS: Main: 265801728 02:37:53 INFO - PROCESS | 7181 | 02:37:55 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53961/tests/kraken/driver.html?testName=audio-oscillator) 02:37:55 INFO - PROCESS | 7181 | RSS: Main: 174755840 02:37:55 INFO - PROCESS | 7181 | 02:37:58 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53961/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:37:58 INFO - PROCESS | 7181 | RSS: Main: 178036736 02:37:58 INFO - PROCESS | 7181 | 02:38:02 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53961/tests/kraken/driver.html?testName=imaging-darkroom) 02:38:02 INFO - PROCESS | 7181 | RSS: Main: 214589440 02:38:02 INFO - PROCESS | 7181 | 02:38:06 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53961/tests/kraken/driver.html?testName=imaging-desaturate) 02:38:06 INFO - PROCESS | 7181 | RSS: Main: 214147072 02:38:06 INFO - PROCESS | 7181 | 02:38:10 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53961/tests/kraken/driver.html?testName=json-parse-financial) 02:38:10 INFO - PROCESS | 7181 | RSS: Main: 214417408 02:38:10 INFO - PROCESS | 7181 | 02:38:12 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53961/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:38:13 INFO - PROCESS | 7181 | RSS: Main: 210391040 02:38:13 INFO - PROCESS | 7181 | 02:38:14 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53961/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:38:15 INFO - PROCESS | 7181 | RSS: Main: 211259392 02:38:15 INFO - PROCESS | 7181 | 02:38:17 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53961/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:38:18 INFO - PROCESS | 7181 | RSS: Main: 214937600 02:38:18 INFO - PROCESS | 7181 | 02:38:21 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:38:22 INFO - PROCESS | 7181 | RSS: Main: 218353664 02:38:22 INFO - PROCESS | 7181 | 02:38:24 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:38:25 INFO - PROCESS | 7181 | RSS: Main: 216723456 02:38:25 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | Cycle 1(1): loaded http://localhost:53961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53961/tests/kraken/driver.html?testName=ai-astar) 02:38:27 INFO - PROCESS | 7181 | RSS: Main: 262217728 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | __start_tp_report 02:38:27 INFO - PROCESS | 7181 | _x_x_mozilla_page_load 02:38:27 INFO - PROCESS | 7181 | _x_x_mozilla_page_load_details 02:38:27 INFO - PROCESS | 7181 | |i|pagename|runs| 02:38:27 INFO - PROCESS | 7181 | |0;ai-astar;116;113;115;117;115;116;115;116;115;117 02:38:27 INFO - PROCESS | 7181 | |1;audio-beat-detection;158;135;158;218;154;165;158;148;187;136 02:38:27 INFO - PROCESS | 7181 | |2;audio-dft;162;162;161;163;161;163;165;164;164;163 02:38:27 INFO - PROCESS | 7181 | |3;audio-fft;77;78;77;140;78;77;78;76;127;79 02:38:27 INFO - PROCESS | 7181 | |4;audio-oscillator;95;95;147;94;94;94;121;94;93;119 02:38:27 INFO - PROCESS | 7181 | |5;imaging-gaussian-blur;119;119;119;118;118;118;118;118;118;119 02:38:27 INFO - PROCESS | 7181 | |6;imaging-darkroom;148;148;149;149;149;149;149;148;149;149 02:38:27 INFO - PROCESS | 7181 | |7;imaging-desaturate;97;97;96;97;97;95;96;95;95;96 02:38:27 INFO - PROCESS | 7181 | |8;json-parse-financial;66;65;67;65;65;66;64;65;65;65 02:38:27 INFO - PROCESS | 7181 | |9;json-stringify-tinderbox;64;64;65;64;65;65;65;64;64;64 02:38:27 INFO - PROCESS | 7181 | |10;stanford-crypto-aes;87;84;85;85;89;84;85;86;167;87 02:38:27 INFO - PROCESS | 7181 | |11;stanford-crypto-ccm;140;147;148;135;139;136;138;143;161;144 02:38:27 INFO - PROCESS | 7181 | |12;stanford-crypto-pbkdf2;182;185;182;179;177;184;178;178;179;177 02:38:27 INFO - PROCESS | 7181 | |13;stanford-crypto-sha256-iterative;71;72;73;70;69;70;70;69;69;72 02:38:27 INFO - PROCESS | 7181 | __end_tp_report 02:38:27 INFO - PROCESS | 7181 | __start_cc_report 02:38:27 INFO - PROCESS | 7181 | _x_x_mozilla_cycle_collect,1944 02:38:27 INFO - PROCESS | 7181 | __end_cc_report 02:38:27 INFO - PROCESS | 7181 | __startTimestamp1462873107633__endTimestamp 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | ------- Summary: start ------- 02:38:27 INFO - PROCESS | 7181 | Number of tests: 14 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:1.18 (1.0%) stddev-sans-first:1.24 02:38:27 INFO - PROCESS | 7181 | Values: 116.0 113.0 115.0 117.0 115.0 116.0 115.0 116.0 115.0 117.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#1] audio-beat-detection Cycles:10 Average:161.70 Median:158.00 stddev:24.68 (15.6%) stddev-sans-first:26.14 02:38:27 INFO - PROCESS | 7181 | Values: 158.0 135.0 158.0 218.0 154.0 165.0 158.0 148.0 187.0 136.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 02:38:27 INFO - PROCESS | 7181 | Values: 162.0 162.0 161.0 163.0 161.0 163.0 165.0 164.0 164.0 163.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#3] audio-fft Cycles:10 Average:88.70 Median:77.50 stddev:23.82 (30.7%) stddev-sans-first:24.89 02:38:27 INFO - PROCESS | 7181 | Values: 77.0 78.0 77.0 140.0 78.0 77.0 78.0 76.0 127.0 79.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:94.00 stddev:18.39 (19.6%) stddev-sans-first:19.17 02:38:27 INFO - PROCESS | 7181 | Values: 95.0 95.0 147.0 94.0 94.0 94.0 121.0 94.0 93.0 119.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:38:27 INFO - PROCESS | 7181 | Values: 119.0 119.0 119.0 118.0 118.0 118.0 118.0 118.0 118.0 119.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 02:38:27 INFO - PROCESS | 7181 | Values: 148.0 148.0 149.0 149.0 149.0 149.0 149.0 148.0 149.0 149.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.50 stddev:0.88 (0.9%) stddev-sans-first:0.87 02:38:27 INFO - PROCESS | 7181 | Values: 97.0 97.0 96.0 97.0 97.0 95.0 96.0 95.0 95.0 96.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 02:38:27 INFO - PROCESS | 7181 | Values: 66.0 65.0 67.0 65.0 65.0 66.0 64.0 65.0 65.0 65.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 02:38:27 INFO - PROCESS | 7181 | Values: 64.0 64.0 65.0 64.0 65.0 65.0 65.0 64.0 64.0 64.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:85.50 stddev:25.73 (30.1%) stddev-sans-first:27.17 02:38:27 INFO - PROCESS | 7181 | Values: 87.0 84.0 85.0 85.0 89.0 84.0 85.0 86.0 167.0 87.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:143.50 stddev:7.67 (5.3%) stddev-sans-first:8.05 02:38:27 INFO - PROCESS | 7181 | Values: 140.0 147.0 148.0 135.0 139.0 136.0 138.0 143.0 161.0 144.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:180.50 stddev:2.92 (1.6%) stddev-sans-first:3.02 02:38:27 INFO - PROCESS | 7181 | Values: 182.0 185.0 182.0 179.0 177.0 184.0 178.0 178.0 179.0 177.0 02:38:27 INFO - PROCESS | 7181 | 02:38:27 INFO - PROCESS | 7181 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:1.43 (2.0%) stddev-sans-first:1.51 02:38:27 INFO - PROCESS | 7181 | Values: 71.0 72.0 73.0 70.0 69.0 70.0 70.0 69.0 69.0 72.0 02:38:27 INFO - PROCESS | 7181 | -------- Summary: end -------- 02:38:27 INFO - PROCESS | 7181 | 02:38:28 INFO - TEST-INFO | 7181: exit 0 02:38:28 INFO - TEST-OK | kraken | took 63668ms 02:38:28 INFO - SUITE-END | took 1180s 02:38:28 INFO - Completed test suite (00:19:40) 02:38:28 INFO - javascript benchmark 02:38:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.004398328635, 2628.5531459651856, 2648.748368904954, 2657.4817910507445, 2673.933151671208, 4481.798319075641, 4501.617362524181, 4514.345419914111, 4653.511381304961, 4679.719216846992, 4608.07838432314, 4612.308153776927, 4635.0, 4724.338592597039, 4749.097671442423, 4122.989867482471, 4190.790460476979, 4322.654187664995, 4387.903024243939, 4415.558444155591, 4265.87202383929, 4370.56294370562, 4385.364122202279, 4386.363977223316, 4424.80088396023, 4144.5855414458465, 4199.139176468817, 4225.408442817978, 4239.40648309237, 4311.1593239318345, 4262.126264115849, 4295.2912769393015, 4311.051568654891, 4321.2653848845775, 4366.563343665608, 4263.211305908417, 4298.699091063627, 4311.8706438806885, 4322.308430651081, 4331.436913201263, 4336.696431249782, 4561.429821272341, 4582.221022426163, 4606.424196975378, 4699.718016918996, 5038.370203724535, 5063.949360506384, 5090.414602320743, 5127.102757017507, 5134.794608215667, 4877.902441951142, 5030.773615187325, 5057.645964782467, 5069.087564238435, 5071.695698258116, 4702.623790096784, 4732.148213321566, 4750.287456881495, 4855.830045948445, 4855.878603034952, 5228.712420816815, 5231.24146998683, 5261.4738526147075, 5312.893742125136, 5313.335833020872, 4737.9052418952115, 4883.169861123618, 4919.163742163841, 4973.5523802857915, 5064.442911279756, 4946.851594452172, 4966.354373931365, 4997.2254300582745, 5000.074986127578, 5064.1897296433135, 4948.777305021283, 4996.075725990703, 5003.399592048978, 5012.949870501321, 5014.724190169502, 4734.502877197913, 4780.020095880336, 4790.377250957354, 4923.08922849274, 5052.115879721034, 4252.149570085933, 4270.466191726035, 4289.227938970953, 4324.459442569679, 4329.134173165379, 3707.1844194277214, 3728.9745320037205, 3738.0467980664757, 3764.284785890672, 3771.6794072503594, 4172.4784401949755, 4231.682623803227, 4273.316269396882, 4313.827446902152, 4325.0, 4906.460289368167, 5001.149804533238, 5028.472010438924, 5039.496050394931, 5048.242763585492, 4308.052228509723, 4308.763018034038, 4313.439252897103, 4315.697901146889, 4334.978325108417, 4400.383946247528, 4560.247559152769, 4593.678442509059, 4606.700564463299, 4641.303804429363, 4718.882027949328, 4789.808407663724, 4800.7599620019555, 4804.0, 4823.0, 5056.266841307916, 5083.875470475306, 5103.948960510495, 5105.566026887756, 5152.227165925141, 4568.634509239319, 4679.695819771704, 4785.0, 4821.035792841376, 4851.369321988119, 4943.65394422387, 4976.402831660224, 5025.321581586439, 5027.572656324253, 5065.113605119016, 5061.797528098835, 5062.594992400673, 5072.163093089746, 5077.695338279715, 5133.2300154975555, 4535.773211339354, 4782.665213435026, 4810.374651295309, 4866.951330486791, 4899.093667671492, 4835.516448355136, 4848.200046992207, 4883.072216278895, 4890.804367825247, 4921.926171107365, 4657.883552911204, 4800.087983283165, 4801.51984801517, 4803.183458811941, 4878.268259761065, 4759.857204283877, 4796.664233503621, 4830.7826147824135, 4832.202686556679, 4961.5534601886, 4734.73958932262, 4743.857684269477, 4776.928346074742, 4778.187708089703, 4811.422629284369], "value": 4599.359947252083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5699011760944, 568.2953138108746, 571.885622875425, 577.7948828166002, 586.1793489115241, 26720.0, 29715.0, 29826.55260171099, 29991.400171996574, 30000.249993750167, 30178.547321790134, 42864.57135428645, 43727.78136109323, 44476.0, 48908.51091489084, 7875.369970402383, 7925.682972681086, 7929.682812687485, 7945.721899733481, 7983.920160798405, 7432.293932076444, 7715.614219289041, 7770.494917830323, 7798.181190974951, 7801.453898227126, 10030.097291243786, 10110.191184705243, 10353.844692329621, 10575.73560660982, 10648.57405703771, 9902.10881020708, 9979.800403991916, 9994.650187243484, 10002.649907253211, 10044.648437304731, 7370.410367170613, 9603.18372938301, 9856.408615483095, 9927.354721943051, 10013.198944084455, 38368.80815595932, 38843.8057809712, 38849.80575097106, 38991.61008389908, 39132.60867391318, 3189.3621275744945, 3200.959688101353, 3223.871045158191, 3312.5528053712924, 3808.923821523554, 29266.561001584992, 29788.255293617618, 30177.0, 30224.24439389011, 30307.848460757774, 2823.251838262862, 2857.100013495763, 2867.6845546989816, 2915.1546051644996, 2916.8979085732108, 238365.0, 238438.0, 239596.0, 239817.0, 240762.7961860197, 57411.0, 57451.71274143602, 57999.130013049835, 58355.99999999915, 58385.41614583885, 59633.403665963655, 59719.40280597138, 59854.40145598488, 60078.399216008154, 60234.39765602376, 12872.485100596059, 14528.782068268985, 14808.0, 14879.03286286388, 14906.180160091299, 9646.469444180497, 10037.0, 10063.798724025624, 10951.56193752241, 11142.777144457228, 17874.731879021823, 18158.182881770354, 18247.81752182461, 18383.448496545127, 19276.32532861343, 5886.911696324559, 5939.049752039653, 5971.581989260797, 5985.6408615483215, 5987.143985364551, 891.777055736066, 903.1690844423015, 911.1435250864166, 988.4464699768153, 1003.5684655598163, 28041.0, 29070.0, 29548.12031569937, 29564.556531652044, 29575.556366654517, 996.3125443444001, 1011.3830563356347, 1032.1381646325403, 1043.2019505078622, 1118.5693507999479, 15155.848441515664, 15524.146171960425, 15562.610934726723, 15666.764998525032, 15811.920940395225, 354922.0, 359734.0, 360199.0, 360386.0, 360504.0, 51590.226146607834, 51596.48403515917, 51688.83111688876, 51714.48285517172, 51745.74127129416, 1112.2103306652207, 1213.6116442738416, 1260.218664428042, 1271.319843883518, 1272.4337669737063, 29049.564256536592, 29340.0, 30164.84917575398, 30187.698123019367, 30542.84728576343, 44195.558044419144, 44608.33087503755, 44667.32999005083, 44705.0, 44868.55131448774, 289656.0, 291308.0, 291729.0, 294375.0, 294531.0, 32531.674683253812, 38449.4232586517, 39733.2053358937, 39800.60199397969, 42857.57142428661, 43404.13191736084, 43594.56405435905, 43907.560924390345, 44250.55749442464, 45043.32435013412, 36967.630323696416, 37559.43660845035, 37736.81131594325, 38193.23613527658, 38264.426033608965, 35800.92597222087, 36750.26499469942, 37119.44320835244, 37547.43678844765, 37638.24723505569, 36174.276514469035, 36867.0, 36912.81543592372, 37875.242495150495, 37932.43101353537, 30846.0, 32582.185445363106, 33081.36105028493, 33552.16119597029, 33744.662553375136, 25253.87373063123, 25415.36461588475, 25736.742632573434, 25869.482610348063, 26022.089226876968], "value": 18089.04034126735, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.96010418905996, 381.211438328626, 383.45549319965653, 390.5996353737417, 398.710934572435, 15723.764143537855, 17236.0, 17344.65310693787, 17756.556086097837, 17857.374991875287, 16757.83242167578, 17026.318947242096, 17372.913135434304, 17471.126443677796, 17574.121293935284, 4952.851414457563, 5094.668846524983, 5111.2333150027425, 5132.948670513284, 5170.172772356424, 3615.1685112424157, 5559.16612508125, 5891.05743081105, 5903.88192236155, 5991.820245392645, 5906.9704651476895, 5968.7612495500125, 5971.4625683688455, 5974.253218347707, 5975.372585878464, 5647.322321321447, 5789.45000224978, 5797.275340582427, 5895.793647222348, 5923.851903702421, 3315.353506066318, 4845.830395936126, 5149.562287205592, 5153.3558305211845, 5259.868503287448, 20216.19135234589, 20490.795092049037, 20680.17279308826, 20726.067326970322, 20842.687359689466, 2011.8012360346972, 2035.1757538197053, 2041.9897900510402, 2063.10255039057, 2226.3432287475234, 8732.694355697584, 9137.314701397356, 9410.576524056434, 9897.35667181631, 12969.221846689228, 1722.939697110595, 1795.1742198588665, 1833.4224719213405, 1867.673157197485, 1881.3415304643402, 39940.60059399398, 40956.18087638231, 60093.69953150206, 68593.0, 71755.64122179356, 10317.896821031694, 10352.327098738559, 10441.895581044093, 10460.68617941463, 10496.68509944703, 14280.143191408548, 14294.642633934234, 14357.0, 14378.568642940729, 14388.136711797326, 7085.751998680022, 7521.135069466972, 7524.473286869976, 7552.433567482461, 7583.2416758323725, 7112.57324560528, 7160.820979475555, 7220.638968051577, 7229.385502232369, 7241.710331586678, 4488.932666010012, 4552.430946131733, 4557.544245575482, 4569.771511424416, 4607.0, 1698.4819630012964, 1738.9826101739075, 1849.657813304543, 1863.897485638303, 1887.103625777772, 854.8803167556547, 869.0570730757199, 881.4711173296099, 932.6922115701802, 974.8147851908114, 16094.114823684575, 16321.755173672404, 16406.425775097814, 16582.170891455622, 16790.0765457901, 884.1026358246385, 891.527490430073, 904.3307952115518, 905.3300557587338, 980.9019098090276, 9088.954555227181, 9496.810063798684, 9582.377145485521, 9617.182539484082, 9648.179904708179, 404124.0, 410148.6447974366, 414419.0, 422417.0, 435263.0, 74377.0, 75561.62219188869, 75777.0, 75824.0, 75844.24155758483, 918.2011649864661, 923.6213152607398, 946.6213514594217, 949.4113649537331, 963.7976025034822, 14901.850981490046, 15109.54671359861, 15169.696606068037, 15198.0, 15662.295196715948, 23773.0, 23845.165419210243, 33249.833750831094, 34670.65329346674, 36589.26821463609, 47007.0, 48150.518494816, 48210.517894822005, 48254.517454826404, 49053.2642010363, 7541.321281084729, 7705.267999540035, 7771.106322772954, 7838.0, 7964.482308649919, 9326.020767819282, 11111.555537778722, 11243.269187502787, 11368.94315528417, 11637.185397022127, 5258.342707161605, 7288.416926645749, 9252.149570086145, 10065.949670251603, 10150.340227885164, 9739.220862330854, 9762.0, 9790.51047447639, 9990.0, 10219.642312519027, 9848.655297064568, 10316.071553560216, 10429.322094063862, 10526.263161578921, 10811.56753729842, 7732.226777322448, 7759.418043646862, 7777.444511097916, 7844.862494938317, 7886.960565197137, 9969.750756231153, 10534.104601108991, 10572.524236409534, 10580.15358771312, 10750.086242669147], "value": 8193.027860752996, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.0701734225338, 1419.900606957513, 1451.8257809062911, 1574.5276417074874, 1761.2690733345655, 6217.62694238346, 6971.372576468117, 7007.369336759691, 7031.50779445439, 7082.185548661905, 6768.4246839018615, 7015.263397343282, 7020.894686579705, 7164.176119746231, 7190.316919892615, 2156.9029393677324, 2200.5708886767006, 2203.6474164133742, 2217.8891055447243, 2218.057325636606, 2158.3093410108772, 2176.0207906442083, 2176.1186719378675, 2182.3889310992868, 2185.694002839604, 2165.6210163221454, 2176.771438998906, 2190.0144934779332, 2203.8567493112896, 2211.3587059752654, 2110.3774386556, 2149.6668016457475, 2149.9140034398606, 2150.2474134053114, 2160.1467420368867, 2138.625740495407, 2154.0, 2161.070739581979, 2166.859154154991, 2171.522265101675, 6896.103506544167, 7068.893966590505, 7125.9287407125785, 7129.287071292881, 7180.497365184439, 4321.330193819963, 4411.470623525198, 4433.0, 4441.644668426518, 4485.0, 2833.3483298841384, 2858.1139846647397, 2879.3441383358804, 2921.649402071765, 2952.2619345163707, 912.6082723846122, 923.4920793563513, 928.4800511713462, 929.3958926697633, 931.7670582354411, 9033.548322583845, 9229.953850230706, 9330.206932410752, 9342.205912497446, 9681.903180968242, 4060.898477538026, 4103.056297051635, 4194.098268872207, 4213.747175169499, 4226.6829987750425, 8222.259996600214, 8426.831463370698, 8504.31965442763, 8529.317654587618, 8552.102029286836, 4500.954990450054, 4531.0, 4534.161180181677, 4550.0, 4574.588287054181, 3471.392506311385, 3883.5339759229073, 3991.9002024949027, 4037.0916543777416, 4040.797960102042, 3572.4105522589, 3644.526211592476, 3675.209829886587, 3714.7399682022537, 3813.7521061130938, 1095.3044816541553, 1177.9705507362214, 1181.344353883603, 1207.957721479744, 1212.9757404851853, 735.481485552684, 850.1371108325055, 861.3711990247155, 863.8142799298181, 867.2541614211773, 4700.435947686231, 4770.403699537558, 4901.1913034349645, 4932.0, 4958.082754690394, 408.0207501995176, 419.1909614444152, 423.8156401965155, 433.51662895871505, 433.6314132986999, 3211.550382946389, 3328.267781088205, 3356.0770788033487, 3369.629340772513, 3398.3543126805826, 8405.369597280229, 8860.246879015356, 8879.600417981206, 8941.687040953535, 8989.05614910438, 8663.35024873137, 8762.780930476789, 8867.91132088671, 8900.554972251362, 8900.976387715365, 6711.765088221889, 6719.832004199934, 6778.661066946633, 6801.251862295144, 6828.180618325832, 4854.101991131652, 5032.471590483093, 5214.2960700304975, 5229.241759944863, 5293.994141113176, 7970.960145199237, 8187.918120818716, 8212.384071194565, 8215.260626543639, 8226.424150309422, 8134.10524842255, 8479.830403392021, 8529.488230706178, 8562.78593035179, 8581.91418085836, 5609.186667933209, 6198.473129784019, 6392.3927226913365, 6424.839379015562, 6543.738250470118, 7072.151341838807, 7077.292270772881, 7144.142702875688, 7145.285471452813, 7168.713251469882, 6272.749090036347, 6501.642409667514, 6530.314316996647, 6542.901856472252, 6558.114654521579, 6169.0, 6237.7193026314835, 6304.779332723516, 6431.260405053479, 6464.741410343721, 5818.185454036523, 5903.291605007426, 5911.320198177093, 5919.763209471573, 5927.614705044331, 4261.87214383569, 4292.399064131087, 4332.003639162947, 4382.6932114752935, 4430.224710675554, 4143.440635514287, 4211.136716973075, 4238.385434111975, 4423.5576442355505, 4426.690131690751], "value": 3878.8803968020866, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.3504096111438, 308.1894617156877, 312.7669885934978, 315.5424634280294, 315.909965659787, 4593.563611456911, 4615.676902616819, 4641.419822522184, 4660.930086048712, 4662.5546080715, 4383.2548466760645, 4383.517813040563, 4484.327350897367, 4539.160255352762, 4613.892665760219, 3623.3840247158046, 3651.050726811028, 3673.412254039354, 3687.244114956441, 3697.352963231424, 3662.230931504387, 3662.7619204751604, 3688.17016171362, 3690.833912473932, 3692.4461330800327, 3455.773200513819, 3518.1204698825295, 3675.154714415686, 3677.9080522986874, 3687.631236876318, 3651.233241019376, 3664.8350824212976, 3668.4313931340416, 3674.375356189441, 3685.3182161300247, 3269.182704323919, 3271.656476070002, 3274.787138835968, 3275.5086736989406, 3279.7868138570916, 4305.547917468652, 4395.802188901507, 4432.911341773147, 4434.645228381754, 4457.754823484707, 4128.153728485683, 4148.149629326011, 4149.170165966789, 4208.852690155861, 4218.704690671654, 4753.786079626425, 4785.904281914377, 4798.136335459616, 4856.490068542787, 4884.487128851455, 3577.2130131371055, 3583.283343331344, 3589.335972845032, 3598.514200582914, 3607.0, 4775.9761201194115, 4996.500349965011, 5027.924581131286, 5031.622628302892, 5046.2178362353525, 3507.737214602741, 3523.6300188480354, 3528.894133176009, 3541.610422853484, 3545.3618348697482, 3542.8582856685443, 3568.4468907319406, 3580.7314451415727, 3580.9283814323567, 3588.964110358863, 3929.410588411704, 4074.4703188585295, 4083.9183216335505, 4091.89770255746, 4101.5488296287385, 4804.822818409442, 4818.084563932842, 4841.6350636307425, 4850.320955066293, 4861.805527778849, 1194.5162209305245, 1209.9939500302442, 1217.2939694976892, 1236.9072319575887, 1246.1588427811373, 873.6068769053824, 888.9333300002526, 895.2390468102061, 898.384606544506, 905.1988989744124, 4023.93964090533, 4067.349224124126, 4077.408775727503, 4101.892489027946, 4106.809025382665, 4757.0, 4760.976195119002, 4777.259524773665, 4777.522247775195, 4803.255495398219, 4011.3982902564267, 4040.515138183378, 4071.75569465833, 4089.26393249218, 4098.52866920302, 2399.9400014999765, 2508.3603681061213, 2531.0, 2534.100394359976, 2557.4757174779124, 4488.788027232694, 4539.84110556129, 4560.224761790503, 4568.771561421916, 4577.29051996941, 4941.555260026615, 4958.45456999737, 4966.453690094087, 4968.826091086795, 5001.274815151855, 4314.676399270004, 4464.776761161994, 4469.0, 4511.278195488706, 4591.461860276778, 4800.399950006249, 4836.685615434985, 4840.6127509798425, 4843.491433399442, 4847.2729090636685, 4693.296005599187, 4708.798017348099, 4741.525847415231, 4780.498047704941, 4781.760911954458, 4428.977855110704, 4491.30384790358, 4528.547145285445, 4733.07704997536, 4762.738049407316, 3519.1905861652476, 3538.8584456622475, 3546.219831637036, 3546.333223385005, 3574.1779390739757, 4828.130936431476, 5027.924581131213, 5095.617828662791, 5105.846824595268, 5119.668886089569, 4739.928901066418, 4878.682885612424, 4889.951100488949, 4911.926321105258, 4912.1158191525865, 4800.543948325043, 4831.589314908272, 4843.443004054438, 4877.6585639004925, 4883.536064073907, 4580.63354931598, 4777.761111944319, 4788.401449818773, 4857.154281373197, 4867.634927380532, 4937.851864444073, 4941.357623508921, 4941.629377796751, 4955.231939049453, 4963.553280204799, 4857.057177129035, 4859.538343857328, 4887.169181239126, 4887.560119589254, 4892.45887545422], "value": 3643.599785418525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.7638017644267, 755.6410704915165, 774.7404619452483, 795.252462685076, 811.4725428471489, 10428.009339112781, 11119.777604447916, 11133.944330278337, 11223.663290101289, 11230.55077796887, 10960.342379457237, 12379.25724456531, 12380.257184568909, 12401.193922395038, 12522.749545009094, 842.4987132656075, 848.4697064334791, 855.9015713192969, 860.2687715441887, 861.7845538615346, 853.564682012172, 854.0818619983543, 857.2927334948693, 858.9055203927563, 859.1108203009886, 834.3950635789034, 885.7387070814093, 886.4858382138344, 886.8758373827669, 888.3381880499037, 871.3682580129419, 873.4453621950043, 874.0778478704964, 879.7360791762478, 882.3426547222329, 646.285854131183, 647.3785166240415, 647.8186107889799, 649.0167396394467, 649.6167261315846, 10306.690799276033, 10508.789824203473, 10554.313969592029, 10635.840462393071, 10664.253502254845, 10234.0, 10310.793784124351, 10404.635837745642, 10416.0, 10439.530221140067, 9059.547022648841, 9065.637374505011, 9245.299883800619, 9415.811683766286, 9505.619775208983, 3133.5143052826847, 3210.325831575372, 3229.3864165808654, 3282.3107147499054, 3301.6368199498274, 33990.0, 36947.815260923795, 37739.24521509582, 38358.6164138355, 41904.0, 10163.54445435614, 10237.062503747808, 10337.22470814692, 10534.420606866695, 10592.470376481146, 17256.0, 17378.65242695139, 17993.19030643624, 18136.274549017893, 18186.090695465173, 6145.201123853871, 6257.843553911189, 6422.807315780534, 6433.871322573522, 6674.432673222734, 3521.4013617685055, 3550.8934731958084, 3616.1863580694135, 3645.5625324961175, 3659.634036596319, 2740.9588856167175, 2841.587969744417, 2862.6278583783974, 2863.55614879694, 2954.615899932995, 563.6364544868619, 565.5277843001057, 567.9744411501492, 576.5704550110111, 579.1891352107084, 542.9457054294539, 544.3603765575433, 608.1485919712438, 629.7732816186169, 630.2972186012655, 7816.921830781619, 7936.920630793618, 8046.114927357986, 8145.185481451807, 8412.495250284881, 458.51168505541494, 576.7750577274866, 596.3023262782555, 608.7139044649008, 618.1315252070848, 3511.7717348372275, 3555.6977656899453, 3596.819341574011, 3637.890863274106, 3657.250263695936, 53072.46927530752, 54095.72952135214, 55033.1745023825, 55304.44695553074, 55317.72341138349, 47461.76269118701, 47721.0, 49939.25091123636, 50230.74884625627, 51394.0, 45535.316970245476, 45800.54199458029, 46406.07187856224, 46431.53568464407, 46949.76525117353, 7108.857822843411, 7267.60028198433, 7387.852242955219, 7407.370373518312, 7436.330730234305, 29199.416011680074, 29222.707772922, 29535.704642953297, 30114.397712046073, 30712.0, 36306.0, 39413.0, 40086.599134009455, 40149.0, 40683.0, 9389.436633801994, 9561.665341713007, 9576.377535460173, 9617.0, 9780.0, 10514.947425262824, 10607.469626518798, 10841.891581084088, 10956.616518421817, 11263.774724505627, 9693.6122555097, 9834.655787047419, 9920.851187232052, 10240.129588985019, 10417.47912604382, 9796.65711700087, 9847.162991145546, 9975.650852220137, 10312.432816194882, 10329.793404132026, 9422.340436169676, 9468.337216394786, 9577.042295770367, 9752.073553012453, 10041.74895627586, 8339.082700902774, 8451.070382257823, 8553.828923421372, 8655.95672021661, 8686.348523860863, 9203.585838637144, 9432.669856554987, 9445.386049906734, 9548.665796697082, 9777.560009799718], "value": 5784.441847313727, "unit": "score"}], "name": "dromaeo_css", "value": 6180.429449253208, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 115.0, 117.0, 115.0, 116.0, 115.0, 116.0, 115.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 135.0, 158.0, 218.0, 154.0, 165.0, 158.0, 148.0, 187.0, 136.0], "value": 161.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 161.0, 163.0, 165.0, 164.0, 164.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 140.0, 78.0, 77.0, 78.0, 76.0, 127.0, 79.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 147.0, 94.0, 94.0, 94.0, 121.0, 94.0, 93.0, 119.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 149.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 97.0, 97.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 85.0, 89.0, 84.0, 85.0, 86.0, 167.0, 87.0], "value": 93.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 147.0, 148.0, 135.0, 139.0, 136.0, 138.0, 143.0, 161.0, 144.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 182.0, 179.0, 177.0, 184.0, 178.0, 178.0, 179.0, 177.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 73.0, 70.0, 69.0, 70.0, 70.0, 69.0, 69.0, 72.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1613.8000000000002, "alertThreshold": 2.0}]} 02:38:28 INFO - Return code: 0 02:38:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:38:28 ERROR - # TBPL SUCCESS # 02:38:28 INFO - Running post-action listener: _resource_record_post_action 02:38:28 INFO - ##### 02:38:28 INFO - ##### Finished run-tests step (success) 02:38:28 INFO - ##### 02:38:28 INFO - Running post-run listener: _resource_record_post_run 02:38:29 INFO - Total resource usage - Wall time: 1197s; CPU: 26.0%; Read bytes: 4096; Write bytes: 520593408; Read time: 16; Write time: 343164 02:38:29 INFO - install - Wall time: 16s; CPU: 26.0%; Read bytes: 0; Write bytes: 234254336; Read time: 0; Write time: 192628 02:38:29 INFO - run-tests - Wall time: 1182s; CPU: 26.0%; Read bytes: 4096; Write bytes: 285741056; Read time: 16; Write time: 150536 02:38:29 INFO - Running post-run listener: _upload_blobber_files 02:38:29 INFO - Blob upload gear active. 02:38:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:38:29 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 02:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:38:30 INFO - (blobuploader) - INFO - Open directory for files ... 02:38:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:38:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:38:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:31 INFO - (blobuploader) - INFO - Done attempting. 02:38:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:38:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:38:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:31 INFO - (blobuploader) - INFO - Done attempting. 02:38:31 INFO - (blobuploader) - INFO - Iteration through files over. 02:38:31 INFO - Return code: 0 02:38:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:38:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:38:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/965828316015ac16abf5a264828ec909766b7c002aa540e86daca8e5ab114a12e5cf8f93e14f58b50289dccfa60e6a2da0f8157250900bce3b845c777d87d71f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f667b295c3389ff6047ef306f790496a003698cd0c61c85537157e20c2f3d1f3b388b0412cb6f1cf1e2e58179b213e08821de2dc6fc0f1b3ee2606ebda3ba83"} 02:38:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:38:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:38:31 INFO - Contents: 02:38:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/965828316015ac16abf5a264828ec909766b7c002aa540e86daca8e5ab114a12e5cf8f93e14f58b50289dccfa60e6a2da0f8157250900bce3b845c777d87d71f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f667b295c3389ff6047ef306f790496a003698cd0c61c85537157e20c2f3d1f3b388b0412cb6f1cf1e2e58179b213e08821de2dc6fc0f1b3ee2606ebda3ba83"} 02:38:31 INFO - Running post-run listener: copy_logs_to_upload_dir 02:38:31 INFO - Copying logs to upload dir... 02:38:31 INFO - mkdir: /builds/slave/test/build/upload/logs 02:38:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.886194 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-10 02:38:31.730770) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 02:38:31.734046) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/965828316015ac16abf5a264828ec909766b7c002aa540e86daca8e5ab114a12e5cf8f93e14f58b50289dccfa60e6a2da0f8157250900bce3b845c777d87d71f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f667b295c3389ff6047ef306f790496a003698cd0c61c85537157e20c2f3d1f3b388b0412cb6f1cf1e2e58179b213e08821de2dc6fc0f1b3ee2606ebda3ba83"} build_url:https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005363 build_url: 'https://queue.taskcluster.net/v1/task/bPI9EJIzTySdJQqmaoahUw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/965828316015ac16abf5a264828ec909766b7c002aa540e86daca8e5ab114a12e5cf8f93e14f58b50289dccfa60e6a2da0f8157250900bce3b845c777d87d71f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f667b295c3389ff6047ef306f790496a003698cd0c61c85537157e20c2f3d1f3b388b0412cb6f1cf1e2e58179b213e08821de2dc6fc0f1b3ee2606ebda3ba83"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 02:38:31.747092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:38:31.747369) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462857981.558233-575550266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002162 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 02:38:31.826173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 02:38:31.826474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 02:38:31.826756) ========= ========= Total master_lag: 0.25 =========