builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1463007513.04 results: success (0) buildid: 20160511133016 builduid: 46a5a9b0eb66406fa30856d2c9f2b2e7 revision: 1532576c0435896ff83448c0e1eb0d38e0c07f33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.043363) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.043759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.044024) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.075102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.075359) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 15:58:33-- 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% 69.9M=0s 2016-05-11 15:58:33 (69.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120094 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.211197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.211522) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.261543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.261912) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1532576c0435896ff83448c0e1eb0d38e0c07f33 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1532576c0435896ff83448c0e1eb0d38e0c07f33 --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=934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 15:58:33,530 truncating revision to first 12 chars 2016-05-11 15:58:33,530 Setting DEBUG logging. 2016-05-11 15:58:33,530 attempt 1/10 2016-05-11 15:58:33,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1532576c0435?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 15:58:33,915 unpacking tar archive at: mozilla-inbound-1532576c0435/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649527 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.923793) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.924228) ========= script_repo_revision: 1532576c0435896ff83448c0e1eb0d38e0c07f33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.924806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.925219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:33.935485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-11 15:58:33.935860) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:34 INFO - MultiFileLogger online at 20160511 15:58:34 in /builds/slave/test 15:58:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:58:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:34 INFO - {'append_to_log': False, 15:58:34 INFO - 'base_work_dir': '/builds/slave/test', 15:58:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:58:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:34 INFO - 'branch': 'Mozilla-Inbound', 15:58:34 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:34 INFO - 'config_files': ('talos/linux_config.py',), 15:58:34 INFO - 'default_actions': ('clobber', 15:58:34 INFO - 'read-buildbot-config', 15:58:34 INFO - 'download-and-extract', 15:58:34 INFO - 'populate-webroot', 15:58:34 INFO - 'create-virtualenv', 15:58:34 INFO - 'install', 15:58:34 INFO - 'run-tests'), 15:58:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:34 INFO - 'download_minidump_stackwalk': True, 15:58:34 INFO - 'download_symbols': 'ondemand', 15:58:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:34 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:34 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:34 INFO - 'installer_path': 'installer.exe', 15:58:34 INFO - 'log_level': 'info', 15:58:34 INFO - 'log_name': 'talos', 15:58:34 INFO - 'log_to_console': True, 15:58:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:34 INFO - 'opt_config_files': (), 15:58:34 INFO - 'pip_index': False, 15:58:34 INFO - 'sps_profile': False, 15:58:34 INFO - 'sps_profile_interval': 0, 15:58:34 INFO - 'suite': 'dromaeojs', 15:58:34 INFO - 'system_bits': '32', 15:58:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:34 INFO - 'title': 'talos-linux64-ix-057', 15:58:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:34 INFO - 'use_talos_json': True, 15:58:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:34 INFO - 'work_dir': 'build'} 15:58:34 INFO - ##### 15:58:34 INFO - ##### Running clobber step. 15:58:34 INFO - ##### 15:58:34 INFO - Running pre-action listener: _resource_record_pre_action 15:58:34 INFO - Running main action method: clobber 15:58:34 INFO - rmtree: /builds/slave/test/build 15:58:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:35 INFO - Running post-action listener: _resource_record_post_action 15:58:35 INFO - ##### 15:58:35 INFO - ##### Finished clobber step (success) 15:58:35 INFO - ##### 15:58:35 INFO - ##### 15:58:35 INFO - ##### Running read-buildbot-config step. 15:58:35 INFO - ##### 15:58:35 INFO - Running pre-action listener: _resource_record_pre_action 15:58:35 INFO - Running main action method: read_buildbot_config 15:58:35 INFO - Using buildbot properties: 15:58:35 INFO - { 15:58:35 INFO - "project": "", 15:58:35 INFO - "product": "firefox", 15:58:35 INFO - "script_repo_revision": "production", 15:58:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:58:35 INFO - "repository": "", 15:58:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:58:35 INFO - "buildid": "20160511133016", 15:58:35 INFO - "pgo_build": "True", 15:58:35 INFO - "basedir": "/builds/slave/test", 15:58:35 INFO - "buildnumber": 978, 15:58:35 INFO - "slavename": "talos-linux64-ix-057", 15:58:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:58:35 INFO - "platform": "ubuntu64_hw", 15:58:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:58:35 INFO - "branch": "mozilla-inbound", 15:58:35 INFO - "repo_path": "integration/mozilla-inbound", 15:58:35 INFO - "revision": "1532576c0435896ff83448c0e1eb0d38e0c07f33", 15:58:35 INFO - "stage_platform": "linux64-pgo", 15:58:35 INFO - "builduid": "46a5a9b0eb66406fa30856d2c9f2b2e7", 15:58:35 INFO - "slavebuilddir": "test" 15:58:35 INFO - } 15:58:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:58:35 INFO - Running post-action listener: _resource_record_post_action 15:58:35 INFO - ##### 15:58:35 INFO - ##### Finished read-buildbot-config step (success) 15:58:35 INFO - ##### 15:58:35 INFO - ##### 15:58:35 INFO - ##### Running download-and-extract step. 15:58:35 INFO - ##### 15:58:35 INFO - Running pre-action listener: _resource_record_pre_action 15:58:35 INFO - Running main action method: download_and_extract 15:58:35 INFO - mkdir: /builds/slave/test/build/tests 15:58:35 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')]} 15:58:35 INFO - https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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 15:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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 15:58:37 INFO - Downloaded 1361 bytes. 15:58:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:37 INFO - Using the following test package requirements: 15:58:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:58:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:58:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'jsshell-linux-x86_64.zip'], 15:58:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:58:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:58:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:58:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:58:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:58:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:37 INFO - https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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 15:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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 15:58:40 INFO - Downloaded 23902591 bytes. 15:58:40 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'] 15:58:40 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 15:58:41 INFO - Return code: 0 15:58:41 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 15:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:41 INFO - https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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 15:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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 15:58:43 INFO - Downloaded 23902591 bytes. 15:58:43 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'] 15:58:43 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 15:58:44 INFO - Return code: 0 15:58:44 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')]} 15:58:44 INFO - https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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 15:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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 15:58:46 INFO - Downloaded 10840239 bytes. 15:58:46 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'] 15:58:46 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 15:58:47 INFO - Return code: 0 15:58: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')]} 15:58:47 INFO - https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:58:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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 15:58:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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 15:58:48 INFO - Downloaded 58330979 bytes. 15:58:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:48 INFO - mkdir: /builds/slave/test/properties 15:58:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:58:48 INFO - Writing to file /builds/slave/test/properties/build_url 15:58:48 INFO - Contents: 15:58:48 INFO - build_url:https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:49 INFO - Running post-action listener: _resource_record_post_action 15:58:49 INFO - Running post-action listener: set_extra_try_arguments 15:58:49 INFO - ##### 15:58:49 INFO - ##### Finished download-and-extract step (success) 15:58:49 INFO - ##### 15:58:49 INFO - ##### 15:58:49 INFO - ##### Running populate-webroot step. 15:58:49 INFO - ##### 15:58:49 INFO - Running pre-action listener: _resource_record_pre_action 15:58:49 INFO - Running main action method: populate_webroot 15:58:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:58:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:58:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:58:49 INFO - '--tppagecycles', 15:58:49 INFO - '7'], 15:58:49 INFO - 'tests': ['tsvgm']}}, 15:58:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:58:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:58:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:58:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:58:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:58:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:58:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:49 INFO - 'talos_options': ['--disable-e10s'], 15:58:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:49 INFO - 'talos_options': ['--disable-e10s'], 15:58:49 INFO - 'tests': ['damp', 'tps']}, 15:58:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:49 INFO - 'tests': ['damp', 'tps']}, 15:58:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:58:49 INFO - 'tests': ['dromaeo_dom']}, 15:58:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:58:49 INFO - 'tests': ['a11yr', 15:58:49 INFO - 'ts_paint', 15:58:49 INFO - 'tpaint', 15:58:49 INFO - 'sessionrestore', 15:58:49 INFO - 'sessionrestore_no_auto_restore', 15:58:49 INFO - 'tabpaint']}, 15:58:49 INFO - 'other-e10s': {'tests': ['a11yr', 15:58:49 INFO - 'ts_paint', 15:58:49 INFO - 'tpaint', 15:58:49 INFO - 'sessionrestore', 15:58:49 INFO - 'sessionrestore_no_auto_restore', 15:58:49 INFO - 'tabpaint']}, 15:58:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:58:49 INFO - 'ts_paint', 15:58:49 INFO - 'tpaint', 15:58:49 INFO - 'sessionrestore', 15:58:49 INFO - 'sessionrestore_no_auto_restore', 15:58:49 INFO - 'tabpaint']}, 15:58:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:58:49 INFO - 'ts_paint', 15:58:49 INFO - 'tpaint', 15:58:49 INFO - 'sessionrestore', 15:58:49 INFO - 'sessionrestore_no_auto_restore', 15:58:49 INFO - 'tabpaint']}, 15:58:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:58:49 INFO - 'tests': ['a11yr', 15:58:49 INFO - 'ts_paint', 15:58:49 INFO - 'tpaint', 15:58:49 INFO - 'sessionrestore', 15:58:49 INFO - 'sessionrestore_no_auto_restore', 15:58:49 INFO - 'tabpaint']}, 15:58:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:58:49 INFO - 'tests': ['a11yr', 15:58:49 INFO - 'ts_paint', 15:58:49 INFO - 'tpaint', 15:58:49 INFO - 'sessionrestore', 15:58:49 INFO - 'sessionrestore_no_auto_restore', 15:58:49 INFO - 'tabpaint']}, 15:58:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:58:49 INFO - 'tests': ['tsvgx', 15:58:49 INFO - 'tsvgr_opacity', 15:58:49 INFO - 'tart', 15:58:49 INFO - 'tscrollx', 15:58:49 INFO - 'cart']}, 15:58:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:58:49 INFO - 'tsvgr_opacity', 15:58:49 INFO - 'tart', 15:58:49 INFO - 'tscrollx', 15:58:49 INFO - 'cart']}, 15:58:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:49 INFO - 'talos_options': ['--disable-e10s'], 15:58:49 INFO - 'tests': ['tp5o']}, 15:58:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:49 INFO - 'tests': ['tp5o']}, 15:58:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:49 INFO - 'talos_options': ['--disable-e10s', 15:58:49 INFO - '--xperf_path', 15:58:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:49 INFO - 'tests': ['tp5n']}, 15:58:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:49 INFO - 'talos_options': ['--xperf_path', 15:58:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:49 INFO - 'tests': ['tp5n']}}, 15:58:49 INFO - 'talos.zip': {'path': '', 15:58:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:58:49 INFO - Running post-action listener: _resource_record_post_action 15:58:49 INFO - ##### 15:58:49 INFO - ##### Finished populate-webroot step (success) 15:58:49 INFO - ##### 15:58:49 INFO - ##### 15:58:49 INFO - ##### Running create-virtualenv step. 15:58:49 INFO - ##### 15:58:49 INFO - Running pre-action listener: _resource_record_pre_action 15:58:49 INFO - Running main action method: create_virtualenv 15:58:49 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:49 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 15:58:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:58:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:49 INFO - Using real prefix '/usr' 15:58:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:51 INFO - Installing pip.................done. 15:58:51 INFO - Return code: 0 15:58:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d4f20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b479c0>, '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 0x1b488c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b48d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', '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 15:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:58:51 INFO - Using env: {'DISPLAY': ':0', 15:58:51 INFO - 'HOME': '/home/cltbld', 15:58:51 INFO - 'LANG': 'en_US.UTF-8', 15:58:51 INFO - 'LANGUAGE': 'en_US:en', 15:58:51 INFO - 'LOGNAME': 'cltbld', 15:58:51 INFO - 'MAIL': '/var/mail/cltbld', 15:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:51 INFO - 'MOZ_NO_REMOTE': '1', 15:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:51 INFO - 'NO_EM_RESTART': '1', 15:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:51 INFO - 'PWD': '/builds/slave/test', 15:58:51 INFO - 'SHELL': '/bin/bash', 15:58:51 INFO - 'SHLVL': '1', 15:58:51 INFO - 'TERM': 'linux', 15:58:51 INFO - 'TMOUT': '86400', 15:58:51 INFO - 'USER': 'cltbld', 15:58:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', 15:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:51 INFO - '_': '/tools/buildbot/bin/python'} 15:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:52 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 15:58:52 INFO - Cleaning up... 15:58:52 INFO - Return code: 0 15:58:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc4d4f20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b479c0>, '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 0x1b488c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b48d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', '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 15:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:58:52 INFO - Using env: {'DISPLAY': ':0', 15:58:52 INFO - 'HOME': '/home/cltbld', 15:58:52 INFO - 'LANG': 'en_US.UTF-8', 15:58:52 INFO - 'LANGUAGE': 'en_US:en', 15:58:52 INFO - 'LOGNAME': 'cltbld', 15:58:52 INFO - 'MAIL': '/var/mail/cltbld', 15:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:52 INFO - 'MOZ_NO_REMOTE': '1', 15:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:52 INFO - 'NO_EM_RESTART': '1', 15:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:52 INFO - 'PWD': '/builds/slave/test', 15:58:52 INFO - 'SHELL': '/bin/bash', 15:58:52 INFO - 'SHLVL': '1', 15:58:52 INFO - 'TERM': 'linux', 15:58:52 INFO - 'TMOUT': '86400', 15:58:52 INFO - 'USER': 'cltbld', 15:58:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', 15:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:52 INFO - '_': '/tools/buildbot/bin/python'} 15:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:52 INFO - Downloading/unpacking psutil>=0.7.1 15:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:54 INFO - Installing collected packages: psutil 15:58:54 INFO - Running setup.py install for psutil 15:58:54 INFO - building 'psutil._psutil_linux' extension 15:58:54 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 15:58:54 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 15:58:54 INFO - building 'psutil._psutil_posix' extension 15:58:54 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 15:58:54 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 15:58:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:54 INFO - Successfully installed psutil 15:58:54 INFO - Cleaning up... 15:58:54 INFO - Return code: 0 15:58:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:54 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 0x7fc4d4f20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b479c0>, '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 0x1b488c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b48d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', '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 15:58:54 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 15:58:54 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 15:58:54 INFO - Using env: {'DISPLAY': ':0', 15:58:54 INFO - 'HOME': '/home/cltbld', 15:58:54 INFO - 'LANG': 'en_US.UTF-8', 15:58:54 INFO - 'LANGUAGE': 'en_US:en', 15:58:54 INFO - 'LOGNAME': 'cltbld', 15:58:54 INFO - 'MAIL': '/var/mail/cltbld', 15:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:54 INFO - 'MOZ_NO_REMOTE': '1', 15:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:54 INFO - 'NO_EM_RESTART': '1', 15:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:54 INFO - 'PWD': '/builds/slave/test', 15:58:54 INFO - 'SHELL': '/bin/bash', 15:58:54 INFO - 'SHLVL': '1', 15:58:54 INFO - 'TERM': 'linux', 15:58:54 INFO - 'TMOUT': '86400', 15:58:54 INFO - 'USER': 'cltbld', 15:58:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', 15:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:54 INFO - '_': '/tools/buildbot/bin/python'} 15:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:58:57 INFO - Installing collected packages: mozsystemmonitor 15:58:57 INFO - Running setup.py install for mozsystemmonitor 15:58:57 INFO - Successfully installed mozsystemmonitor 15:58:57 INFO - Cleaning up... 15:58:57 INFO - Return code: 0 15:58:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:57 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 0x7fc4d4f20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b479c0>, '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 0x1b488c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b48d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', '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 15:58:57 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 15:58:57 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 15:58:57 INFO - Using env: {'DISPLAY': ':0', 15:58:57 INFO - 'HOME': '/home/cltbld', 15:58:57 INFO - 'LANG': 'en_US.UTF-8', 15:58:57 INFO - 'LANGUAGE': 'en_US:en', 15:58:57 INFO - 'LOGNAME': 'cltbld', 15:58:57 INFO - 'MAIL': '/var/mail/cltbld', 15:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:57 INFO - 'MOZ_NO_REMOTE': '1', 15:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:57 INFO - 'NO_EM_RESTART': '1', 15:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:57 INFO - 'PWD': '/builds/slave/test', 15:58:57 INFO - 'SHELL': '/bin/bash', 15:58:57 INFO - 'SHLVL': '1', 15:58:57 INFO - 'TERM': 'linux', 15:58:57 INFO - 'TMOUT': '86400', 15:58:57 INFO - 'USER': 'cltbld', 15:58:57 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', 15:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:57 INFO - '_': '/tools/buildbot/bin/python'} 15:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:57 INFO - Downloading/unpacking blobuploader==1.2.4 15:58:57 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 15:58:57 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 15:58:57 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 15:58:57 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 15:58:57 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 15:58:57 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 15:58:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:58:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:58:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:59 INFO - Downloading docopt-0.6.1.tar.gz 15:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:00 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:00 INFO - Running setup.py install for blobuploader 15:59:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:00 INFO - Running setup.py install for requests 15:59:00 INFO - Running setup.py install for docopt 15:59:00 INFO - Successfully installed blobuploader requests docopt 15:59:00 INFO - Cleaning up... 15:59:00 INFO - Return code: 0 15:59:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:00 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')]} 15:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:00 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')]} 15:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:00 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 0x7fc4d4f20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b479c0>, '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 0x1b488c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b48d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', '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 15:59:00 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 15:59:00 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 15:59:00 INFO - Using env: {'DISPLAY': ':0', 15:59:00 INFO - 'HOME': '/home/cltbld', 15:59:00 INFO - 'LANG': 'en_US.UTF-8', 15:59:00 INFO - 'LANGUAGE': 'en_US:en', 15:59:00 INFO - 'LOGNAME': 'cltbld', 15:59:00 INFO - 'MAIL': '/var/mail/cltbld', 15:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:00 INFO - 'MOZ_NO_REMOTE': '1', 15:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:00 INFO - 'NO_EM_RESTART': '1', 15:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:00 INFO - 'PWD': '/builds/slave/test', 15:59:00 INFO - 'SHELL': '/bin/bash', 15:59:00 INFO - 'SHLVL': '1', 15:59:00 INFO - 'TERM': 'linux', 15:59:00 INFO - 'TMOUT': '86400', 15:59:00 INFO - 'USER': 'cltbld', 15:59:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', 15:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:00 INFO - '_': '/tools/buildbot/bin/python'} 15:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:00 INFO - Running setup.py (path:/tmp/pip-CIpyrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:00 INFO - Running setup.py (path:/tmp/pip-K0uZRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:00 INFO - Running setup.py (path:/tmp/pip-bcDs4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:01 INFO - Running setup.py (path:/tmp/pip-OBA3vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:01 INFO - Running setup.py (path:/tmp/pip-zOtyl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:01 INFO - Running setup.py (path:/tmp/pip-quDMdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:01 INFO - Running setup.py (path:/tmp/pip-CJVaDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:01 INFO - Running setup.py (path:/tmp/pip-45YdQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:01 INFO - Running setup.py (path:/tmp/pip-IHryBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:01 INFO - Running setup.py (path:/tmp/pip-157hDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:01 INFO - Running setup.py (path:/tmp/pip-PXF4FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:01 INFO - Running setup.py (path:/tmp/pip-79SsXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:01 INFO - Running setup.py (path:/tmp/pip-7EZxJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:01 INFO - Running setup.py (path:/tmp/pip-g1jfgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:01 INFO - Running setup.py (path:/tmp/pip-JN61SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:01 INFO - Running setup.py (path:/tmp/pip-f2aQY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:02 INFO - Running setup.py (path:/tmp/pip-SdFivj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:02 INFO - Running setup.py install for manifestparser 15:59:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Running setup.py install for mozcrash 15:59:02 INFO - Running setup.py install for mozdebug 15:59:02 INFO - Running setup.py install for mozdevice 15:59:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Running setup.py install for mozfile 15:59:02 INFO - Running setup.py install for mozhttpd 15:59:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Running setup.py install for mozinfo 15:59:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Running setup.py install for mozInstall 15:59:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Running setup.py install for mozleak 15:59:02 INFO - Running setup.py install for mozlog 15:59:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for moznetwork 15:59:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for mozprocess 15:59:03 INFO - Running setup.py install for mozprofile 15:59:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for mozrunner 15:59:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for mozscreenshot 15:59:03 INFO - Running setup.py install for moztest 15:59:03 INFO - Running setup.py install for mozversion 15:59:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:03 INFO - Cleaning up... 15:59:03 INFO - Return code: 0 15:59:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:03 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 0x7fc4d4f20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b479c0>, '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 0x1b488c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b48d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', '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 15:59:03 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 15:59:03 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 15:59:03 INFO - Using env: {'DISPLAY': ':0', 15:59:03 INFO - 'HOME': '/home/cltbld', 15:59:03 INFO - 'LANG': 'en_US.UTF-8', 15:59:03 INFO - 'LANGUAGE': 'en_US:en', 15:59:03 INFO - 'LOGNAME': 'cltbld', 15:59:03 INFO - 'MAIL': '/var/mail/cltbld', 15:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:03 INFO - 'MOZ_NO_REMOTE': '1', 15:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:03 INFO - 'NO_EM_RESTART': '1', 15:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:03 INFO - 'PWD': '/builds/slave/test', 15:59:03 INFO - 'SHELL': '/bin/bash', 15:59:03 INFO - 'SHLVL': '1', 15:59:03 INFO - 'TERM': 'linux', 15:59:03 INFO - 'TMOUT': '86400', 15:59:03 INFO - 'USER': 'cltbld', 15:59:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', 15:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:03 INFO - '_': '/tools/buildbot/bin/python'} 15:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:04 INFO - Running setup.py (path:/tmp/pip-L6kgAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:04 INFO - Running setup.py (path:/tmp/pip-UV0D8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:04 INFO - Running setup.py (path:/tmp/pip-3ptI2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:04 INFO - Running setup.py (path:/tmp/pip-RkBbqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:04 INFO - Running setup.py (path:/tmp/pip-cynLwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:04 INFO - Running setup.py (path:/tmp/pip-1M3aO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:04 INFO - Running setup.py (path:/tmp/pip-7Vd0k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:04 INFO - Running setup.py (path:/tmp/pip-OHdodK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:04 INFO - Running setup.py (path:/tmp/pip-ZTv8je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:04 INFO - Running setup.py (path:/tmp/pip-ys3O8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:04 INFO - Running setup.py (path:/tmp/pip-h16MJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:04 INFO - Running setup.py (path:/tmp/pip-HwMxUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:04 INFO - Running setup.py (path:/tmp/pip-GkDmp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:05 INFO - Running setup.py (path:/tmp/pip-Oq55mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:05 INFO - Running setup.py (path:/tmp/pip-QEG_Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:05 INFO - Running setup.py (path:/tmp/pip-7GDf01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:05 INFO - Running setup.py (path:/tmp/pip-L2oi3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:05 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)) 15:59:05 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)) 15:59:05 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)) 15:59:05 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)) 15:59:05 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)) 15:59:05 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)) 15:59:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:07 INFO - Downloading blessings-1.6.tar.gz 15:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:07 INFO - Installing collected packages: blessings 15:59:07 INFO - Running setup.py install for blessings 15:59:07 INFO - Successfully installed blessings 15:59:07 INFO - Cleaning up... 15:59:07 INFO - Return code: 0 15:59:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:07 INFO - Reading from file tmpfile_stdout 15:59:07 INFO - Current package versions: 15:59:07 INFO - argparse == 1.2.1 15:59:07 INFO - blessings == 1.6 15:59:07 INFO - blobuploader == 1.2.4 15:59:07 INFO - docopt == 0.6.1 15:59:07 INFO - manifestparser == 1.1 15:59:07 INFO - mozInstall == 1.12 15:59:07 INFO - mozcrash == 0.17 15:59:07 INFO - mozdebug == 0.1 15:59:07 INFO - mozdevice == 0.48 15:59:07 INFO - mozfile == 1.2 15:59:07 INFO - mozhttpd == 0.7 15:59:07 INFO - mozinfo == 0.9 15:59:07 INFO - mozleak == 0.1 15:59:07 INFO - mozlog == 3.2 15:59:07 INFO - moznetwork == 0.27 15:59:07 INFO - mozprocess == 0.22 15:59:07 INFO - mozprofile == 0.28 15:59:07 INFO - mozrunner == 6.11 15:59:07 INFO - mozscreenshot == 0.1 15:59:07 INFO - mozsystemmonitor == 0.0 15:59:07 INFO - moztest == 0.7 15:59:07 INFO - mozversion == 1.4 15:59:07 INFO - psutil == 3.1.1 15:59:07 INFO - requests == 1.2.3 15:59:07 INFO - wsgiref == 0.1.2 15:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:07 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')]} 15:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:07 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')]} 15:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:07 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 0x7fc4d4f20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b479c0>, '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 0x1b488c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b48d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', '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 15:59:07 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 15:59:07 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 15:59:07 INFO - Using env: {'DISPLAY': ':0', 15:59:07 INFO - 'HOME': '/home/cltbld', 15:59:07 INFO - 'LANG': 'en_US.UTF-8', 15:59:07 INFO - 'LANGUAGE': 'en_US:en', 15:59:07 INFO - 'LOGNAME': 'cltbld', 15:59:07 INFO - 'MAIL': '/var/mail/cltbld', 15:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:07 INFO - 'MOZ_NO_REMOTE': '1', 15:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:07 INFO - 'NO_EM_RESTART': '1', 15:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:07 INFO - 'PWD': '/builds/slave/test', 15:59:07 INFO - 'SHELL': '/bin/bash', 15:59:07 INFO - 'SHLVL': '1', 15:59:07 INFO - 'TERM': 'linux', 15:59:07 INFO - 'TMOUT': '86400', 15:59:07 INFO - 'USER': 'cltbld', 15:59:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', 15:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:07 INFO - '_': '/tools/buildbot/bin/python'} 15:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 INFO - Cleaning up... 15:59:08 INFO - Return code: 0 15:59:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d4f20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b479c0>, '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 0x1b488c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b48d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', '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 15:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:59:08 INFO - Using env: {'DISPLAY': ':0', 15:59:08 INFO - 'HOME': '/home/cltbld', 15:59:08 INFO - 'LANG': 'en_US.UTF-8', 15:59:08 INFO - 'LANGUAGE': 'en_US:en', 15:59:08 INFO - 'LOGNAME': 'cltbld', 15:59:08 INFO - 'MAIL': '/var/mail/cltbld', 15:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:08 INFO - 'MOZ_NO_REMOTE': '1', 15:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:08 INFO - 'NO_EM_RESTART': '1', 15:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:08 INFO - 'PWD': '/builds/slave/test', 15:59:08 INFO - 'SHELL': '/bin/bash', 15:59:08 INFO - 'SHLVL': '1', 15:59:08 INFO - 'TERM': 'linux', 15:59:08 INFO - 'TMOUT': '86400', 15:59:08 INFO - 'USER': 'cltbld', 15:59:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', 15:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:08 INFO - '_': '/tools/buildbot/bin/python'} 15:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:08 INFO - Downloading/unpacking jsonschema 15:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:10 INFO - Downloading/unpacking functools32 (from jsonschema) 15:59:10 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 15:59:10 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 15:59:10 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 15:59:10 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 15:59:10 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 15:59:10 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 15:59:10 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:10 INFO - warning: no files found matching '*.txt' 15:59:10 INFO - no previously-included directories found matching 'build' 15:59:10 INFO - no previously-included directories found matching 'dist' 15:59:10 INFO - no previously-included directories found matching '.git*' 15:59:10 INFO - Installing collected packages: jsonschema, functools32 15:59:10 INFO - Running setup.py install for functools32 15:59:10 INFO - warning: no files found matching '*.txt' 15:59:10 INFO - no previously-included directories found matching 'build' 15:59:10 INFO - no previously-included directories found matching 'dist' 15:59:10 INFO - no previously-included directories found matching '.git*' 15:59:10 INFO - Successfully installed jsonschema functools32 15:59:10 INFO - Cleaning up... 15:59:10 INFO - Return code: 0 15:59:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d4f20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b479c0>, '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 0x1b488c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b48d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', '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 15:59: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', 'flake8'] in /builds/slave/test/build 15:59: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 flake8 15:59:10 INFO - Using env: {'DISPLAY': ':0', 15:59:10 INFO - 'HOME': '/home/cltbld', 15:59:10 INFO - 'LANG': 'en_US.UTF-8', 15:59:10 INFO - 'LANGUAGE': 'en_US:en', 15:59:10 INFO - 'LOGNAME': 'cltbld', 15:59:10 INFO - 'MAIL': '/var/mail/cltbld', 15:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:10 INFO - 'MOZ_NO_REMOTE': '1', 15:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:10 INFO - 'NO_EM_RESTART': '1', 15:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:10 INFO - 'PWD': '/builds/slave/test', 15:59:10 INFO - 'SHELL': '/bin/bash', 15:59:10 INFO - 'SHLVL': '1', 15:59:10 INFO - 'TERM': 'linux', 15:59:10 INFO - 'TMOUT': '86400', 15:59:10 INFO - 'USER': 'cltbld', 15:59:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', 15:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:10 INFO - '_': '/tools/buildbot/bin/python'} 15:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:10 INFO - Downloading/unpacking flake8 15:59:10 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 15:59:10 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 15:59:10 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 15:59:10 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 15:59:10 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 15:59:10 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 15:59:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:59:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:59:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:59:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:13 INFO - no previously-included directories found matching 'docs/_build' 15:59:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:59:13 INFO - Running setup.py install for pep8 15:59:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:13 INFO - no previously-included directories found matching 'docs/_build' 15:59:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:59:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:59:13 INFO - Cleaning up... 15:59:13 INFO - Return code: 0 15:59:13 INFO - Running post-action listener: _resource_record_post_action 15:59:13 INFO - Running post-action listener: _start_resource_monitoring 15:59:13 INFO - Starting resource monitoring. 15:59:13 INFO - ##### 15:59:13 INFO - ##### Finished create-virtualenv step (success) 15:59:13 INFO - ##### 15:59:13 INFO - ##### 15:59:13 INFO - ##### Running install step. 15:59:13 INFO - ##### 15:59:13 INFO - Running pre-action listener: _resource_record_pre_action 15:59:13 INFO - Running main action method: install 15:59:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:13 INFO - Reading from file tmpfile_stdout 15:59:13 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:13 INFO - Reading from file tmpfile_stdout 15:59:13 INFO - Output received: 15:59:13 INFO - Usage: mozinstall [options] installer 15:59:13 INFO - Options: 15:59:13 INFO - -h, --help show this help message and exit 15:59:13 INFO - -d DEST, --destination=DEST 15:59:13 INFO - Directory to install application into. [default: 15:59:13 INFO - "/builds/slave/test"] 15:59:13 INFO - --app=APP Application being installed. [default: firefox] 15:59:13 INFO - mkdir: /builds/slave/test/build/application 15:59:13 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'] 15:59:13 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 15:59:30 INFO - Reading from file tmpfile_stdout 15:59:30 INFO - Output received: 15:59:30 INFO - /builds/slave/test/build/application/firefox/firefox 15:59:30 INFO - Running post-action listener: _resource_record_post_action 15:59:30 INFO - ##### 15:59:30 INFO - ##### Finished install step (success) 15:59:30 INFO - ##### 15:59:30 INFO - ##### 15:59:30 INFO - ##### Running run-tests step. 15:59:30 INFO - ##### 15:59:30 INFO - Running pre-action listener: _resource_record_pre_action 15:59:30 INFO - Running main action method: run_tests 15:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:59:30 INFO - Python 2.7.3 15:59:30 INFO - Return code: 0 15:59:30 INFO - grabbing minidump binary from tooltool 15:59:30 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')]} 15:59:30 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b479c0>, '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 0x1b488c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b48d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:59:30 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 15:59:30 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 15:59:30 INFO - Calling ['/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'] with output_timeout 600 15:59:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:30 INFO - Return code: 0 15:59:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:59:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:59:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:59:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:59:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:59:31 INFO - Return code: 0 15:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 15:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 15:59:31 INFO - Using env: {'DISPLAY': ':0', 15:59:31 INFO - 'HOME': '/home/cltbld', 15:59:31 INFO - 'LANG': 'en_US.UTF-8', 15:59:31 INFO - 'LANGUAGE': 'en_US:en', 15:59:31 INFO - 'LOGNAME': 'cltbld', 15:59:31 INFO - 'MAIL': '/var/mail/cltbld', 15:59:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:31 INFO - 'MOZ_NO_REMOTE': '1', 15:59:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:31 INFO - 'NO_EM_RESTART': '1', 15:59:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:31 INFO - 'PWD': '/builds/slave/test', 15:59:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:31 INFO - 'SHELL': '/bin/bash', 15:59:31 INFO - 'SHLVL': '1', 15:59:31 INFO - 'TERM': 'linux', 15:59:31 INFO - 'TMOUT': '86400', 15:59:31 INFO - 'USER': 'cltbld', 15:59:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815', 15:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:31 INFO - '_': '/tools/buildbot/bin/python'} 15:59:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 15:59:31 INFO - mozversion application_buildid: 20160511133016 15:59:31 INFO - mozversion application_changeset: 1532576c0435896ff83448c0e1eb0d38e0c07f33 15:59:31 INFO - mozversion application_display_name: Nightly 15:59:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:31 INFO - mozversion application_name: Firefox 15:59:31 INFO - mozversion application_remotingname: firefox 15:59:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:59:31 INFO - mozversion application_vendor: Mozilla 15:59:31 INFO - mozversion application_version: 49.0a1 15:59:31 INFO - mozversion platform_buildid: 20160511133016 15:59:31 INFO - mozversion platform_changeset: 1532576c0435896ff83448c0e1eb0d38e0c07f33 15:59:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:59:31 INFO - mozversion platform_version: 49.0a1 15:59:31 INFO - using testdate: 1463007571 15:59:31 INFO - actual date: 1463007571 15:59:31 INFO - starting webserver on 'localhost:36957' 15:59:31 INFO - SUITE-START | Running 2 tests 15:59:31 INFO - TEST-START | dromaeo_css 15:59:31 INFO - operating with platform_type : linux_ 15:59:31 INFO - Initialising browser for dromaeo_css test... 15:59:31 INFO - TEST-INFO | started process 825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoeOIKM/profile http://localhost:36957/getInfo.html) 15:59:35 INFO - PROCESS | 825 | __metrics Screen width/height:1600/1200 15:59:35 INFO - PROCESS | 825 | colorDepth:24 15:59:35 INFO - PROCESS | 825 | Browser inner width/height: 1024/697 15:59:35 INFO - PROCESS | 825 | __metrics 15:59:36 ERROR - PROCESS | 825 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:59:37 INFO - TEST-INFO | 825: exit 0 15:59:37 INFO - Browser initialized. 15:59:37 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:37 INFO - TEST-INFO | started process 914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoeOIKM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:49 INFO - PROCESS | 914 | RSS: Main: 151441408 15:59:49 INFO - PROCESS | 914 | 16:00:40 INFO - PROCESS | 914 | 1463007640599 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:02:48 INFO - PROCESS | 914 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36957/tests/dromaeo/cssquery-ext.html) 16:02:49 INFO - PROCESS | 914 | RSS: Main: 249876480 16:02:49 INFO - PROCESS | 914 | 16:05:51 INFO - PROCESS | 914 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-ext.html (next: http://localhost:36957/tests/dromaeo/cssquery-jquery.html) 16:05:52 INFO - PROCESS | 914 | RSS: Main: 236675072 16:05:52 INFO - PROCESS | 914 | 16:08:54 INFO - PROCESS | 914 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36957/tests/dromaeo/cssquery-mootools.html) 16:08:54 INFO - PROCESS | 914 | RSS: Main: 230735872 16:08:54 INFO - PROCESS | 914 | 16:11:56 INFO - PROCESS | 914 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36957/tests/dromaeo/cssquery-prototype.html) 16:11:57 INFO - PROCESS | 914 | RSS: Main: 231735296 16:11:57 INFO - PROCESS | 914 | 16:15:00 INFO - PROCESS | 914 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36957/tests/dromaeo/cssquery-yui.html) 16:15:00 INFO - PROCESS | 914 | RSS: Main: 222461952 16:15:00 INFO - PROCESS | 914 | 16:18:03 INFO - PROCESS | 914 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-yui.html (next: http://localhost:36957/tests/dromaeo/cssquery-dojo.html) 16:18:03 INFO - PROCESS | 914 | RSS: Main: 305917952 16:18:03 INFO - PROCESS | 914 | 16:18:03 INFO - PROCESS | 914 | __start_tp_report 16:18:03 INFO - PROCESS | 914 | _x_x_mozilla_page_load 16:18:03 INFO - PROCESS | 914 | _x_x_mozilla_page_load_details 16:18:03 INFO - PROCESS | 914 | |i|pagename|runs| 16:18:03 INFO - PROCESS | 914 | |0;dojo.html;3149.448846451871;3151.991362763915;3198.9840050799744;3211;3231.256810933485;5122.308488354071;5170.405403378612;5364.865878353043;5413.133898576229;5450.127979523277;5213.661112027716;5223.555997740187;5236.2931004314405;5269.973650131744;5292.338457692788;4726.149293127236;4802.183628783097;4833.971554965486;4960.479149689285;4991.7504124793795;4850;4884.877878053042;4907.852764417055;4920.68015578988;4955.405351357842;4700.106979673868;4842.225243960985;4855.5872750816225;4885.853424397274;4892.315075889378;4894;4909.091818013643;4910.48439913811;4924.409070911478;4949.554540091409;4618.56123668251;4873.31773551703;4875.58557522611;4881.389826271716;4903.338049363326;5236.3978142513715;5264.078786212397;5273.630845840793;5336.839894803162;5354.705491197982;5730.484256416942;5773;5820.097884827858;5823;5824.767009319622;5539.861503462445;5747.568932330092;5834.737436815353;5874.412558744134;5897.351291357947;5406.053940560386;5527.834164975057;5529.3364796224305;5531.976584331912;5539.224508568764;6014.849628759316;6040.395960403925;6042.758289668364;6042.788502402394;6042.818715438544;5386.5152136307925;5632.155176723442;5656.91514627281;5774.82675519735;5782.566307526952;5798.01433756254;5801.88396232073;5804.912926306109;5813.709314534256;5852.912206316909;5738.928017189978;5771.769129234784;5783.363829978699;5785.479306862402;5789.073748200268;5395.892082158335;5691.686957217393;5698.088305871041;5740.454656807597;5783.1325301204315;4383.583559561836;4384.802683879233;4384.846530371422;4385.035292235703;4415.646748260131;3909.0227443139215;3918.1575961167914;3925.803709814498;3954.6440820326306;3969.940450893239;5228.63399562027;5288.68267903927;5342.091844386386;5374.48942350476;5392.56859451243;5782.392848750821;5803.448672376117;5824.3302020267365;5827.970860145757;5829.679367634821;5422.7017514036315;5428.484293992144;5442.564594832404;5443.618946673695;5444.265024221759;4692.319613656001;4807.61539076873;4816.927746083811;4869.14789911764;4937.35814344133;5993.910091348634;5997.400259974055;5997.430244126801;5999.460048595647;6005.759769609254;5801.419858014249;5808.128780682931;5810.941890581209;5813.970930145322;5818.069108942718;5755.97122014404;5850.034744267148;5877.4122587740885;5925.703714814156;5944.167816505606;5631.408702086222;5646.2942132233475;5670.716464176857;5677.120046392815;5685.317761868602;5502.0921547944145;5788.247527821356;5797.188393624811;5800.187973683604;5802.564807639528;5525.972370138124;5562.360328562268;5601.943980560142;5631.380548139619;5632.380438151882;5625.128105143709;5627.155926611041;5630.3525094613005;5634.690092044977;5641.830745077655;5328.17413300939;5496.835094947158;5540.556755459635;5551.361593416808;5557.499825015768;5658.943410565842;5770.740316685676;5781.971090144522;5785.508231800344;5791.102379131242;5579.832605021856;5609.943900560942;5610.270664813548;5610.298712660918;5655.745491452977 16:18:03 INFO - PROCESS | 914 | |1;ext.html;595.1251660059713;628.9811305660829;641.711229946524;641.8395401149712;656.7799787071331;33572.66427335726;35131.297374052534;35945.82027089864;35986.280274394565;37839.05402364942;45726.314105288446;45813.31280030802;46236.61290161301;46307;46312.073758524806;7790.727324543642;8731.388802783807;8929.55352232389;8935.240504557089;10237.79524409515;10041.648542300984;10387.584496620164;10390.844137337946;10396.740081497948;10401.063904248616;10477.895221047767;10482.842757358645;10520.42137682431;10527.84208236877;10530.684079477627;7981.5610141442485;8122.18778122189;10267.794644107076;10463.476826158661;10541;10316.845247321296;10379.688609341732;10398;10398.220133490018;10408.115310198642;41377.79311103455;41583.7920810394;41604.58395416037;41654;41711.374329385086;3507.368673638744;3529.435290353557;3532.876349327761;3562.9643703562892;4131.8967025824295;32541.83729081363;32779.50830737517;32878;32945;32996.17509562256;4210.91578168438;4351.19502891966;4363.847265345697;4428.867133985986;4517.2998185281;299984;301044;301776;302076;302741.9999999978;56018.07873448901;57221.14168287479;57295.14057289144;57304.42695572991;57974.7101264491;61943.38056619376;62014.689926550076;62252;62370;62418.687906561085;13920.58238252854;14087.647808804657;14116.576502704935;14124.717505649829;14134.36395362211;10603.946980265204;10660;10673.199510036779;10677.305975111592;10680.092192163753;15956.920215398848;17355.913220433817;17372.565685857702;17473.388431405096;17476.475705728848;5255.421903590602;5971.820845374646;6069.271687397452;6211.440970312603;6282.4974002079725;1004.5630150884242;1139.316410153901;1170.8477897873222;1194.8506436695413;1223.9082068844873;30433;31480.685193147776;31486.685133148832;31537.8423107883;32071;1137.8691450483134;1147.3689470791032;1222.8532576090747;1253.7993920972601;1271.1483306184878;16848.663026739643;16850.831491684927;17078.23147958345;17096.145192740314;17251.3962011329;446088;450717;450922;451376;451488;56891.431085688615;56992.71503642455;57057.42942570604;57394.13908791372;57417.42582574121;1198.808190689503;1222.2910711787142;1341.496938648007;1378.7656098463085;1397.8392484864166;26286.265098553802;32596.51105233376;32819.50770738393;32886.34227315488;33074.33851323008;54230;54594;54642.45357546374;54795.45204547903;55057.449425505234;444200;444337;446819;447143;448286;40695.59304406918;41597;42310.78844605757;42444.15111697687;42545.149097018504;47183.764081179375;47585;48465.75767121142;48721.512784871695;48739;40545.797271013456;40632.79683601563;41349.79325103355;41976;42453.57546424496;40083.799581001906;40915;41038.58961410467;41801.79099104485;41936.80631936782;40005.39991900066;40756;41075.383869242585;41112.79443602763;41318.58681413268;35258.64741352656;36196.276074477835;36327.455088174225;37319.44020839635;37589.81205093957;27786.5832012524;28039;28048.43903121885;28602.57096143518;28613.28466788347 16:18:03 INFO - PROCESS | 914 | |2;jquery.html;366.6956426166282;382.163062892266;392.30561905427396;394.3257030477883;403.48757078510295;16764.413245536394;18702.90648546757;18771.249150033982;18817.435476935698;19489.707654385194;17617.11914404278;17946.371876984307;17971.550711232194;18510.44468665939;19899.60200795983;5461.371942226655;5643.746031428585;5802.274715660543;5851.444112809277;5852.005159122938;3896.629820167094;5574.944250557503;5841.15303281024;5844.970775146118;5844.970775146118;5891.469767720904;5907;5929.555283353744;5931.881362372772;5972.343042265347;6504.121943537609;6531.771388001397;6546.639934803584;6554.573952693059;6554.672266386686;4920.876978075541;5217.686938783647;5225.451327610622;5785.421457854223;5794.797182098607;13289.86710132896;13591.320433978262;13781.035327527077;13839.308034598229;13879.167249965034;2314.867960690177;2344.2498400511845;2392.102961389479;2405.482821193452;2720.694066847924;9683.757906052335;9847.90152098477;9909.801803963881;9983.00169983003;11440.828387574193;1914.4926594452481;1929.2379510093435;1934.5550523379702;2005.3783327168478;2056.3830850744716;76807.23192768113;81305.59347203285;81408;82342;83219.16780832174;10685.09176719972;10929.234953553176;10977.890221097847;10981.341119532854;11095.167862410352;15243;15419.691606168039;15420;15435.687966522746;15450.304736286895;7106.253843346478;7176.7129314826825;7178.605176715227;7312.926870731225;7320.231375705474;6436.292007879129;6552.803415897435;6592.241892182365;6656.301088385747;6736.124303840469;4470.754108523997;4495.213337665896;4542.863714088517;4666.2067448533835;4772.76136193189;1737.860971122307;1820.9180586873622;1904.8571357148269;1924.979760726817;1938.2925232290113;902.7652810269377;947.0340252942099;998.5157198758596;1012.7468132966758;1063.2504084620325;18481.5379615508;18594.349197778014;18630.720539191923;19006.80993190078;19357.4192774217;1020.811149937264;1039.5789705169418;1045.278757657214;1082.8700555933337;1092.7158938676002;10417.895821041844;10846.457677116112;10976.725581860517;11014.173936954761;11015;479298;481165;486525;492860;495747;71749;86876;89436.10563894278;89983.55008224917;90999.54500227589;949.6960972488876;950.2113246005798;983.4738414947968;995.2282892145485;1000.849872519128;16357;16488.83511164921;16934.915325423295;17064.146792660566;17469.213885375444;38303.808480957414;39086.6091339083;39980;40915;41034.794826026875;50908;53764.73117634387;54162;54272;54314.45685543252;6654.800355989328;6933.375996160168;7362.852742945218;8465.91534084676;8919.063498332842;10223.1821454282;10225;13166.473341066634;13845.376958036712;13962.441502339792;11646.94176529112;11901.523939042687;12079.154459187772;12124.393780311126;12417.013277875496;11879.04967602607;11962.880371196177;12121.939390302992;12141.332226727614;12171.33057681836;12171.2697238166;12437.689057773629;12439.564615238423;12604.369781511072;12653.620391388273;8071.515709057476;8099.635516401894;8187.426880118334;8226.095129535626;8240.1347858474;9036.909630903607;11315.151363647594;11660.125490588409;11785.587504437304;12222.633321000385 16:18:03 INFO - PROCESS | 914 | |3;mootools.html;1406.5006922542505;1571.6856628674261;1593.5139782366377;1758.43730006398;1868.8131186881315;8526.872096918543;8870.512121833304;8895.377323587352;9023.503707296097;9048.095190480948;8843.248323892461;8973.461592304466;8984.505852178128;8985.550722463884;9002.189802917736;2047.396018174642;2318.733345665245;2365.325882123591;2384.5946189147885;2393.533261014103;2395.7724016218517;2401.847113385576;2403.122860156048;2411.6141417373224;2414.33605758417;2320.2227253869974;2391.421661703276;2393.8204634652384;2394.3415560720855;2398.832081754278;2072.0882811562938;2339.228054741931;2414.432608337057;2421.1889017179265;2437.756224377566;2304.1129165271323;2335.346103091137;2336.439254578906;2339.5905716499547;2340.8361414700976;8973.237274831647;8975.147361000694;8976.685815996409;8995.55022248885;9038.638454461814;5366.141417373241;5463.590230732671;5511.4213007634025;5520.834374968757;5545.972270138664;3544.5923718772156;3548.8048157351336;3578.570571531433;3617.0595645132194;3643.453481977698;1111.0223003756723;1122.2929554380687;1139.2708666453477;1142.605800998654;1152.8674202466657;12713.046521510923;12762.23426594398;12824.935875320563;12845.486180552767;12850.614481565568;4881.145799485076;4886.731229782396;4893.241547560134;4931.3589233399425;4937.802487900515;10632.255742098134;10641;10663.520141593646;10677.893221067845;10681.679549613524;4682.367880336179;5447.673139611636;5473.698946557977;5487.9298536784945;5494.203340515683;4834.7824347904425;4971.552560269593;4997.9500204997485;5014.272930425068;5017.698938063728;4001.959980400217;4010.318245898204;4043.3861114574242;4095.1604920991126;4116.0533077392365;1276.7318863038681;1287.5493577248076;1293.1400618588534;1319.0502837956656;1334.5062326939094;819.2135549872071;872.2498651159997;895.3553441522093;923.1138107416821;945.579217248318;5694.174344719992;5744.195812586241;5820.76716931318;5826.941730582725;5937.287525496881;994.5623925472913;1017.2726500552141;1023.7696518283327;1028.2545154762886;1052.678932925465;3803.5625903020955;3932.960670393317;3935.0752573145287;3964.0684439156776;4001.779902105412;10907.727306817234;11189.49647265875;11209.439528023566;11260.605878794202;11478.253913495597;11076.501557429934;11097.778044439066;11163.051140653135;11169.329840209613;11254.49354779037;8209.548474833942;8298.128696486781;8401.53791541471;8434.873476897852;8514.74455766328;5648.435156484319;5818.476337129509;5867.618604790675;5929;5973.820785376446;10132.34139780912;10384.792304154025;10407.84388234162;10411.958804119527;10587.788244235226;10385.948070259601;10504.684859454228;10723.142148628247;10747.516361763895;10865.497886494528;6918.308169183243;7524.17234104259;7582.597219514408;7740.380769538536;7778.455508114604;8828.911710882809;8856.202941735275;8887.511186884525;8893.155150260714;8899.955500222717;7730.18833022547;7912.683492660229;7936.761897143095;7977.760667179994;7993.8401231976195;7652.464327497022;7666.425018123775;7730.188330225245;7793.766187014398;7927.643256053607;7222.277772222736;7268.600226987566;7345.485815992829;7358.337749602561;7360.926390736024;5234.842954711365;5241.423443421144;5285.127953887719;5356.625036247581;5421.593380496557;5218.739063046908;5304.893902121858;5332.3068001161155;5480.862978425571;5518.751656175402 16:18:03 INFO - PROCESS | 914 | |4;prototype.html;334.15292234186336;336.96124945631243;340.4773672412847;341.9025577710353;344.6243594482016;5269.341332333458;5289.391719952202;5370.140777475604;5377.381601115872;5384.43463436339;5274.657147285424;5278;5278.806322175077;5285.127953887613;5302.125149350362;3954.1498577805696;4005.7396269242404;4124;4166.708330416872;4184.435101261336;4132.400801883725;4155.833766649331;4157.875263742078;4169.166166766644;4175.956010997251;3953.189596132786;4159.480064991876;4166.354215096665;4185.518665353493;4201.1807697499;4031.657309128698;4061.918761624766;4072.3077076896852;4119.938200926988;4135.379693046037;3654.14127679995;3667.8446289419016;3673.2837096766143;3688.7233457490797;3690.833912473918;5019.924701129486;5065.544101030888;5077.796888124471;5081.415637201732;5098.158803797369;4540.477845047796;4698.4361876574685;4708.152532544141;4755.809767609326;4763.976180119112;5426.9185962210595;5488.722180295173;5497.976113137758;5499.945000549983;5512.657120723717;4068.9593104068877;4074.30736774749;4079.6736261099336;4079.8980025499304;4101.364288535282;5606.747696353674;5643.40744221859;5735.713214339266;5744.621290890198;5750.913736293959;4098.180363927227;4106.260873042821;4117.402976568441;4134.462519872457;4138.896527586774;4202.621764041251;4208.263553878059;4216.9578304217175;4232.957670423318;4241.34259189826;4547.567981041796;4721.197396442613;4725.416985309891;4732.397181550134;4786.976065119652;5471.37079235893;5484.327280179504;5498.360786822268;5508.44915508446;5552.973164794821;1429.2353590828857;1441.5891470930735;1446.2624061728595;1462.9707405851823;1476.1290838405391;932.5104320231796;950.8573713942964;951.3435729346728;957.305953183936;964.2286171063262;4678.8128474861305;4706.552877476634;4773.307870358779;4793.400824896888;4793.9280910786365;4957.735777376818;4977.352944117241;4980.9252861207115;4997.30037794709;5066.417362003417;4520.683552151318;4741.57325840676;4759.547842954914;4778.713277203379;4781.545753153445;2645.140329392955;2685.4763321152577;2689.5696688530134;2690.2870739254113;2695.460907818444;5008.924866127011;5067.619928505377;5121.359830021247;5145.404924473425;5194.948050519522;4709.670323077352;5014.824481143142;5085.440601533828;5093.853882876398;5096.108181068298;5115.92326115116;5156.252343410185;5156.845294641167;5191.428942816363;5208.099043848968;5011.599072074298;5060.822871199491;5086.18621020635;5103.642745007814;5121.617163365796;4829.806807727651;4965.379327584052;4972.8508144755715;4997.450280469218;5011.872328726007;5163.535281824654;5184.9740751296;5191.90969896326;5234.555062819551;5238.214267859851;3814.2263847311133;3821.636944490269;3832.1760821423527;3834.6932245419744;3846.2499812537408;5036.521530454601;5058.873528161826;5213.611152750743;5456.690394305418;5693.629914055573;5355.768173320081;5579.581531385081;5589.888202236014;5603.38362780102;5614.69119198448;5521.1442226454965;5525.392206857323;5535.335759708861;5559.193916881949;5568.888622227614;5235.869103272448;5450.81967213118;5470.398256191896;5531.059719847716;5540.252065971043;5619.297587801525;5633.943660563506;5639.3232812062815;5643.858903527281;5665.830025099253;5471.917921231265;5473.397926228032;5496.532794712494;5543;5545.944540554543 16:18:03 INFO - PROCESS | 914 | |5;yui.html;807.6769292283086;810.7689308547066;861.4056301152204;872.4765140915448;879.2877769007109;14059.648508787286;14613.269336533158;14620.268986550684;14638.560843174695;14690;14149;14166.645833854158;14174.71650566988;14217.502387416442;14291.428342866273;686.0703746423599;703.6833424958763;792.5324058805304;816.8774683797434;826.3430572694722;810.6716779704229;818.5743413425015;818.8116733151379;818.8771684247381;819.5574389829485;871.9869201961976;882.3646974178581;883.2271762208068;883.8939327280735;884.3014018925073;719.4460265595515;848.1264297773304;873.8077622922947;873.8208667223236;874.558348034245;632.9936700633027;633.6483251795252;633.6989929783363;633.8795628830553;634.6699716147577;13897.861021389757;13990.0906441081;14021.579352619336;14030.579082627537;14068.437262509487;13397.263150526716;13934;14032.43870245189;14128.858711412857;14154;12128;12315.261084334968;12345.5061797528;12517.687057823536;12538.24770513763;4466.285394336891;4504.752238626874;4532.7280363178315;4645.070985802819;4657.906841863178;55934.160987585215;56091.43908560903;56211.71894140544;56961.71519142419;57323.85352292973;10704.78590428187;10749.516271767789;10826.94586527078;10923.071538919123;11141.832872506919;19529;19679;19735.901320493595;19736.11187496566;19744.70382944257;8150.796230094176;8164.428490005643;8310.958445207736;8329.042160151539;8446.957765211135;4883.291922671264;4946.258061290763;4955.4548999610015;4975.228839529878;4992.775325110379;3416.6754158354915;3490.771036791009;3493.406120959443;3495.790252584853;3496.8984769797435;624.6845343101795;636.4971672378769;637.5855693798975;641.6278558436096;642.5373730913734;734.9375303099297;737.9446541509408;750.7972847331299;753.5102183580607;756.8826831841073;9312.161905428544;9573.664921727706;9764.877039140447;10423.92349743109;10664.146868250677;626.8652239768471;648.8896887529131;717.9425645948312;783.5318745950302;798.2097723253937;4645.837395691202;4705.435347758291;4802.351682522884;4900.754962251873;4901.656884018084;67791.66104169546;68358.3164168352;68399.31600683929;69132.654336728;69278;58596.414035859096;59185;59389.70305148447;59767.40232597618;60542.697286513285;53625.731871340395;53954.19068713972;54299.99999999921;54371.45628543664;54838;8802.29581633455;8974.596143173443;9000.864987025068;9003.954980225319;9028.683996060106;33247.66752332446;33400.498992514644;33642.66357336493;34026.14934626654;34096.82951585226;44644.55355446404;46877.2968405481;46955.76522117368;47019.76490117527;47352.52647473481;11881.465334059814;12141.392930353624;12153.210041347284;12243.20419172751;12563.309018004098;13051.804222936853;13092.672683182996;13448.327583620976;13690.178589284675;13723.519676811264;12684.175528590613;13016.479340826261;13190.076694631283;13302.268375239455;13394.330283485591;12289.508419663114;12325.630231093082;12479.438425270702;12914.80627790565;12967.870321296667;12355.135140540076;12573.74852502963;12579.433925473559;12976.02679799;13020.674483137618;10323.174146068146;10448.42533660656;10459.163266938778;11094.278871873303;11139.443027848738;10539.841902371318;10820;10866.185036122164;10982.450877455936;11046.116310695286 16:18:03 INFO - PROCESS | 914 | __end_tp_report 16:18:03 INFO - PROCESS | 914 | __start_cc_report 16:18:03 INFO - PROCESS | 914 | _x_x_mozilla_cycle_collect,859 16:18:03 INFO - PROCESS | 914 | __end_cc_report 16:18:03 INFO - PROCESS | 914 | __startTimestamp1463008683836__endTimestamp 16:18:03 INFO - PROCESS | 914 | 16:18:03 INFO - PROCESS | 914 | ------- Summary: start ------- 16:18:03 INFO - PROCESS | 914 | Number of tests: 6 16:18:03 INFO - PROCESS | 914 | 16:18:03 INFO - PROCESS | 914 | [#0] dojo.html Cycles:165 Average:5342.14 Median:5540.56 stddev:615.36 (11.1%) stddev-sans-first:592.71 16:18:03 INFO - PROCESS | 914 | Values: 3149.4 3152.0 3199.0 3211.0 3231.3 5122.3 5170.4 5364.9 5413.1 5450.1 5213.7 5223.6 5236.3 5270.0 5292.3 4726.1 4802.2 4834.0 4960.5 4991.8 4850.0 4884.9 4907.9 4920.7 4955.4 4700.1 4842.2 4855.6 4885.9 4892.3 4894.0 4909.1 4910.5 4924.4 4949.6 4618.6 4873.3 4875.6 4881.4 4903.3 5236.4 5264.1 5273.6 5336.8 5354.7 5730.5 5773.0 5820.1 5823.0 5824.8 5539.9 5747.6 5834.7 5874.4 5897.4 5406.1 5527.8 5529.3 5532.0 5539.2 6014.8 6040.4 6042.8 6042.8 6042.8 5386.5 5632.2 5656.9 5774.8 5782.6 5798.0 5801.9 5804.9 5813.7 5852.9 5738.9 5771.8 5783.4 5785.5 5789.1 5395.9 5691.7 5698.1 5740.5 5783.1 4383.6 4384.8 4384.8 4385.0 4415.6 3909.0 3918.2 3925.8 3954.6 3969.9 5228.6 5288.7 5342.1 5374.5 5392.6 5782.4 5803.4 5824.3 5828.0 5829.7 5422.7 5428.5 5442.6 5443.6 5444.3 4692.3 4807.6 4816.9 4869.1 4937.4 5993.9 5997.4 5997.4 5999.5 6005.8 5801.4 5808.1 5810.9 5814.0 5818.1 5756.0 5850.0 5877.4 5925.7 5944.2 5631.4 5646.3 5670.7 5677.1 5685.3 5502.1 5788.2 5797.2 5800.2 5802.6 5526.0 5562.4 5601.9 5631.4 5632.4 5625.1 5627.2 5630.4 5634.7 5641.8 5328.2 5496.8 5540.6 5551.4 5557.5 5658.9 5770.7 5782.0 5785.5 5791.1 5579.8 5609.9 5610.3 5610.3 5655.7 16:18:03 INFO - PROCESS | 914 | 16:18:03 INFO - PROCESS | 914 | [#1] ext.html Cycles:180 Average:57030.36 Median:37454.63 stddev:106994.65 (285.7%) stddev-sans-first:107210.89 16:18:03 INFO - PROCESS | 914 | Values: 595.1 629.0 641.7 641.8 656.8 33572.7 35131.3 35945.8 35986.3 37839.1 45726.3 45813.3 46236.6 46307.0 46312.1 7790.7 8731.4 8929.6 8935.2 10237.8 10041.6 10387.6 10390.8 10396.7 10401.1 10477.9 10482.8 10520.4 10527.8 10530.7 7981.6 8122.2 10267.8 10463.5 10541.0 10316.8 10379.7 10398.0 10398.2 10408.1 41377.8 41583.8 41604.6 41654.0 41711.4 3507.4 3529.4 3532.9 3563.0 4131.9 32541.8 32779.5 32878.0 32945.0 32996.2 4210.9 4351.2 4363.8 4428.9 4517.3 299984.0 301044.0 301776.0 302076.0 302742.0 56018.1 57221.1 57295.1 57304.4 57974.7 61943.4 62014.7 62252.0 62370.0 62418.7 13920.6 14087.6 14116.6 14124.7 14134.4 10603.9 10660.0 10673.2 10677.3 10680.1 15956.9 17355.9 17372.6 17473.4 17476.5 5255.4 5971.8 6069.3 6211.4 6282.5 1004.6 1139.3 1170.8 1194.9 1223.9 30433.0 31480.7 31486.7 31537.8 32071.0 1137.9 1147.4 1222.9 1253.8 1271.1 16848.7 16850.8 17078.2 17096.1 17251.4 446088.0 450717.0 450922.0 451376.0 451488.0 56891.4 56992.7 57057.4 57394.1 57417.4 1198.8 1222.3 1341.5 1378.8 1397.8 26286.3 32596.5 32819.5 32886.3 33074.3 54230.0 54594.0 54642.5 54795.5 55057.4 444200.0 444337.0 446819.0 447143.0 448286.0 40695.6 41597.0 42310.8 42444.2 42545.1 47183.8 47585.0 48465.8 48721.5 48739.0 40545.8 40632.8 41349.8 41976.0 42453.6 40083.8 40915.0 41038.6 41801.8 41936.8 40005.4 40756.0 41075.4 41112.8 41318.6 35258.6 36196.3 36327.5 37319.4 37589.8 27786.6 28039.0 28048.4 28602.6 28613.3 16:18:03 INFO - PROCESS | 914 | 16:18:03 INFO - PROCESS | 914 | [#2] jquery.html Cycles:180 Average:28161.75 Median:21100.22 stddev:80232.14 (380.2%) stddev-sans-first:80430.06 16:18:03 INFO - PROCESS | 914 | Values: 366.7 382.2 392.3 394.3 403.5 16764.4 18702.9 18771.2 18817.4 19489.7 17617.1 17946.4 17971.6 18510.4 19899.6 5461.4 5643.7 5802.3 5851.4 5852.0 3896.6 5574.9 5841.2 5845.0 5845.0 5891.5 5907.0 5929.6 5931.9 5972.3 6504.1 6531.8 6546.6 6554.6 6554.7 4920.9 5217.7 5225.5 5785.4 5794.8 13289.9 13591.3 13781.0 13839.3 13879.2 2314.9 2344.2 2392.1 2405.5 2720.7 9683.8 9847.9 9909.8 9983.0 11440.8 1914.5 1929.2 1934.6 2005.4 2056.4 76807.2 81305.6 81408.0 82342.0 83219.2 10685.1 10929.2 10977.9 10981.3 11095.2 15243.0 15419.7 15420.0 15435.7 15450.3 7106.3 7176.7 7178.6 7312.9 7320.2 6436.3 6552.8 6592.2 6656.3 6736.1 4470.8 4495.2 4542.9 4666.2 4772.8 1737.9 1820.9 1904.9 1925.0 1938.3 902.8 947.0 998.5 1012.7 1063.3 18481.5 18594.3 18630.7 19006.8 19357.4 1020.8 1039.6 1045.3 1082.9 1092.7 10417.9 10846.5 10976.7 11014.2 11015.0 479298.0 481165.0 486525.0 492860.0 495747.0 71749.0 86876.0 89436.1 89983.6 90999.5 949.7 950.2 983.5 995.2 1000.8 16357.0 16488.8 16934.9 17064.1 17469.2 38303.8 39086.6 39980.0 40915.0 41034.8 50908.0 53764.7 54162.0 54272.0 54314.5 6654.8 6933.4 7362.9 8465.9 8919.1 10223.2 10225.0 13166.5 13845.4 13962.4 11646.9 11901.5 12079.2 12124.4 12417.0 11879.0 11962.9 12121.9 12141.3 12171.3 12171.3 12437.7 12439.6 12604.4 12653.6 8071.5 8099.6 8187.4 8226.1 8240.1 9036.9 11315.2 11660.1 11785.6 12222.6 16:18:03 INFO - PROCESS | 914 | 16:18:03 INFO - PROCESS | 914 | [#3] mootools.html Cycles:180 Average:5936.60 Median:4857.96 stddev:3398.05 (69.9%) stddev-sans-first:3390.53 16:18:03 INFO - PROCESS | 914 | Values: 1406.5 1571.7 1593.5 1758.4 1868.8 8526.9 8870.5 8895.4 9023.5 9048.1 8843.2 8973.5 8984.5 8985.6 9002.2 2047.4 2318.7 2365.3 2384.6 2393.5 2395.8 2401.8 2403.1 2411.6 2414.3 2320.2 2391.4 2393.8 2394.3 2398.8 2072.1 2339.2 2414.4 2421.2 2437.8 2304.1 2335.3 2336.4 2339.6 2340.8 8973.2 8975.1 8976.7 8995.6 9038.6 5366.1 5463.6 5511.4 5520.8 5546.0 3544.6 3548.8 3578.6 3617.1 3643.5 1111.0 1122.3 1139.3 1142.6 1152.9 12713.0 12762.2 12824.9 12845.5 12850.6 4881.1 4886.7 4893.2 4931.4 4937.8 10632.3 10641.0 10663.5 10677.9 10681.7 4682.4 5447.7 5473.7 5487.9 5494.2 4834.8 4971.6 4998.0 5014.3 5017.7 4002.0 4010.3 4043.4 4095.2 4116.1 1276.7 1287.5 1293.1 1319.1 1334.5 819.2 872.2 895.4 923.1 945.6 5694.2 5744.2 5820.8 5826.9 5937.3 994.6 1017.3 1023.8 1028.3 1052.7 3803.6 3933.0 3935.1 3964.1 4001.8 10907.7 11189.5 11209.4 11260.6 11478.3 11076.5 11097.8 11163.1 11169.3 11254.5 8209.5 8298.1 8401.5 8434.9 8514.7 5648.4 5818.5 5867.6 5929.0 5973.8 10132.3 10384.8 10407.8 10412.0 10587.8 10385.9 10504.7 10723.1 10747.5 10865.5 6918.3 7524.2 7582.6 7740.4 7778.5 8828.9 8856.2 8887.5 8893.2 8900.0 7730.2 7912.7 7936.8 7977.8 7993.8 7652.5 7666.4 7730.2 7793.8 7927.6 7222.3 7268.6 7345.5 7358.3 7360.9 5234.8 5241.4 5285.1 5356.6 5421.6 5218.7 5304.9 5332.3 5480.9 5518.8 16:18:03 INFO - PROCESS | 914 | 16:18:03 INFO - PROCESS | 914 | [#4] prototype.html Cycles:180 Average:4486.85 Median:5011.74 stddev:1277.16 (25.5%) stddev-sans-first:1242.13 16:18:03 INFO - PROCESS | 914 | Values: 334.2 337.0 340.5 341.9 344.6 5269.3 5289.4 5370.1 5377.4 5384.4 5274.7 5278.0 5278.8 5285.1 5302.1 3954.1 4005.7 4124.0 4166.7 4184.4 4132.4 4155.8 4157.9 4169.2 4176.0 3953.2 4159.5 4166.4 4185.5 4201.2 4031.7 4061.9 4072.3 4119.9 4135.4 3654.1 3667.8 3673.3 3688.7 3690.8 5019.9 5065.5 5077.8 5081.4 5098.2 4540.5 4698.4 4708.2 4755.8 4764.0 5426.9 5488.7 5498.0 5499.9 5512.7 4069.0 4074.3 4079.7 4079.9 4101.4 5606.7 5643.4 5735.7 5744.6 5750.9 4098.2 4106.3 4117.4 4134.5 4138.9 4202.6 4208.3 4217.0 4233.0 4241.3 4547.6 4721.2 4725.4 4732.4 4787.0 5471.4 5484.3 5498.4 5508.4 5553.0 1429.2 1441.6 1446.3 1463.0 1476.1 932.5 950.9 951.3 957.3 964.2 4678.8 4706.6 4773.3 4793.4 4793.9 4957.7 4977.4 4980.9 4997.3 5066.4 4520.7 4741.6 4759.5 4778.7 4781.5 2645.1 2685.5 2689.6 2690.3 2695.5 5008.9 5067.6 5121.4 5145.4 5194.9 4709.7 5014.8 5085.4 5093.9 5096.1 5115.9 5156.3 5156.8 5191.4 5208.1 5011.6 5060.8 5086.2 5103.6 5121.6 4829.8 4965.4 4972.9 4997.5 5011.9 5163.5 5185.0 5191.9 5234.6 5238.2 3814.2 3821.6 3832.2 3834.7 3846.2 5036.5 5058.9 5213.6 5456.7 5693.6 5355.8 5579.6 5589.9 5603.4 5614.7 5521.1 5525.4 5535.3 5559.2 5568.9 5235.9 5450.8 5470.4 5531.1 5540.3 5619.3 5633.9 5639.3 5643.9 5665.8 5471.9 5473.4 5496.5 5543.0 5545.9 16:18:03 INFO - PROCESS | 914 | 16:18:03 INFO - PROCESS | 914 | [#5] yui.html Cycles:180 Average:15445.82 Median:46987.77 stddev:18264.19 (38.9%) stddev-sans-first:18282.35 16:18:03 INFO - PROCESS | 914 | Values: 807.7 810.8 861.4 872.5 879.3 14059.6 14613.3 14620.3 14638.6 14690.0 14149.0 14166.6 14174.7 14217.5 14291.4 686.1 703.7 792.5 816.9 826.3 810.7 818.6 818.8 818.9 819.6 872.0 882.4 883.2 883.9 884.3 719.4 848.1 873.8 873.8 874.6 633.0 633.6 633.7 633.9 634.7 13897.9 13990.1 14021.6 14030.6 14068.4 13397.3 13934.0 14032.4 14128.9 14154.0 12128.0 12315.3 12345.5 12517.7 12538.2 4466.3 4504.8 4532.7 4645.1 4657.9 55934.2 56091.4 56211.7 56961.7 57323.9 10704.8 10749.5 10826.9 10923.1 11141.8 19529.0 19679.0 19735.9 19736.1 19744.7 8150.8 8164.4 8311.0 8329.0 8447.0 4883.3 4946.3 4955.5 4975.2 4992.8 3416.7 3490.8 3493.4 3495.8 3496.9 624.7 636.5 637.6 641.6 642.5 734.9 737.9 750.8 753.5 756.9 9312.2 9573.7 9764.9 10423.9 10664.1 626.9 648.9 717.9 783.5 798.2 4645.8 4705.4 4802.4 4900.8 4901.7 67791.7 68358.3 68399.3 69132.7 69278.0 58596.4 59185.0 59389.7 59767.4 60542.7 53625.7 53954.2 54300.0 54371.5 54838.0 8802.3 8974.6 9000.9 9004.0 9028.7 33247.7 33400.5 33642.7 34026.1 34096.8 44644.6 46877.3 46955.8 47019.8 47352.5 11881.5 12141.4 12153.2 12243.2 12563.3 13051.8 13092.7 13448.3 13690.2 13723.5 12684.2 13016.5 13190.1 13302.3 13394.3 12289.5 12325.6 12479.4 12914.8 12967.9 12355.1 12573.7 12579.4 12976.0 13020.7 10323.2 10448.4 10459.2 11094.3 11139.4 10539.8 10820.0 10866.2 10982.5 11046.1 16:18:03 INFO - PROCESS | 914 | -------- Summary: end -------- 16:18:03 INFO - PROCESS | 914 | 16:18:04 INFO - TEST-INFO | 914: exit 0 16:18:04 INFO - TEST-OK | dromaeo_css | took 1112824ms 16:18:04 INFO - TEST-START | kraken 16:18:04 INFO - operating with platform_type : linux_ 16:18:04 INFO - Initialising browser for kraken test... 16:18:04 INFO - TEST-INFO | started process 1113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVdtITY/profile http://localhost:36957/getInfo.html) 16:18:08 INFO - PROCESS | 1113 | __metrics Screen width/height:1600/1200 16:18:08 INFO - PROCESS | 1113 | colorDepth:24 16:18:08 INFO - PROCESS | 1113 | Browser inner width/height: 1024/697 16:18:08 INFO - PROCESS | 1113 | __metrics 16:18:09 ERROR - PROCESS | 1113 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:18:10 INFO - TEST-INFO | 1113: exit 0 16:18:10 INFO - Browser initialized. 16:18:10 INFO - Running cycle 1/1 for kraken test... 16:18:10 INFO - TEST-INFO | started process 1265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVdtITY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:22 INFO - PROCESS | 1265 | RSS: Main: 152207360 16:18:22 INFO - PROCESS | 1265 | 16:18:24 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36957/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:25 INFO - PROCESS | 1265 | RSS: Main: 208109568 16:18:25 INFO - PROCESS | 1265 | 16:18:28 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36957/tests/kraken/driver.html?testName=audio-dft) 16:18:29 INFO - PROCESS | 1265 | RSS: Main: 197021696 16:18:29 INFO - PROCESS | 1265 | 16:18:32 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36957/tests/kraken/driver.html?testName=audio-fft) 16:18:33 INFO - PROCESS | 1265 | RSS: Main: 264921088 16:18:33 INFO - PROCESS | 1265 | 16:18:35 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36957/tests/kraken/driver.html?testName=audio-oscillator) 16:18:35 INFO - PROCESS | 1265 | RSS: Main: 174137344 16:18:35 INFO - PROCESS | 1265 | 16:18:38 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36957/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:38 INFO - PROCESS | 1265 | RSS: Main: 177799168 16:18:38 INFO - PROCESS | 1265 | 16:18:41 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36957/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:42 INFO - PROCESS | 1265 | RSS: Main: 214253568 16:18:42 INFO - PROCESS | 1265 | 16:18:45 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36957/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:46 INFO - PROCESS | 1265 | RSS: Main: 211861504 16:18:46 INFO - PROCESS | 1265 | 16:18:49 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36957/tests/kraken/driver.html?testName=json-parse-financial) 16:18:50 INFO - PROCESS | 1265 | RSS: Main: 212918272 16:18:50 INFO - PROCESS | 1265 | 16:18:51 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36957/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:18:52 INFO - PROCESS | 1265 | RSS: Main: 201842688 16:18:52 INFO - PROCESS | 1265 | 16:18:54 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:18:54 INFO - PROCESS | 1265 | RSS: Main: 206135296 16:18:54 INFO - PROCESS | 1265 | 16:18:56 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:18:57 INFO - PROCESS | 1265 | RSS: Main: 215195648 16:18:57 INFO - PROCESS | 1265 | 16:19:00 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:00 INFO - PROCESS | 1265 | RSS: Main: 223227904 16:19:00 INFO - PROCESS | 1265 | 16:19:03 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:04 INFO - PROCESS | 1265 | RSS: Main: 217710592 16:19:04 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36957/tests/kraken/driver.html?testName=ai-astar) 16:19:06 INFO - PROCESS | 1265 | RSS: Main: 263806976 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | __start_tp_report 16:19:06 INFO - PROCESS | 1265 | _x_x_mozilla_page_load 16:19:06 INFO - PROCESS | 1265 | _x_x_mozilla_page_load_details 16:19:06 INFO - PROCESS | 1265 | |i|pagename|runs| 16:19:06 INFO - PROCESS | 1265 | |0;ai-astar;110;107;110;111;111;110;111;109;111;109 16:19:06 INFO - PROCESS | 1265 | |1;audio-beat-detection;155;130;153;222;126;159;154;129;178;123 16:19:06 INFO - PROCESS | 1265 | |2;audio-dft;160;160;160;161;161;163;161;161;160;161 16:19:06 INFO - PROCESS | 1265 | |3;audio-fft;74;75;76;158;75;74;76;75;135;75 16:19:06 INFO - PROCESS | 1265 | |4;audio-oscillator;93;93;145;94;92;91;118;92;92;128 16:19:06 INFO - PROCESS | 1265 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;118;117;117 16:19:06 INFO - PROCESS | 1265 | |6;imaging-darkroom;145;146;146;146;146;147;145;146;146;146 16:19:06 INFO - PROCESS | 1265 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 16:19:06 INFO - PROCESS | 1265 | |8;json-parse-financial;61;58;59;57;58;60;57;110;56;56 16:19:06 INFO - PROCESS | 1265 | |9;json-stringify-tinderbox;60;59;59;59;59;59;60;60;59;61 16:19:06 INFO - PROCESS | 1265 | |10;stanford-crypto-aes;79;78;78;78;78;79;78;80;80;82 16:19:06 INFO - PROCESS | 1265 | |11;stanford-crypto-ccm;126;126;123;123;129;127;127;123;201;128 16:19:06 INFO - PROCESS | 1265 | |12;stanford-crypto-pbkdf2;167;167;162;161;163;171;163;161;164;168 16:19:06 INFO - PROCESS | 1265 | |13;stanford-crypto-sha256-iterative;65;68;65;64;68;65;64;63;62;63 16:19:06 INFO - PROCESS | 1265 | __end_tp_report 16:19:06 INFO - PROCESS | 1265 | __start_cc_report 16:19:06 INFO - PROCESS | 1265 | _x_x_mozilla_cycle_collect,1869 16:19:06 INFO - PROCESS | 1265 | __end_cc_report 16:19:06 INFO - PROCESS | 1265 | __startTimestamp1463008746395__endTimestamp 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | ------- Summary: start ------- 16:19:06 INFO - PROCESS | 1265 | Number of tests: 14 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:1.29 (1.2%) stddev-sans-first:1.36 16:19:06 INFO - PROCESS | 1265 | Values: 110.0 107.0 110.0 111.0 111.0 110.0 111.0 109.0 111.0 109.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:154.50 stddev:30.11 (19.5%) stddev-sans-first:31.93 16:19:06 INFO - PROCESS | 1265 | Values: 155.0 130.0 153.0 222.0 126.0 159.0 154.0 129.0 178.0 123.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 16:19:06 INFO - PROCESS | 1265 | Values: 160.0 160.0 160.0 161.0 161.0 163.0 161.0 161.0 160.0 161.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#3] audio-fft Cycles:10 Average:89.30 Median:75.00 stddev:30.64 (40.9%) stddev-sans-first:31.99 16:19:06 INFO - PROCESS | 1265 | Values: 74.0 75.0 76.0 158.0 75.0 74.0 76.0 75.0 135.0 75.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:92.00 stddev:19.42 (21.1%) stddev-sans-first:20.21 16:19:06 INFO - PROCESS | 1265 | Values: 93.0 93.0 145.0 94.0 92.0 91.0 118.0 92.0 92.0 128.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 16:19:06 INFO - PROCESS | 1265 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 16:19:06 INFO - PROCESS | 1265 | Values: 145.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 146.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:19:06 INFO - PROCESS | 1265 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:58.00 stddev:16.52 (28.5%) stddev-sans-first:17.51 16:19:06 INFO - PROCESS | 1265 | Values: 61.0 58.0 59.0 57.0 58.0 60.0 57.0 110.0 56.0 56.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 16:19:06 INFO - PROCESS | 1265 | Values: 60.0 59.0 59.0 59.0 59.0 59.0 60.0 60.0 59.0 61.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:1.33 (1.7%) stddev-sans-first:1.41 16:19:06 INFO - PROCESS | 1265 | Values: 79.0 78.0 78.0 78.0 78.0 79.0 78.0 80.0 80.0 82.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:127.00 stddev:23.88 (18.8%) stddev-sans-first:25.19 16:19:06 INFO - PROCESS | 1265 | Values: 126.0 126.0 123.0 123.0 129.0 127.0 127.0 123.0 201.0 128.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.50 stddev:3.37 (2.0%) stddev-sans-first:3.47 16:19:06 INFO - PROCESS | 1265 | Values: 167.0 167.0 162.0 161.0 163.0 171.0 163.0 161.0 164.0 168.0 16:19:06 INFO - PROCESS | 1265 | 16:19:06 INFO - PROCESS | 1265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:2.00 (3.1%) stddev-sans-first:2.12 16:19:06 INFO - PROCESS | 1265 | Values: 65.0 68.0 65.0 64.0 68.0 65.0 64.0 63.0 62.0 63.0 16:19:06 INFO - PROCESS | 1265 | -------- Summary: end -------- 16:19:06 INFO - PROCESS | 1265 | 16:19:07 INFO - TEST-INFO | 1265: exit 0 16:19:07 INFO - TEST-OK | kraken | took 62853ms 16:19:07 INFO - SUITE-END | took 1175s 16:19:07 INFO - Completed test suite (00:19:35) 16:19:07 INFO - javascript benchmark 16:19:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3149.448846451871, 3151.991362763915, 3198.9840050799744, 3211.0, 3231.256810933485, 5122.308488354071, 5170.405403378612, 5364.865878353043, 5413.133898576229, 5450.127979523277, 5213.661112027716, 5223.555997740187, 5236.2931004314405, 5269.973650131744, 5292.338457692788, 4726.149293127236, 4802.183628783097, 4833.971554965486, 4960.479149689285, 4991.7504124793795, 4850.0, 4884.877878053042, 4907.852764417055, 4920.68015578988, 4955.405351357842, 4700.106979673868, 4842.225243960985, 4855.5872750816225, 4885.853424397274, 4892.315075889378, 4894.0, 4909.091818013643, 4910.48439913811, 4924.409070911478, 4949.554540091409, 4618.56123668251, 4873.31773551703, 4875.58557522611, 4881.389826271716, 4903.338049363326, 5236.3978142513715, 5264.078786212397, 5273.630845840793, 5336.839894803162, 5354.705491197982, 5730.484256416942, 5773.0, 5820.097884827858, 5823.0, 5824.767009319622, 5539.861503462445, 5747.568932330092, 5834.737436815353, 5874.412558744134, 5897.351291357947, 5406.053940560386, 5527.834164975057, 5529.3364796224305, 5531.976584331912, 5539.224508568764, 6014.849628759316, 6040.395960403925, 6042.758289668364, 6042.788502402394, 6042.818715438544, 5386.5152136307925, 5632.155176723442, 5656.91514627281, 5774.82675519735, 5782.566307526952, 5798.01433756254, 5801.88396232073, 5804.912926306109, 5813.709314534256, 5852.912206316909, 5738.928017189978, 5771.769129234784, 5783.363829978699, 5785.479306862402, 5789.073748200268, 5395.892082158335, 5691.686957217393, 5698.088305871041, 5740.454656807597, 5783.1325301204315, 4383.583559561836, 4384.802683879233, 4384.846530371422, 4385.035292235703, 4415.646748260131, 3909.0227443139215, 3918.1575961167914, 3925.803709814498, 3954.6440820326306, 3969.940450893239, 5228.63399562027, 5288.68267903927, 5342.091844386386, 5374.48942350476, 5392.56859451243, 5782.392848750821, 5803.448672376117, 5824.3302020267365, 5827.970860145757, 5829.679367634821, 5422.7017514036315, 5428.484293992144, 5442.564594832404, 5443.618946673695, 5444.265024221759, 4692.319613656001, 4807.61539076873, 4816.927746083811, 4869.14789911764, 4937.35814344133, 5993.910091348634, 5997.400259974055, 5997.430244126801, 5999.460048595647, 6005.759769609254, 5801.419858014249, 5808.128780682931, 5810.941890581209, 5813.970930145322, 5818.069108942718, 5755.97122014404, 5850.034744267148, 5877.4122587740885, 5925.703714814156, 5944.167816505606, 5631.408702086222, 5646.2942132233475, 5670.716464176857, 5677.120046392815, 5685.317761868602, 5502.0921547944145, 5788.247527821356, 5797.188393624811, 5800.187973683604, 5802.564807639528, 5525.972370138124, 5562.360328562268, 5601.943980560142, 5631.380548139619, 5632.380438151882, 5625.128105143709, 5627.155926611041, 5630.3525094613005, 5634.690092044977, 5641.830745077655, 5328.17413300939, 5496.835094947158, 5540.556755459635, 5551.361593416808, 5557.499825015768, 5658.943410565842, 5770.740316685676, 5781.971090144522, 5785.508231800344, 5791.102379131242, 5579.832605021856, 5609.943900560942, 5610.270664813548, 5610.298712660918, 5655.745491452977], "value": 5301.085943420933, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.1251660059713, 628.9811305660829, 641.711229946524, 641.8395401149712, 656.7799787071331, 33572.66427335726, 35131.297374052534, 35945.82027089864, 35986.280274394565, 37839.05402364942, 45726.314105288446, 45813.31280030802, 46236.61290161301, 46307.0, 46312.073758524806, 7790.727324543642, 8731.388802783807, 8929.55352232389, 8935.240504557089, 10237.79524409515, 10041.648542300984, 10387.584496620164, 10390.844137337946, 10396.740081497948, 10401.063904248616, 10477.895221047767, 10482.842757358645, 10520.42137682431, 10527.84208236877, 10530.684079477627, 7981.5610141442485, 8122.18778122189, 10267.794644107076, 10463.476826158661, 10541.0, 10316.845247321296, 10379.688609341732, 10398.0, 10398.220133490018, 10408.115310198642, 41377.79311103455, 41583.7920810394, 41604.58395416037, 41654.0, 41711.374329385086, 3507.368673638744, 3529.435290353557, 3532.876349327761, 3562.9643703562892, 4131.8967025824295, 32541.83729081363, 32779.50830737517, 32878.0, 32945.0, 32996.17509562256, 4210.91578168438, 4351.19502891966, 4363.847265345697, 4428.867133985986, 4517.2998185281, 299984.0, 301044.0, 301776.0, 302076.0, 302741.9999999978, 56018.07873448901, 57221.14168287479, 57295.14057289144, 57304.42695572991, 57974.7101264491, 61943.38056619376, 62014.689926550076, 62252.0, 62370.0, 62418.687906561085, 13920.58238252854, 14087.647808804657, 14116.576502704935, 14124.717505649829, 14134.36395362211, 10603.946980265204, 10660.0, 10673.199510036779, 10677.305975111592, 10680.092192163753, 15956.920215398848, 17355.913220433817, 17372.565685857702, 17473.388431405096, 17476.475705728848, 5255.421903590602, 5971.820845374646, 6069.271687397452, 6211.440970312603, 6282.4974002079725, 1004.5630150884242, 1139.316410153901, 1170.8477897873222, 1194.8506436695413, 1223.9082068844873, 30433.0, 31480.685193147776, 31486.685133148832, 31537.8423107883, 32071.0, 1137.8691450483134, 1147.3689470791032, 1222.8532576090747, 1253.7993920972601, 1271.1483306184878, 16848.663026739643, 16850.831491684927, 17078.23147958345, 17096.145192740314, 17251.3962011329, 446088.0, 450717.0, 450922.0, 451376.0, 451488.0, 56891.431085688615, 56992.71503642455, 57057.42942570604, 57394.13908791372, 57417.42582574121, 1198.808190689503, 1222.2910711787142, 1341.496938648007, 1378.7656098463085, 1397.8392484864166, 26286.265098553802, 32596.51105233376, 32819.50770738393, 32886.34227315488, 33074.33851323008, 54230.0, 54594.0, 54642.45357546374, 54795.45204547903, 55057.449425505234, 444200.0, 444337.0, 446819.0, 447143.0, 448286.0, 40695.59304406918, 41597.0, 42310.78844605757, 42444.15111697687, 42545.149097018504, 47183.764081179375, 47585.0, 48465.75767121142, 48721.512784871695, 48739.0, 40545.797271013456, 40632.79683601563, 41349.79325103355, 41976.0, 42453.57546424496, 40083.799581001906, 40915.0, 41038.58961410467, 41801.79099104485, 41936.80631936782, 40005.39991900066, 40756.0, 41075.383869242585, 41112.79443602763, 41318.58681413268, 35258.64741352656, 36196.276074477835, 36327.455088174225, 37319.44020839635, 37589.81205093957, 27786.5832012524, 28039.0, 28048.43903121885, 28602.57096143518, 28613.28466788347], "value": 20202.550514054485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.6956426166282, 382.163062892266, 392.30561905427396, 394.3257030477883, 403.48757078510295, 16764.413245536394, 18702.90648546757, 18771.249150033982, 18817.435476935698, 19489.707654385194, 17617.11914404278, 17946.371876984307, 17971.550711232194, 18510.44468665939, 19899.60200795983, 5461.371942226655, 5643.746031428585, 5802.274715660543, 5851.444112809277, 5852.005159122938, 3896.629820167094, 5574.944250557503, 5841.15303281024, 5844.970775146118, 5844.970775146118, 5891.469767720904, 5907.0, 5929.555283353744, 5931.881362372772, 5972.343042265347, 6504.121943537609, 6531.771388001397, 6546.639934803584, 6554.573952693059, 6554.672266386686, 4920.876978075541, 5217.686938783647, 5225.451327610622, 5785.421457854223, 5794.797182098607, 13289.86710132896, 13591.320433978262, 13781.035327527077, 13839.308034598229, 13879.167249965034, 2314.867960690177, 2344.2498400511845, 2392.102961389479, 2405.482821193452, 2720.694066847924, 9683.757906052335, 9847.90152098477, 9909.801803963881, 9983.00169983003, 11440.828387574193, 1914.4926594452481, 1929.2379510093435, 1934.5550523379702, 2005.3783327168478, 2056.3830850744716, 76807.23192768113, 81305.59347203285, 81408.0, 82342.0, 83219.16780832174, 10685.09176719972, 10929.234953553176, 10977.890221097847, 10981.341119532854, 11095.167862410352, 15243.0, 15419.691606168039, 15420.0, 15435.687966522746, 15450.304736286895, 7106.253843346478, 7176.7129314826825, 7178.605176715227, 7312.926870731225, 7320.231375705474, 6436.292007879129, 6552.803415897435, 6592.241892182365, 6656.301088385747, 6736.124303840469, 4470.754108523997, 4495.213337665896, 4542.863714088517, 4666.2067448533835, 4772.76136193189, 1737.860971122307, 1820.9180586873622, 1904.8571357148269, 1924.979760726817, 1938.2925232290113, 902.7652810269377, 947.0340252942099, 998.5157198758596, 1012.7468132966758, 1063.2504084620325, 18481.5379615508, 18594.349197778014, 18630.720539191923, 19006.80993190078, 19357.4192774217, 1020.811149937264, 1039.5789705169418, 1045.278757657214, 1082.8700555933337, 1092.7158938676002, 10417.895821041844, 10846.457677116112, 10976.725581860517, 11014.173936954761, 11015.0, 479298.0, 481165.0, 486525.0, 492860.0, 495747.0, 71749.0, 86876.0, 89436.10563894278, 89983.55008224917, 90999.54500227589, 949.6960972488876, 950.2113246005798, 983.4738414947968, 995.2282892145485, 1000.849872519128, 16357.0, 16488.83511164921, 16934.915325423295, 17064.146792660566, 17469.213885375444, 38303.808480957414, 39086.6091339083, 39980.0, 40915.0, 41034.794826026875, 50908.0, 53764.73117634387, 54162.0, 54272.0, 54314.45685543252, 6654.800355989328, 6933.375996160168, 7362.852742945218, 8465.91534084676, 8919.063498332842, 10223.1821454282, 10225.0, 13166.473341066634, 13845.376958036712, 13962.441502339792, 11646.94176529112, 11901.523939042687, 12079.154459187772, 12124.393780311126, 12417.013277875496, 11879.04967602607, 11962.880371196177, 12121.939390302992, 12141.332226727614, 12171.33057681836, 12171.2697238166, 12437.689057773629, 12439.564615238423, 12604.369781511072, 12653.620391388273, 8071.515709057476, 8099.635516401894, 8187.426880118334, 8226.095129535626, 8240.1347858474, 9036.909630903607, 11315.151363647594, 11660.125490588409, 11785.587504437304, 12222.633321000385], "value": 8905.506514718201, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.5006922542505, 1571.6856628674261, 1593.5139782366377, 1758.43730006398, 1868.8131186881315, 8526.872096918543, 8870.512121833304, 8895.377323587352, 9023.503707296097, 9048.095190480948, 8843.248323892461, 8973.461592304466, 8984.505852178128, 8985.550722463884, 9002.189802917736, 2047.396018174642, 2318.733345665245, 2365.325882123591, 2384.5946189147885, 2393.533261014103, 2395.7724016218517, 2401.847113385576, 2403.122860156048, 2411.6141417373224, 2414.33605758417, 2320.2227253869974, 2391.421661703276, 2393.8204634652384, 2394.3415560720855, 2398.832081754278, 2072.0882811562938, 2339.228054741931, 2414.432608337057, 2421.1889017179265, 2437.756224377566, 2304.1129165271323, 2335.346103091137, 2336.439254578906, 2339.5905716499547, 2340.8361414700976, 8973.237274831647, 8975.147361000694, 8976.685815996409, 8995.55022248885, 9038.638454461814, 5366.141417373241, 5463.590230732671, 5511.4213007634025, 5520.834374968757, 5545.972270138664, 3544.5923718772156, 3548.8048157351336, 3578.570571531433, 3617.0595645132194, 3643.453481977698, 1111.0223003756723, 1122.2929554380687, 1139.2708666453477, 1142.605800998654, 1152.8674202466657, 12713.046521510923, 12762.23426594398, 12824.935875320563, 12845.486180552767, 12850.614481565568, 4881.145799485076, 4886.731229782396, 4893.241547560134, 4931.3589233399425, 4937.802487900515, 10632.255742098134, 10641.0, 10663.520141593646, 10677.893221067845, 10681.679549613524, 4682.367880336179, 5447.673139611636, 5473.698946557977, 5487.9298536784945, 5494.203340515683, 4834.7824347904425, 4971.552560269593, 4997.9500204997485, 5014.272930425068, 5017.698938063728, 4001.959980400217, 4010.318245898204, 4043.3861114574242, 4095.1604920991126, 4116.0533077392365, 1276.7318863038681, 1287.5493577248076, 1293.1400618588534, 1319.0502837956656, 1334.5062326939094, 819.2135549872071, 872.2498651159997, 895.3553441522093, 923.1138107416821, 945.579217248318, 5694.174344719992, 5744.195812586241, 5820.76716931318, 5826.941730582725, 5937.287525496881, 994.5623925472913, 1017.2726500552141, 1023.7696518283327, 1028.2545154762886, 1052.678932925465, 3803.5625903020955, 3932.960670393317, 3935.0752573145287, 3964.0684439156776, 4001.779902105412, 10907.727306817234, 11189.49647265875, 11209.439528023566, 11260.605878794202, 11478.253913495597, 11076.501557429934, 11097.778044439066, 11163.051140653135, 11169.329840209613, 11254.49354779037, 8209.548474833942, 8298.128696486781, 8401.53791541471, 8434.873476897852, 8514.74455766328, 5648.435156484319, 5818.476337129509, 5867.618604790675, 5929.0, 5973.820785376446, 10132.34139780912, 10384.792304154025, 10407.84388234162, 10411.958804119527, 10587.788244235226, 10385.948070259601, 10504.684859454228, 10723.142148628247, 10747.516361763895, 10865.497886494528, 6918.308169183243, 7524.17234104259, 7582.597219514408, 7740.380769538536, 7778.455508114604, 8828.911710882809, 8856.202941735275, 8887.511186884525, 8893.155150260714, 8899.955500222717, 7730.18833022547, 7912.683492660229, 7936.761897143095, 7977.760667179994, 7993.8401231976195, 7652.464327497022, 7666.425018123775, 7730.188330225245, 7793.766187014398, 7927.643256053607, 7222.277772222736, 7268.600226987566, 7345.485815992829, 7358.337749602561, 7360.926390736024, 5234.842954711365, 5241.423443421144, 5285.127953887719, 5356.625036247581, 5421.593380496557, 5218.739063046908, 5304.893902121858, 5332.3068001161155, 5480.862978425571, 5518.751656175402], "value": 4738.349485200458, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.15292234186336, 336.96124945631243, 340.4773672412847, 341.9025577710353, 344.6243594482016, 5269.341332333458, 5289.391719952202, 5370.140777475604, 5377.381601115872, 5384.43463436339, 5274.657147285424, 5278.0, 5278.806322175077, 5285.127953887613, 5302.125149350362, 3954.1498577805696, 4005.7396269242404, 4124.0, 4166.708330416872, 4184.435101261336, 4132.400801883725, 4155.833766649331, 4157.875263742078, 4169.166166766644, 4175.956010997251, 3953.189596132786, 4159.480064991876, 4166.354215096665, 4185.518665353493, 4201.1807697499, 4031.657309128698, 4061.918761624766, 4072.3077076896852, 4119.938200926988, 4135.379693046037, 3654.14127679995, 3667.8446289419016, 3673.2837096766143, 3688.7233457490797, 3690.833912473918, 5019.924701129486, 5065.544101030888, 5077.796888124471, 5081.415637201732, 5098.158803797369, 4540.477845047796, 4698.4361876574685, 4708.152532544141, 4755.809767609326, 4763.976180119112, 5426.9185962210595, 5488.722180295173, 5497.976113137758, 5499.945000549983, 5512.657120723717, 4068.9593104068877, 4074.30736774749, 4079.6736261099336, 4079.8980025499304, 4101.364288535282, 5606.747696353674, 5643.40744221859, 5735.713214339266, 5744.621290890198, 5750.913736293959, 4098.180363927227, 4106.260873042821, 4117.402976568441, 4134.462519872457, 4138.896527586774, 4202.621764041251, 4208.263553878059, 4216.9578304217175, 4232.957670423318, 4241.34259189826, 4547.567981041796, 4721.197396442613, 4725.416985309891, 4732.397181550134, 4786.976065119652, 5471.37079235893, 5484.327280179504, 5498.360786822268, 5508.44915508446, 5552.973164794821, 1429.2353590828857, 1441.5891470930735, 1446.2624061728595, 1462.9707405851823, 1476.1290838405391, 932.5104320231796, 950.8573713942964, 951.3435729346728, 957.305953183936, 964.2286171063262, 4678.8128474861305, 4706.552877476634, 4773.307870358779, 4793.400824896888, 4793.9280910786365, 4957.735777376818, 4977.352944117241, 4980.9252861207115, 4997.30037794709, 5066.417362003417, 4520.683552151318, 4741.57325840676, 4759.547842954914, 4778.713277203379, 4781.545753153445, 2645.140329392955, 2685.4763321152577, 2689.5696688530134, 2690.2870739254113, 2695.460907818444, 5008.924866127011, 5067.619928505377, 5121.359830021247, 5145.404924473425, 5194.948050519522, 4709.670323077352, 5014.824481143142, 5085.440601533828, 5093.853882876398, 5096.108181068298, 5115.92326115116, 5156.252343410185, 5156.845294641167, 5191.428942816363, 5208.099043848968, 5011.599072074298, 5060.822871199491, 5086.18621020635, 5103.642745007814, 5121.617163365796, 4829.806807727651, 4965.379327584052, 4972.8508144755715, 4997.450280469218, 5011.872328726007, 5163.535281824654, 5184.9740751296, 5191.90969896326, 5234.555062819551, 5238.214267859851, 3814.2263847311133, 3821.636944490269, 3832.1760821423527, 3834.6932245419744, 3846.2499812537408, 5036.521530454601, 5058.873528161826, 5213.611152750743, 5456.690394305418, 5693.629914055573, 5355.768173320081, 5579.581531385081, 5589.888202236014, 5603.38362780102, 5614.69119198448, 5521.1442226454965, 5525.392206857323, 5535.335759708861, 5559.193916881949, 5568.888622227614, 5235.869103272448, 5450.81967213118, 5470.398256191896, 5531.059719847716, 5540.252065971043, 5619.297587801525, 5633.943660563506, 5639.3232812062815, 5643.858903527281, 5665.830025099253, 5471.917921231265, 5473.397926228032, 5496.532794712494, 5543.0, 5545.944540554543], "value": 4088.9041305702567, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.6769292283086, 810.7689308547066, 861.4056301152204, 872.4765140915448, 879.2877769007109, 14059.648508787286, 14613.269336533158, 14620.268986550684, 14638.560843174695, 14690.0, 14149.0, 14166.645833854158, 14174.71650566988, 14217.502387416442, 14291.428342866273, 686.0703746423599, 703.6833424958763, 792.5324058805304, 816.8774683797434, 826.3430572694722, 810.6716779704229, 818.5743413425015, 818.8116733151379, 818.8771684247381, 819.5574389829485, 871.9869201961976, 882.3646974178581, 883.2271762208068, 883.8939327280735, 884.3014018925073, 719.4460265595515, 848.1264297773304, 873.8077622922947, 873.8208667223236, 874.558348034245, 632.9936700633027, 633.6483251795252, 633.6989929783363, 633.8795628830553, 634.6699716147577, 13897.861021389757, 13990.0906441081, 14021.579352619336, 14030.579082627537, 14068.437262509487, 13397.263150526716, 13934.0, 14032.43870245189, 14128.858711412857, 14154.0, 12128.0, 12315.261084334968, 12345.5061797528, 12517.687057823536, 12538.24770513763, 4466.285394336891, 4504.752238626874, 4532.7280363178315, 4645.070985802819, 4657.906841863178, 55934.160987585215, 56091.43908560903, 56211.71894140544, 56961.71519142419, 57323.85352292973, 10704.78590428187, 10749.516271767789, 10826.94586527078, 10923.071538919123, 11141.832872506919, 19529.0, 19679.0, 19735.901320493595, 19736.11187496566, 19744.70382944257, 8150.796230094176, 8164.428490005643, 8310.958445207736, 8329.042160151539, 8446.957765211135, 4883.291922671264, 4946.258061290763, 4955.4548999610015, 4975.228839529878, 4992.775325110379, 3416.6754158354915, 3490.771036791009, 3493.406120959443, 3495.790252584853, 3496.8984769797435, 624.6845343101795, 636.4971672378769, 637.5855693798975, 641.6278558436096, 642.5373730913734, 734.9375303099297, 737.9446541509408, 750.7972847331299, 753.5102183580607, 756.8826831841073, 9312.161905428544, 9573.664921727706, 9764.877039140447, 10423.92349743109, 10664.146868250677, 626.8652239768471, 648.8896887529131, 717.9425645948312, 783.5318745950302, 798.2097723253937, 4645.837395691202, 4705.435347758291, 4802.351682522884, 4900.754962251873, 4901.656884018084, 67791.66104169546, 68358.3164168352, 68399.31600683929, 69132.654336728, 69278.0, 58596.414035859096, 59185.0, 59389.70305148447, 59767.40232597618, 60542.697286513285, 53625.731871340395, 53954.19068713972, 54299.99999999921, 54371.45628543664, 54838.0, 8802.29581633455, 8974.596143173443, 9000.864987025068, 9003.954980225319, 9028.683996060106, 33247.66752332446, 33400.498992514644, 33642.66357336493, 34026.14934626654, 34096.82951585226, 44644.55355446404, 46877.2968405481, 46955.76522117368, 47019.76490117527, 47352.52647473481, 11881.465334059814, 12141.392930353624, 12153.210041347284, 12243.20419172751, 12563.309018004098, 13051.804222936853, 13092.672683182996, 13448.327583620976, 13690.178589284675, 13723.519676811264, 12684.175528590613, 13016.479340826261, 13190.076694631283, 13302.268375239455, 13394.330283485591, 12289.508419663114, 12325.630231093082, 12479.438425270702, 12914.80627790565, 12967.870321296667, 12355.135140540076, 12573.74852502963, 12579.433925473559, 12976.02679799, 13020.674483137618, 10323.174146068146, 10448.42533660656, 10459.163266938778, 11094.278871873303, 11139.443027848738, 10539.841902371318, 10820.0, 10866.185036122164, 10982.450877455936, 11046.116310695286], "value": 6941.611122485658, "unit": "score"}], "name": "dromaeo_css", "value": 7101.688345957518, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 110.0, 111.0, 111.0, 110.0, 111.0, 109.0, 111.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 153.0, 222.0, 126.0, 159.0, 154.0, 129.0, 178.0, 123.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 161.0, 163.0, 161.0, 161.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 158.0, 75.0, 74.0, 76.0, 75.0, 135.0, 75.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 145.0, 94.0, 92.0, 91.0, 118.0, 92.0, 92.0, 128.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 59.0, 57.0, 58.0, 60.0, 57.0, 110.0, 56.0, 56.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 61.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 80.0, 80.0, 82.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 123.0, 123.0, 129.0, 127.0, 127.0, 123.0, 201.0, 128.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 162.0, 161.0, 163.0, 171.0, 163.0, 161.0, 164.0, 168.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 65.0, 64.0, 68.0, 65.0, 64.0, 63.0, 62.0, 63.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1538.8999999999999, "alertThreshold": 2.0}]} 16:19:07 INFO - Return code: 0 16:19:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:19:07 ERROR - # TBPL SUCCESS # 16:19:07 INFO - Running post-action listener: _resource_record_post_action 16:19:07 INFO - ##### 16:19:07 INFO - ##### Finished run-tests step (success) 16:19:07 INFO - ##### 16:19:07 INFO - Running post-run listener: _resource_record_post_run 16:19:08 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533491712; Read time: 36; Write time: 416320 16:19:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244850688; Read time: 0; Write time: 235668 16:19:08 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288641024; Read time: 36; Write time: 180652 16:19:08 INFO - Running post-run listener: _upload_blobber_files 16:19:08 INFO - Blob upload gear active. 16:19:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:19:08 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 16:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:19:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:19:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:19:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:10 INFO - (blobuploader) - INFO - Done attempting. 16:19:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:19:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:19:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:10 INFO - (blobuploader) - INFO - Done attempting. 16:19:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:10 INFO - Return code: 0 16:19:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:19:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a9afdebc4cba3eece6cab93b72f646ddf6d02759d4ba942dc2b000c9cdc4adaf0fbed103d68f1bc52761569300dc40acce91696e100bf616dd14430ab2ad64d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa4e7459a98d38672e4711fd169a11224ba6b8a3a1cbe60aa7a0002d17d75d03d12b54e406ada4f25cb877c8d6617f6c58167953bc3c80a3b2f7e2d4b35babe2"} 16:19:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:19:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:19:10 INFO - Contents: 16:19:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a9afdebc4cba3eece6cab93b72f646ddf6d02759d4ba942dc2b000c9cdc4adaf0fbed103d68f1bc52761569300dc40acce91696e100bf616dd14430ab2ad64d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa4e7459a98d38672e4711fd169a11224ba6b8a3a1cbe60aa7a0002d17d75d03d12b54e406ada4f25cb877c8d6617f6c58167953bc3c80a3b2f7e2d4b35babe2"} 16:19:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:10 INFO - Copying logs to upload dir... 16:19:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:19:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.707224 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-11 16:19:10.662885) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 16:19:10.666935) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a9afdebc4cba3eece6cab93b72f646ddf6d02759d4ba942dc2b000c9cdc4adaf0fbed103d68f1bc52761569300dc40acce91696e100bf616dd14430ab2ad64d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa4e7459a98d38672e4711fd169a11224ba6b8a3a1cbe60aa7a0002d17d75d03d12b54e406ada4f25cb877c8d6617f6c58167953bc3c80a3b2f7e2d4b35babe2"} build_url:https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/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/Mozilla-Inbound/sha512/a9afdebc4cba3eece6cab93b72f646ddf6d02759d4ba942dc2b000c9cdc4adaf0fbed103d68f1bc52761569300dc40acce91696e100bf616dd14430ab2ad64d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa4e7459a98d38672e4711fd169a11224ba6b8a3a1cbe60aa7a0002d17d75d03d12b54e406ada4f25cb877c8d6617f6c58167953bc3c80a3b2f7e2d4b35babe2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 16:19:10.693747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 16:19:10.694347) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1463007226.67012-1861437815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 16:19:10.777565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 16:19:10.777917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 16:19:10.778238) ========= ========= Total master_lag: 0.17 =========