builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1461932645.14 results: success (0) buildid: 20160429044446 builduid: 54ddb870c4764e9491d1d02ef6a7a352 revision: f98e3add979e3b2eba6461fdaed2cfc80961ff6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:05.141835) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:05.142282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:05.142573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:05.254183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:05.254488) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 05:24:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 15.6M=0.001s 2016-04-29 05:24:05 (15.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133263 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:05.418433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:05.418768) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015107 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:05.469244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:05.469579) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f98e3add979e3b2eba6461fdaed2cfc80961ff6f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f98e3add979e3b2eba6461fdaed2cfc80961ff6f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 05:24:05,762 truncating revision to first 12 chars 2016-04-29 05:24:05,762 Setting DEBUG logging. 2016-04-29 05:24:05,762 attempt 1/10 2016-04-29 05:24:05,762 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f98e3add979e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 05:24:06,247 unpacking tar archive at: fx-team-f98e3add979e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.751799 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:06.233781) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:06.234136) ========= script_repo_revision: f98e3add979e3b2eba6461fdaed2cfc80961ff6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:06.234564) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:06.234984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 05:24:06.248498) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-29 05:24:06.248773) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:24:06 INFO - MultiFileLogger online at 20160429 05:24:06 in /builds/slave/test 05:24:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:24:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:24:06 INFO - {'append_to_log': False, 05:24:06 INFO - 'base_work_dir': '/builds/slave/test', 05:24:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:24:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:24:06 INFO - 'branch': 'Fx-Team-Non-PGO', 05:24:06 INFO - 'buildbot_json_path': 'buildprops.json', 05:24:06 INFO - 'config_files': ('talos/linux_config.py',), 05:24:06 INFO - 'default_actions': ('clobber', 05:24:06 INFO - 'read-buildbot-config', 05:24:06 INFO - 'download-and-extract', 05:24:06 INFO - 'populate-webroot', 05:24:06 INFO - 'create-virtualenv', 05:24:06 INFO - 'install', 05:24:06 INFO - 'run-tests'), 05:24:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:24:06 INFO - 'download_minidump_stackwalk': True, 05:24:06 INFO - 'download_symbols': 'ondemand', 05:24:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:24:06 INFO - 'tooltool.py': '/tools/tooltool.py', 05:24:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:24:06 INFO - '/tools/misc-python/virtualenv.py')}, 05:24:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:24:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:24:06 INFO - 'installer_path': 'installer.exe', 05:24:06 INFO - 'log_level': 'info', 05:24:06 INFO - 'log_name': 'talos', 05:24:06 INFO - 'log_to_console': True, 05:24:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:24:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:24:06 INFO - 'opt_config_files': (), 05:24:06 INFO - 'pip_index': False, 05:24:06 INFO - 'sps_profile': False, 05:24:06 INFO - 'sps_profile_interval': 0, 05:24:06 INFO - 'suite': 'dromaeojs-e10s', 05:24:06 INFO - 'system_bits': '32', 05:24:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:24:06 INFO - 'title': 'talos-linux64-ix-023', 05:24:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:24:06 INFO - 'use_talos_json': True, 05:24:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:24:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:24:06 INFO - 'work_dir': 'build'} 05:24:06 INFO - ##### 05:24:06 INFO - ##### Running clobber step. 05:24:06 INFO - ##### 05:24:06 INFO - Running pre-action listener: _resource_record_pre_action 05:24:06 INFO - Running main action method: clobber 05:24:06 INFO - rmtree: /builds/slave/test/build 05:24:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:24:07 INFO - Running post-action listener: _resource_record_post_action 05:24:07 INFO - ##### 05:24:07 INFO - ##### Running read-buildbot-config step. 05:24:07 INFO - ##### 05:24:07 INFO - Running pre-action listener: _resource_record_pre_action 05:24:07 INFO - Running main action method: read_buildbot_config 05:24:07 INFO - Using buildbot properties: 05:24:07 INFO - { 05:24:07 INFO - "project": "", 05:24:07 INFO - "product": "firefox", 05:24:07 INFO - "script_repo_revision": "production", 05:24:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:24:07 INFO - "repository": "", 05:24:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:24:07 INFO - "buildid": "20160429044446", 05:24:07 INFO - "pgo_build": "False", 05:24:07 INFO - "basedir": "/builds/slave/test", 05:24:07 INFO - "buildnumber": 1217, 05:24:07 INFO - "slavename": "talos-linux64-ix-023", 05:24:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:24:07 INFO - "platform": "ubuntu64_hw", 05:24:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:24:07 INFO - "branch": "fx-team", 05:24:07 INFO - "repo_path": "integration/fx-team", 05:24:07 INFO - "revision": "f98e3add979e3b2eba6461fdaed2cfc80961ff6f", 05:24:07 INFO - "stage_platform": "linux64", 05:24:07 INFO - "builduid": "54ddb870c4764e9491d1d02ef6a7a352", 05:24:07 INFO - "slavebuilddir": "test" 05:24:07 INFO - } 05:24:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:24:07 INFO - Running post-action listener: _resource_record_post_action 05:24:07 INFO - ##### 05:24:07 INFO - ##### Running download-and-extract step. 05:24:07 INFO - ##### 05:24:07 INFO - Running pre-action listener: _resource_record_pre_action 05:24:07 INFO - Running main action method: download_and_extract 05:24:07 INFO - mkdir: /builds/slave/test/build/tests 05:24: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')]} 05:24:07 INFO - https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/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 05:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/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 05:24:09 INFO - Downloaded 1361 bytes. 05:24:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:24:09 INFO - Using the following test package requirements: 05:24:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:24:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:24:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:24:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:09 INFO - u'jsshell-linux-x86_64.zip'], 05:24:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:24:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:24:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:24:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:24:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:24:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:24:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:24:09 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')]} 05:24:09 INFO - https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:24:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:24:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:24:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/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 05:24:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/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 05:24:10 INFO - Downloaded 22301146 bytes. 05:24:10 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'] 05:24:10 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 05:24:12 INFO - Return code: 0 05:24:12 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 05:24:12 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')]} 05:24:12 INFO - https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:24:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:24:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:24:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/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 05:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/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 05:24:13 INFO - Downloaded 22301146 bytes. 05:24:13 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'] 05:24:13 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 05:24:15 INFO - Return code: 0 05:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:15 INFO - https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:24:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:24:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:24:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/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 05:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/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 05:24:16 INFO - Downloaded 10840145 bytes. 05:24:16 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'] 05:24:16 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 05:24:16 INFO - Return code: 0 05:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:16 INFO - https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:24:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:24:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:24:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/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 05:24:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/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 05:24:18 INFO - Downloaded 54853270 bytes. 05:24:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:24:18 INFO - mkdir: /builds/slave/test/properties 05:24:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:24:18 INFO - Writing to file /builds/slave/test/properties/build_url 05:24:18 INFO - Contents: 05:24:18 INFO - build_url:https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:24:18 INFO - Running post-action listener: _resource_record_post_action 05:24:18 INFO - Running post-action listener: set_extra_try_arguments 05:24:18 INFO - ##### 05:24:18 INFO - ##### Running populate-webroot step. 05:24:18 INFO - ##### 05:24:18 INFO - Running pre-action listener: _resource_record_pre_action 05:24:18 INFO - Running main action method: populate_webroot 05:24:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:24:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:24:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:24:18 INFO - '--tppagecycles', 05:24:18 INFO - '7'], 05:24:18 INFO - 'tests': ['tsvgm']}}, 05:24:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:24:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:24:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:24:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:24:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:24:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:24:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:18 INFO - 'talos_options': ['--disable-e10s'], 05:24:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:18 INFO - 'talos_options': ['--disable-e10s'], 05:24:18 INFO - 'tests': ['damp', 'tps']}, 05:24:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:18 INFO - 'tests': ['damp', 'tps']}, 05:24:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:24:18 INFO - 'tests': ['dromaeo_dom']}, 05:24:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:24:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:24:18 INFO - 'tests': ['a11yr', 05:24:18 INFO - 'ts_paint', 05:24:18 INFO - 'tpaint', 05:24:18 INFO - 'sessionrestore', 05:24:18 INFO - 'sessionrestore_no_auto_restore', 05:24:18 INFO - 'tabpaint']}, 05:24:18 INFO - 'other-e10s': {'tests': ['a11yr', 05:24:18 INFO - 'ts_paint', 05:24:18 INFO - 'tpaint', 05:24:18 INFO - 'sessionrestore', 05:24:18 INFO - 'sessionrestore_no_auto_restore', 05:24:18 INFO - 'tabpaint']}, 05:24:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:24:18 INFO - 'ts_paint', 05:24:18 INFO - 'tpaint', 05:24:18 INFO - 'sessionrestore', 05:24:18 INFO - 'sessionrestore_no_auto_restore', 05:24:18 INFO - 'tabpaint']}, 05:24:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:24:18 INFO - 'ts_paint', 05:24:18 INFO - 'tpaint', 05:24:18 INFO - 'sessionrestore', 05:24:18 INFO - 'sessionrestore_no_auto_restore', 05:24:18 INFO - 'tabpaint']}, 05:24:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:24:18 INFO - 'tests': ['a11yr', 05:24:18 INFO - 'ts_paint', 05:24:18 INFO - 'tpaint', 05:24:18 INFO - 'sessionrestore', 05:24:18 INFO - 'sessionrestore_no_auto_restore', 05:24:18 INFO - 'tabpaint']}, 05:24:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:24:18 INFO - 'tests': ['a11yr', 05:24:18 INFO - 'ts_paint', 05:24:18 INFO - 'tpaint', 05:24:18 INFO - 'sessionrestore', 05:24:18 INFO - 'sessionrestore_no_auto_restore', 05:24:18 INFO - 'tabpaint']}, 05:24:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:24:18 INFO - 'tests': ['tsvgx', 05:24:18 INFO - 'tsvgr_opacity', 05:24:18 INFO - 'tart', 05:24:18 INFO - 'tscrollx', 05:24:18 INFO - 'cart']}, 05:24:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:24:18 INFO - 'tsvgr_opacity', 05:24:18 INFO - 'tart', 05:24:18 INFO - 'tscrollx', 05:24:18 INFO - 'cart']}, 05:24:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:18 INFO - 'talos_options': ['--disable-e10s'], 05:24:18 INFO - 'tests': ['tp5o']}, 05:24:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:18 INFO - 'tests': ['tp5o']}, 05:24:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:18 INFO - 'talos_options': ['--disable-e10s', 05:24:18 INFO - '--xperf_path', 05:24:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:18 INFO - 'tests': ['tp5n']}, 05:24:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:18 INFO - 'talos_options': ['--xperf_path', 05:24:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:18 INFO - 'tests': ['tp5n']}}, 05:24:18 INFO - 'talos.zip': {'path': '', 05:24:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:24:18 INFO - Running post-action listener: _resource_record_post_action 05:24:18 INFO - ##### 05:24:18 INFO - ##### Running create-virtualenv step. 05:24:18 INFO - ##### 05:24:18 INFO - Running pre-action listener: _resource_record_pre_action 05:24:18 INFO - Running main action method: create_virtualenv 05:24:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:24:18 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 05:24:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:24:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:24:19 INFO - Using real prefix '/usr' 05:24:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:24:19 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:22 INFO - Installing pip.................done. 05:24:22 INFO - Return code: 0 05:24:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 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 0x7fe98765bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f8410>, '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 0x24f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', '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 05:24:22 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 05:24:22 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 05:24:22 INFO - Using env: {'DISPLAY': ':0', 05:24:22 INFO - 'HOME': '/home/cltbld', 05:24:22 INFO - 'LANG': 'en_US.UTF-8', 05:24:22 INFO - 'LANGUAGE': 'en_US:en', 05:24:22 INFO - 'LOGNAME': 'cltbld', 05:24:22 INFO - 'MAIL': '/var/mail/cltbld', 05:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:22 INFO - 'MOZ_NO_REMOTE': '1', 05:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:22 INFO - 'NO_EM_RESTART': '1', 05:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:22 INFO - 'PWD': '/builds/slave/test', 05:24:22 INFO - 'SHELL': '/bin/bash', 05:24:22 INFO - 'SHLVL': '1', 05:24:22 INFO - 'TERM': 'linux', 05:24:22 INFO - 'TMOUT': '86400', 05:24:22 INFO - 'USER': 'cltbld', 05:24:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', 05:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:22 INFO - '_': '/tools/buildbot/bin/python'} 05:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:22 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 05:24:22 INFO - Cleaning up... 05:24:22 INFO - Return code: 0 05:24:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 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 0x7fe98765bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f8410>, '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 0x24f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', '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 05:24:22 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 05:24:22 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 05:24:22 INFO - Using env: {'DISPLAY': ':0', 05:24:22 INFO - 'HOME': '/home/cltbld', 05:24:22 INFO - 'LANG': 'en_US.UTF-8', 05:24:22 INFO - 'LANGUAGE': 'en_US:en', 05:24:22 INFO - 'LOGNAME': 'cltbld', 05:24:22 INFO - 'MAIL': '/var/mail/cltbld', 05:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:22 INFO - 'MOZ_NO_REMOTE': '1', 05:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:22 INFO - 'NO_EM_RESTART': '1', 05:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:22 INFO - 'PWD': '/builds/slave/test', 05:24:22 INFO - 'SHELL': '/bin/bash', 05:24:22 INFO - 'SHLVL': '1', 05:24:22 INFO - 'TERM': 'linux', 05:24:22 INFO - 'TMOUT': '86400', 05:24:22 INFO - 'USER': 'cltbld', 05:24:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', 05:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:22 INFO - '_': '/tools/buildbot/bin/python'} 05:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:23 INFO - Downloading/unpacking psutil>=0.7.1 05:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:25 INFO - Installing collected packages: psutil 05:24:25 INFO - Running setup.py install for psutil 05:24:25 INFO - building 'psutil._psutil_linux' extension 05:24:25 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 05:24:26 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 05:24:26 INFO - building 'psutil._psutil_posix' extension 05:24:26 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 05:24:26 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 05:24:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:26 INFO - Successfully installed psutil 05:24:26 INFO - Cleaning up... 05:24:26 INFO - Return code: 0 05:24:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:26 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 0x7fe98765bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f8410>, '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 0x24f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', '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 05:24:26 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 05:24:26 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 05:24:26 INFO - Using env: {'DISPLAY': ':0', 05:24:26 INFO - 'HOME': '/home/cltbld', 05:24:26 INFO - 'LANG': 'en_US.UTF-8', 05:24:26 INFO - 'LANGUAGE': 'en_US:en', 05:24:26 INFO - 'LOGNAME': 'cltbld', 05:24:26 INFO - 'MAIL': '/var/mail/cltbld', 05:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:26 INFO - 'MOZ_NO_REMOTE': '1', 05:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:26 INFO - 'NO_EM_RESTART': '1', 05:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:26 INFO - 'PWD': '/builds/slave/test', 05:24:26 INFO - 'SHELL': '/bin/bash', 05:24:26 INFO - 'SHLVL': '1', 05:24:26 INFO - 'TERM': 'linux', 05:24:26 INFO - 'TMOUT': '86400', 05:24:26 INFO - 'USER': 'cltbld', 05:24:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', 05:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:26 INFO - '_': '/tools/buildbot/bin/python'} 05:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:24:26 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 05:24:26 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 05:24:26 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 05:24:26 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 05:24:26 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 05:24:26 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 05:24:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:24:28 INFO - Installing collected packages: mozsystemmonitor 05:24:28 INFO - Running setup.py install for mozsystemmonitor 05:24:28 INFO - Successfully installed mozsystemmonitor 05:24:28 INFO - Cleaning up... 05:24:28 INFO - Return code: 0 05:24:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe98765bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f8410>, '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 0x24f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', '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 05:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:24:28 INFO - Using env: {'DISPLAY': ':0', 05:24:28 INFO - 'HOME': '/home/cltbld', 05:24:28 INFO - 'LANG': 'en_US.UTF-8', 05:24:28 INFO - 'LANGUAGE': 'en_US:en', 05:24:28 INFO - 'LOGNAME': 'cltbld', 05:24:28 INFO - 'MAIL': '/var/mail/cltbld', 05:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:28 INFO - 'MOZ_NO_REMOTE': '1', 05:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:28 INFO - 'NO_EM_RESTART': '1', 05:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:28 INFO - 'PWD': '/builds/slave/test', 05:24:28 INFO - 'SHELL': '/bin/bash', 05:24:28 INFO - 'SHLVL': '1', 05:24:28 INFO - 'TERM': 'linux', 05:24:28 INFO - 'TMOUT': '86400', 05:24:28 INFO - 'USER': 'cltbld', 05:24:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', 05:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:28 INFO - '_': '/tools/buildbot/bin/python'} 05:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:24:29 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 05:24:29 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 05:24:29 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 05:24:29 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 05:24:29 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 05:24:29 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 05:24:30 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:31 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 05:24:31 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 05:24:31 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 05:24:31 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 05:24:31 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 05:24:31 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 05:24:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24:31 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 05:24:31 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 05:24:31 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 05:24:31 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 05:24:31 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 05:24:31 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 05:24:31 INFO - Downloading docopt-0.6.1.tar.gz 05:24:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:31 INFO - Running setup.py install for blobuploader 05:24:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:31 INFO - Running setup.py install for requests 05:24:32 INFO - Running setup.py install for docopt 05:24:32 INFO - Successfully installed blobuploader requests docopt 05:24:32 INFO - Cleaning up... 05:24:32 INFO - Return code: 0 05:24:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:32 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 0x7fe98765bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f8410>, '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 0x24f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', '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 05:24:32 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 05:24:32 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 05:24:32 INFO - Using env: {'DISPLAY': ':0', 05:24:32 INFO - 'HOME': '/home/cltbld', 05:24:32 INFO - 'LANG': 'en_US.UTF-8', 05:24:32 INFO - 'LANGUAGE': 'en_US:en', 05:24:32 INFO - 'LOGNAME': 'cltbld', 05:24:32 INFO - 'MAIL': '/var/mail/cltbld', 05:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:32 INFO - 'MOZ_NO_REMOTE': '1', 05:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:32 INFO - 'NO_EM_RESTART': '1', 05:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:32 INFO - 'PWD': '/builds/slave/test', 05:24:32 INFO - 'SHELL': '/bin/bash', 05:24:32 INFO - 'SHLVL': '1', 05:24:32 INFO - 'TERM': 'linux', 05:24:32 INFO - 'TMOUT': '86400', 05:24:32 INFO - 'USER': 'cltbld', 05:24:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', 05:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:32 INFO - '_': '/tools/buildbot/bin/python'} 05:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:32 INFO - Running setup.py (path:/tmp/pip-nI9tCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:32 INFO - Running setup.py (path:/tmp/pip-VxRrEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:32 INFO - Running setup.py (path:/tmp/pip-T8umtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:32 INFO - Running setup.py (path:/tmp/pip-ijcLBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:32 INFO - Running setup.py (path:/tmp/pip-NJGgOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:32 INFO - Running setup.py (path:/tmp/pip-KdTgNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:33 INFO - Running setup.py (path:/tmp/pip-Qmm0V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:33 INFO - Running setup.py (path:/tmp/pip-4D3fTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:33 INFO - Running setup.py (path:/tmp/pip-iOBSbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:33 INFO - Running setup.py (path:/tmp/pip-E1IumI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:33 INFO - Running setup.py (path:/tmp/pip-YxiwHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:33 INFO - Running setup.py (path:/tmp/pip-_c4_0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:33 INFO - Running setup.py (path:/tmp/pip-Wl4Ldc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:33 INFO - Running setup.py (path:/tmp/pip-ON59Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:33 INFO - Running setup.py (path:/tmp/pip-T0KSPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:33 INFO - Running setup.py (path:/tmp/pip-Y2M8gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:33 INFO - Running setup.py (path:/tmp/pip-7uAwWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:33 INFO - Running setup.py install for manifestparser 05:24:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:33 INFO - Running setup.py install for mozcrash 05:24:34 INFO - Running setup.py install for mozdebug 05:24:34 INFO - Running setup.py install for mozdevice 05:24:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:24:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:34 INFO - Running setup.py install for mozfile 05:24:34 INFO - Running setup.py install for mozhttpd 05:24:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:34 INFO - Running setup.py install for mozinfo 05:24:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:34 INFO - Running setup.py install for mozInstall 05:24:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:34 INFO - Running setup.py install for mozleak 05:24:34 INFO - Running setup.py install for mozlog 05:24:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:34 INFO - Running setup.py install for moznetwork 05:24:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:34 INFO - Running setup.py install for mozprocess 05:24:35 INFO - Running setup.py install for mozprofile 05:24:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:35 INFO - Running setup.py install for mozrunner 05:24:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:35 INFO - Running setup.py install for mozscreenshot 05:24:35 INFO - Running setup.py install for moztest 05:24:35 INFO - Running setup.py install for mozversion 05:24:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:35 INFO - Cleaning up... 05:24:35 INFO - Return code: 0 05:24:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:35 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 0x7fe98765bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f8410>, '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 0x24f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', '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 05:24:35 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 05:24:35 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 05:24:35 INFO - Using env: {'DISPLAY': ':0', 05:24:35 INFO - 'HOME': '/home/cltbld', 05:24:35 INFO - 'LANG': 'en_US.UTF-8', 05:24:35 INFO - 'LANGUAGE': 'en_US:en', 05:24:35 INFO - 'LOGNAME': 'cltbld', 05:24:35 INFO - 'MAIL': '/var/mail/cltbld', 05:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:35 INFO - 'MOZ_NO_REMOTE': '1', 05:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:35 INFO - 'NO_EM_RESTART': '1', 05:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:35 INFO - 'PWD': '/builds/slave/test', 05:24:35 INFO - 'SHELL': '/bin/bash', 05:24:35 INFO - 'SHLVL': '1', 05:24:35 INFO - 'TERM': 'linux', 05:24:35 INFO - 'TMOUT': '86400', 05:24:35 INFO - 'USER': 'cltbld', 05:24:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', 05:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:35 INFO - '_': '/tools/buildbot/bin/python'} 05:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:35 INFO - Running setup.py (path:/tmp/pip-Y3SaIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:35 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)) 05:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:35 INFO - Running setup.py (path:/tmp/pip-0bsLtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:36 INFO - Running setup.py (path:/tmp/pip-hsLHvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:36 INFO - Running setup.py (path:/tmp/pip-zSgXuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:36 INFO - Running setup.py (path:/tmp/pip-FpIl57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:36 INFO - Running setup.py (path:/tmp/pip-ZD_0t_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:36 INFO - Running setup.py (path:/tmp/pip-rNDtO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:36 INFO - Running setup.py (path:/tmp/pip-hxEmwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:36 INFO - Running setup.py (path:/tmp/pip-42_dXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:36 INFO - Running setup.py (path:/tmp/pip-PxNGQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:36 INFO - Running setup.py (path:/tmp/pip-e159GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:36 INFO - Running setup.py (path:/tmp/pip-01Lzn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:36 INFO - Running setup.py (path:/tmp/pip-1tFrco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:36 INFO - Running setup.py (path:/tmp/pip-duaQMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:36 INFO - Running setup.py (path:/tmp/pip-7nBKCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:36 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)) 05:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:36 INFO - Running setup.py (path:/tmp/pip-epiSUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:37 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)) 05:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:37 INFO - Running setup.py (path:/tmp/pip-lAUC3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:37 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)) 05:24:37 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)) 05:24:37 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)) 05:24:37 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)) 05:24:37 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)) 05:24:37 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)) 05:24:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 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 05:24:38 INFO - Downloading blessings-1.6.tar.gz 05:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:39 INFO - Installing collected packages: blessings 05:24:39 INFO - Running setup.py install for blessings 05:24:39 INFO - Successfully installed blessings 05:24:39 INFO - Cleaning up... 05:24:39 INFO - Return code: 0 05:24:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:39 INFO - Reading from file tmpfile_stdout 05:24:39 INFO - Current package versions: 05:24:39 INFO - argparse == 1.2.1 05:24:39 INFO - blessings == 1.6 05:24:39 INFO - blobuploader == 1.2.4 05:24:39 INFO - docopt == 0.6.1 05:24:39 INFO - manifestparser == 1.1 05:24:39 INFO - mozInstall == 1.12 05:24:39 INFO - mozcrash == 0.17 05:24:39 INFO - mozdebug == 0.1 05:24:39 INFO - mozdevice == 0.48 05:24:39 INFO - mozfile == 1.2 05:24:39 INFO - mozhttpd == 0.7 05:24:39 INFO - mozinfo == 0.9 05:24:39 INFO - mozleak == 0.1 05:24:39 INFO - mozlog == 3.1 05:24:39 INFO - moznetwork == 0.27 05:24:39 INFO - mozprocess == 0.22 05:24:39 INFO - mozprofile == 0.28 05:24:39 INFO - mozrunner == 6.11 05:24:39 INFO - mozscreenshot == 0.1 05:24:39 INFO - mozsystemmonitor == 0.0 05:24:39 INFO - moztest == 0.7 05:24:39 INFO - mozversion == 1.4 05:24:39 INFO - psutil == 3.1.1 05:24:39 INFO - requests == 1.2.3 05:24:39 INFO - wsgiref == 0.1.2 05:24:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:39 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')]} 05:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:39 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')]} 05:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:39 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 0x7fe98765bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f8410>, '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 0x24f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', '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 05:24:39 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 05:24:39 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 05:24:39 INFO - Using env: {'DISPLAY': ':0', 05:24:39 INFO - 'HOME': '/home/cltbld', 05:24:39 INFO - 'LANG': 'en_US.UTF-8', 05:24:39 INFO - 'LANGUAGE': 'en_US:en', 05:24:39 INFO - 'LOGNAME': 'cltbld', 05:24:39 INFO - 'MAIL': '/var/mail/cltbld', 05:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:39 INFO - 'MOZ_NO_REMOTE': '1', 05:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:39 INFO - 'NO_EM_RESTART': '1', 05:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:39 INFO - 'PWD': '/builds/slave/test', 05:24:39 INFO - 'SHELL': '/bin/bash', 05:24:39 INFO - 'SHLVL': '1', 05:24:39 INFO - 'TERM': 'linux', 05:24:39 INFO - 'TMOUT': '86400', 05:24:39 INFO - 'USER': 'cltbld', 05:24:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', 05:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:39 INFO - '_': '/tools/buildbot/bin/python'} 05:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:39 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)) 05:24:39 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)) 05:24:39 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)) 05:24:39 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)) 05:24:39 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)) 05:24:39 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)) 05:24:39 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)) 05:24:39 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)) 05:24:39 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)) 05:24:39 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)) 05:24:39 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)) 05:24:39 INFO - Cleaning up... 05:24:39 INFO - Return code: 0 05:24:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:24:39 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')]} 05:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:39 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')]} 05:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:39 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 0x7fe98765bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f8410>, '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 0x24f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', '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 05:24:39 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 05:24:39 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 05:24:39 INFO - Using env: {'DISPLAY': ':0', 05:24:39 INFO - 'HOME': '/home/cltbld', 05:24:39 INFO - 'LANG': 'en_US.UTF-8', 05:24:39 INFO - 'LANGUAGE': 'en_US:en', 05:24:39 INFO - 'LOGNAME': 'cltbld', 05:24:39 INFO - 'MAIL': '/var/mail/cltbld', 05:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:39 INFO - 'MOZ_NO_REMOTE': '1', 05:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:39 INFO - 'NO_EM_RESTART': '1', 05:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:39 INFO - 'PWD': '/builds/slave/test', 05:24:39 INFO - 'SHELL': '/bin/bash', 05:24:39 INFO - 'SHLVL': '1', 05:24:39 INFO - 'TERM': 'linux', 05:24:39 INFO - 'TMOUT': '86400', 05:24:39 INFO - 'USER': 'cltbld', 05:24:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', 05:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:39 INFO - '_': '/tools/buildbot/bin/python'} 05:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:39 INFO - Downloading/unpacking jsonschema 05:24:39 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 05:24:39 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 05:24:39 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 05:24:39 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 05:24:39 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 05:24:39 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 05:24:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:41 INFO - Downloading/unpacking functools32 (from jsonschema) 05:24:41 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 05:24:41 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 05:24:41 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 05:24:41 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 05:24:41 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 05:24:41 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 05:24:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:42 INFO - warning: no files found matching '*.txt' 05:24:42 INFO - no previously-included directories found matching 'build' 05:24:42 INFO - no previously-included directories found matching 'dist' 05:24:42 INFO - no previously-included directories found matching '.git*' 05:24:42 INFO - Installing collected packages: jsonschema, functools32 05:24:42 INFO - Running setup.py install for functools32 05:24:42 INFO - warning: no files found matching '*.txt' 05:24:42 INFO - no previously-included directories found matching 'build' 05:24:42 INFO - no previously-included directories found matching 'dist' 05:24:42 INFO - no previously-included directories found matching '.git*' 05:24:42 INFO - Successfully installed jsonschema functools32 05:24:42 INFO - Cleaning up... 05:24:42 INFO - Return code: 0 05:24:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:42 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 0x7fe98765bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f8410>, '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 0x24f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', '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 05:24:42 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 05:24:42 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 05:24:42 INFO - Using env: {'DISPLAY': ':0', 05:24:42 INFO - 'HOME': '/home/cltbld', 05:24:42 INFO - 'LANG': 'en_US.UTF-8', 05:24:42 INFO - 'LANGUAGE': 'en_US:en', 05:24:42 INFO - 'LOGNAME': 'cltbld', 05:24:42 INFO - 'MAIL': '/var/mail/cltbld', 05:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:42 INFO - 'MOZ_NO_REMOTE': '1', 05:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:42 INFO - 'NO_EM_RESTART': '1', 05:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:42 INFO - 'PWD': '/builds/slave/test', 05:24:42 INFO - 'SHELL': '/bin/bash', 05:24:42 INFO - 'SHLVL': '1', 05:24:42 INFO - 'TERM': 'linux', 05:24:42 INFO - 'TMOUT': '86400', 05:24:42 INFO - 'USER': 'cltbld', 05:24:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', 05:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:42 INFO - '_': '/tools/buildbot/bin/python'} 05:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:42 INFO - Downloading/unpacking flake8 05:24:42 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 05:24:42 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 05:24:42 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 05:24:42 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 05:24:42 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 05:24:42 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 05:24:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:24:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:24:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:24:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:24:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:24:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:24:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:24:45 INFO - no previously-included directories found matching 'docs/_build' 05:24:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:24:45 INFO - Running setup.py install for pep8 05:24:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:24:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:24:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:24:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:24:45 INFO - no previously-included directories found matching 'docs/_build' 05:24:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:24:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:24:45 INFO - Cleaning up... 05:24:45 INFO - Return code: 0 05:24:45 INFO - Running post-action listener: _resource_record_post_action 05:24:45 INFO - Running post-action listener: _start_resource_monitoring 05:24:45 INFO - Starting resource monitoring. 05:24:45 INFO - ##### 05:24:45 INFO - ##### Running install step. 05:24:45 INFO - ##### 05:24:45 INFO - Running pre-action listener: _resource_record_pre_action 05:24:45 INFO - Running main action method: install 05:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:45 INFO - Reading from file tmpfile_stdout 05:24:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:45 INFO - Reading from file tmpfile_stdout 05:24:45 INFO - Output received: 05:24:45 INFO - Usage: mozinstall [options] installer 05:24:45 INFO - Options: 05:24:45 INFO - -h, --help show this help message and exit 05:24:45 INFO - -d DEST, --destination=DEST 05:24:45 INFO - Directory to install application into. [default: 05:24:45 INFO - "/builds/slave/test"] 05:24:45 INFO - --app=APP Application being installed. [default: firefox] 05:24:45 INFO - mkdir: /builds/slave/test/build/application 05:24:45 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'] 05:24:45 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 05:25:01 INFO - Reading from file tmpfile_stdout 05:25:01 INFO - Output received: 05:25:01 INFO - /builds/slave/test/build/application/firefox/firefox 05:25:01 INFO - Running post-action listener: _resource_record_post_action 05:25:01 INFO - ##### 05:25:01 INFO - ##### Running run-tests step. 05:25:01 INFO - ##### 05:25:01 INFO - Running pre-action listener: _resource_record_pre_action 05:25:01 INFO - Running main action method: run_tests 05:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:25:01 INFO - Python 2.7.3 05:25:01 INFO - Return code: 0 05:25:01 INFO - grabbing minidump binary from tooltool 05:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:01 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f8410>, '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 0x24f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:25:01 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 05:25:01 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 05:25:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:01 INFO - Return code: 0 05:25:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:25:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:25:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:25:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:25:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:25:02 INFO - Return code: 0 05:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:25:02 INFO - Using env: {'DISPLAY': ':0', 05:25:02 INFO - 'HOME': '/home/cltbld', 05:25:02 INFO - 'LANG': 'en_US.UTF-8', 05:25:02 INFO - 'LANGUAGE': 'en_US:en', 05:25:02 INFO - 'LOGNAME': 'cltbld', 05:25:02 INFO - 'MAIL': '/var/mail/cltbld', 05:25:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:25:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:02 INFO - 'MOZ_NO_REMOTE': '1', 05:25:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:02 INFO - 'NO_EM_RESTART': '1', 05:25:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:02 INFO - 'PWD': '/builds/slave/test', 05:25:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:25:02 INFO - 'SHELL': '/bin/bash', 05:25:02 INFO - 'SHLVL': '1', 05:25:02 INFO - 'TERM': 'linux', 05:25:02 INFO - 'TMOUT': '86400', 05:25:02 INFO - 'USER': 'cltbld', 05:25:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936', 05:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:02 INFO - '_': '/tools/buildbot/bin/python'} 05:25:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:25:03 INFO - mozversion application_buildid: 20160429044446 05:25:03 INFO - mozversion application_changeset: f98e3add979e3b2eba6461fdaed2cfc80961ff6f 05:25:03 INFO - mozversion application_display_name: Nightly 05:25:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:25:03 INFO - mozversion application_name: Firefox 05:25:03 INFO - mozversion application_remotingname: firefox 05:25:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:25:03 INFO - mozversion application_vendor: Mozilla 05:25:03 INFO - mozversion application_version: 49.0a1 05:25:03 INFO - mozversion platform_buildid: 20160429044446 05:25:03 INFO - mozversion platform_changeset: f98e3add979e3b2eba6461fdaed2cfc80961ff6f 05:25:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:25:03 INFO - mozversion platform_version: 49.0a1 05:25:03 INFO - using testdate: 1461932703 05:25:03 INFO - actual date: 1461932703 05:25:03 INFO - starting webserver on 'localhost:43270' 05:25:03 INFO - SUITE-START | Running 2 tests 05:25:03 INFO - TEST-START | dromaeo_css 05:25:03 INFO - operating with platform_type : linux_ 05:25:03 INFO - Initialising browser for dromaeo_css test... 05:25:03 INFO - TEST-INFO | started process 3370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7CNbZ7/profile http://localhost:43270/getInfo.html) 05:25:09 INFO - PROCESS | 3370 | 05:25:09 INFO - PROCESS | 3370 | (process:3440): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:25:10 INFO - PROCESS | 3370 | __metrics Screen width/height:1600/1200 05:25:10 INFO - PROCESS | 3370 | colorDepth:24 05:25:10 INFO - PROCESS | 3370 | Browser inner width/height: 1024/697 05:25:10 INFO - PROCESS | 3370 | __metrics 05:25:10 ERROR - PROCESS | 3370 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:25:11 INFO - TEST-INFO | 3370: exit 0 05:25:11 INFO - Browser initialized. 05:25:11 INFO - Running cycle 1/1 for dromaeo_css test... 05:25:11 INFO - TEST-INFO | started process 3489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7CNbZ7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:13 INFO - PROCESS | 3489 | 05:25:13 INFO - PROCESS | 3489 | (process:3549): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:25:23 INFO - PROCESS | 3489 | RSS: Main: 166133760 05:25:23 INFO - PROCESS | 3489 | 05:26:13 INFO - PROCESS | 3489 | 1461932773090 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] 05:28:26 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43270/tests/dromaeo/cssquery-ext.html) 05:28:27 INFO - PROCESS | 3489 | RSS: Main: 167215104 05:28:27 INFO - PROCESS | 3489 | 05:31:29 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43270/tests/dromaeo/cssquery-ext.html (next: http://localhost:43270/tests/dromaeo/cssquery-jquery.html) 05:31:30 INFO - PROCESS | 3489 | RSS: Main: 166785024 05:31:30 INFO - PROCESS | 3489 | 05:34:32 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43270/tests/dromaeo/cssquery-mootools.html) 05:34:33 INFO - PROCESS | 3489 | RSS: Main: 167956480 05:34:33 INFO - PROCESS | 3489 | 05:37:34 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43270/tests/dromaeo/cssquery-prototype.html) 05:37:35 INFO - PROCESS | 3489 | RSS: Main: 165466112 05:37:35 INFO - PROCESS | 3489 | 05:40:38 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43270/tests/dromaeo/cssquery-yui.html) 05:40:38 INFO - PROCESS | 3489 | RSS: Main: 167096320 05:40:38 INFO - PROCESS | 3489 | 05:43:41 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43270/tests/dromaeo/cssquery-yui.html (next: http://localhost:43270/tests/dromaeo/cssquery-dojo.html) 05:43:41 INFO - PROCESS | 3489 | RSS: Main: 169185280 05:43:41 INFO - PROCESS | 3489 | 05:43:41 INFO - PROCESS | 3489 | __start_tp_report 05:43:41 INFO - PROCESS | 3489 | _x_x_mozilla_page_load 05:43:41 INFO - PROCESS | 3489 | _x_x_mozilla_page_load_details 05:43:41 INFO - PROCESS | 3489 | |i|pagename|runs| 05:43:41 INFO - PROCESS | 3489 | |0;dojo.html;2611.5168693791647;2672.7728143107843;2703.63500927375;2718.578620313852;2721.8502982335976;4721.386219791427;4751.16854550454;4752.976235118824;4756.334113224147;4797.6401769867225;4565.589096981271;4690.929636055462;4707.62339012879;4771.713697178163;4773.331733557305;4334.176506463769;4358.346248062784;4368.868933931971;4390.868273951786;4448.666350023745;4051.560094475839;4328.913421731563;4339.19724850902;4359.3025115981445;4373.518912919576;4180.47744031996;4266.957330426687;4340.544242854487;4347.2826983547675;4364;4229.238737027334;4297.35539669049;4330.39374487572;4332.891677708051;4356.607905288539;4294.055307832303;4309.78451077448;4329.177456283296;4333.696641235115;4361.738295702236;4587.42657167854;4618.1687296286655;4649.3026046093355;4660.930086048712;4698.8355407560575;4992.251162325644;5012.2231054186295;5016.673916195472;5049.545540901337;5053.898922021539;4805.471398146201;5053.949460505385;5057.5448209660935;5082.542571168576;5119.232115182753;4624.514425985257;4665.4168228971375;4685.625149988061;4718.504557021532;4727.527247275314;5107.438181799999;5171.844844654666;5212.609054320941;5227.059129356676;5242.397124330674;4780.856574302707;4961.5534601886;4979.800807967641;5007.098722230034;5052.393712754493;4850.733209673432;5019.774110165052;5058.140116180258;5083.87290317745;5107.795688172506;4938.925916111261;5018.096742586296;5033.018561380569;5044.621653376012;5088.0587091388215;4937.333459982929;4964.652474326835;4976.353074100344;4980.651354405157;5010.123228435009;4234.343676730112;4297.527272000078;4302.290122129876;4333.761643109596;4338.110687309094;3715.5727091384297;3720.330340538675;3728.086618778417;3735.813209339522;3761.097336639242;4252.277112890816;4361;4392.912141757147;4400.75795831226;4446.977765111218;5082.491750824888;5107.514786095315;5119.155339368963;5147.150720131136;5159.406668233126;4307.956920430818;4338.891527711832;4342.370356298319;4353.020570371705;4392.516823149451;4357.281048627005;4500.437445319335;4559.589636932692;4569.95430045702;4571.519990401027;4678.461976872567;4713.410823647044;4715.78778954941;4735.668503204743;4767.76161191946;5010.824621138243;5023.995200959896;5029.622778291716;5031.974840125776;5060.468650791614;4644.535546445329;4690.9765451172525;4720.740359280273;4782.856514304576;4794.808207671654;4915.11527924977;4940.629452790983;4942.654014218971;4955.5044495550155;4994.101061808909;5010.198368261061;5024.598032157345;5028.120078986236;5034.773435195499;5085;4740.881477963078;4793.065352256276;4847.127517046824;4926;5012.974935125301;4778.139934811628;4785.353977213032;4806;4812.855614331575;4819.95180048209;4719.764011799465;4734.834280800155;4758.952410475989;4762.785674644719;4837.443693975238;4911.901761964812;4921.9507804921495;4934.753262336797;4940.827071052496;4989.775460104232;4775.044991001744;4829.034193161311;4831.589314908272;4884.511548845087;4893.314935908905 05:43:41 INFO - PROCESS | 3489 | |1;ext.html;559.462915601023;598.5510866849862;598.8592680720031;622.9783155624776;626.2703949898369;35386;36287.63712362875;36409;36425.81787091061;36433.45349819748;39171.21657566847;39957;40053;40058.799706001504;40212.39681404774;7636.961815190916;7766.262205090507;7833.5299882006975;7833.9608301958415;7849.529028258323;7727.111382191064;7883.526988380687;7897.921020789776;7901.407394445439;7903.0911445183965;7790.45466817323;7892.250236227578;7918.32694220989;7918.80202994924;7930.048394192705;7749.961250193769;7810.49231799934;7822.374210063182;7863.724769633035;7872.448928575002;7653.15815260321;7778.416618753616;7815.687372505093;7827.6868925242925;7865.095514015904;36964.44553331702;37086.629133708586;37248.627513725056;37435.625643743486;37491.8125409374;2924.6490421149388;3147.013629741969;3327.4212485323824;3760.9623903761158;3796.3735983562956;29109.272268193465;29460;30176.547351789523;30487.847560762275;30603.540946885816;3056.2512184514712;3134.7022032907066;3188.681131886816;3192.696693814084;3218.951715724266;234081;237738;238592;238944;239861;31254.843725781226;54767.72616136894;55117.44882551123;55333.170002449995;55428.44571554233;32466.513002304986;32556.186095347333;32752.34495310128;32812.83593582017;32815;12420.441080151415;12723.491060357483;12746.36268186587;12751.59732429432;12775.488980440865;10328.896711032794;10362.948185259176;10389.753229612345;10401.115905147995;10427.11369533583;8127.431079824474;8170.7957301067945;8191.262786349138;8236.958815205886;8372.665093396317;3228.7255583275214;3285.0801775502896;3308.470644696837;3321.6678332167075;3324.850381732828;865.6321063547967;974.6783561424713;987.3434166279344;998.1615443027891;1007.1791489935679;25613.23160305194;25815.741842581334;26406.73593264081;26779.464410711676;27049.594256086173;931.5156118818177;987.8814542254831;998.0418797953901;1003.4380746781826;1033.2302434686208;13598.252096134807;13808.447662093404;14421.92789036069;14459.349329280207;14475.131492110297;364474;369086;371960;374139;375090;49320.75339623279;50216;50262.24606630903;50310.49689503131;50560.49439505632;1219.8353222314875;1252.6762854904205;1253.160382543698;1264.6648638110908;1270.790319597256;26784.866075669495;27405.45189096167;28049.71950280471;28106.156815295573;28233;41578.79210603928;42003.57996419997;42152.36771448492;42457.1508569833;42468;325682;325720;327616;329036;330017;25978.35054123662;26308.947642094867;26552.336191594593;37446.438303424926;38684;41877.58122418859;41982.370264445446;42467.3629895558;42612.57387426086;43384;36260.63739362573;36267.45598815967;36479.635203648686;36545.269094617426;36563.26873462569;35635.643643563235;36023.27953440969;36111.45832812563;36271.63728362683;36323.45514817333;28555.857220713762;33095.66904330926;33231.169220769676;35009;36121.63878361288;31713.841430792698;32890.40329250709;33258.33483330272;33288.33423331568;33470;25274.873625631753;25282.747172528776;25402;25479.726013699612;25496.745032549436 05:43:41 INFO - PROCESS | 3489 | |2;jquery.html;377.2775135615296;381.2223064947506;383.1666126175569;386.3007955600362;392.7878945369497;15877.297814627662;16594.58513537159;17016;17016.149192540386;17034.74447883283;11319.547218111265;15973.440929567467;16645.83354166461;16691.08199049052;16733.330666773345;4733.621310295177;4856.271559266121;4883.536064073925;4886.413630364344;4893.339399181118;3507.140750516114;5423.538999185074;5654.6041777075625;5668.348139963895;5711.514521265697;5663.745131469073;5693.117566777156;5704.286964129484;5708.286464191976;5808.332041815203;6046.3349031606485;6071.635701857903;6080.0575910733905;6181.969090154543;6191.876162476748;5356.223347614613;5458.5087342139;5533.142362933751;5551.2228288039705;5558.277423934903;12719.682007949876;12760;12800.231986080866;12846.678833029155;17187.3984410545;1888.5373083594607;1964.764228292614;2003.3388981636026;2153.956920861574;2383.927232745254;9529.904700952971;9795.461249631267;9849.704508864745;9928.95035524825;10408.271421000532;1726.3698749956302;1759.832815882489;1797.8471829894474;1859.9721004184948;1887.3677318098453;71072.2892771076;74866.25133748648;75185.62407187984;75499.62250188769;76525.61737191334;10198.949005255075;10262.846057309147;10442.321249118935;10459.738506537245;10544.156467482582;14349.210793406462;14434.927825360806;14589.489367872286;14615;14653.853461465462;7141.428685705131;7256.818579535554;7351.522151060164;7410;7440.627968601549;6774.220964589037;6823.454123670094;6930.965345173343;6964.965175174193;7007.089078419875;4288.785560721952;4482.901689086129;4524.014150660548;4604.976975115103;4607;1702.4807433732583;1806.6386722655523;1911.8470522358177;1914.9904250478937;1918.7933876042384;921.235374639048;937.9155875971059;969.970900872975;983.7688143286322;998.4558415663481;15610.843891561166;16251.674966500605;16321.83678163227;16647.16764161787;16836.57908552296;863.7408777366765;881.1716986033108;884.9601767920459;897.2597606974273;914.6615752171739;9140.680076197434;9175.174234318943;9208.953955230316;9345.252379809599;9394.201492873046;402964;406608;414572;416670;426441;82900;83992;86028.56985715032;86917.13082869217;87465.1253487457;982.5234761140841;983.439439519467;989.9505024748589;999.5002498750624;1009.0666133826181;14682.853171468149;14770.227572691347;14797;15192.848071519586;15501.509142158608;34839.47740783941;35445.29109417849;35900;36710.8164459176;37278;46315.3052704203;48661.5133848657;49183.50816491789;49517.257241140695;50043.249351260485;7594.974558828783;7642.197569255148;7740.651670674721;7856;7865.3314468268545;11091.72270693239;11446.542138314375;11460.656180314603;11473.713157171138;11482.36846973391;9496.43021418717;9707.951460242653;9740.805183896424;9847.556859941176;10143;9949.900500994898;10032.548535315782;10076.647317343857;10370.896291036994;10404;10203.540840662337;10304.742381440525;10330.535125919201;10336.276460647683;10408.323458975143;7727.574983375968;7822.335101516434;7966.243206895336;8032.759017229492;8036.397270204641;8627.22354988054;9755.902440975784;9791.314607977658;9856.753581160528;10070.395776253448 05:43:41 INFO - PROCESS | 3489 | |3;mootools.html;1416.8370637376702;1467.3103641288596;1587.6030992251938;1778;1779.87540872139;6790.253072162071;7153.570785752859;7354.669039893204;7494.5503269803785;7495.512791668538;7391.0761154855645;7463.2163622819635;7469.47713660044;7500.887486687704;7520.736774212904;2177.1182671018264;2204.603171429142;2210.9778902211015;2215.3575463115676;2223.5997520446313;2164.7618761936174;2206.0293470872766;2207.7792220777956;2223.377454312787;2225.899834507451;2190.912363505458;2205.71325727656;2209.5139069404786;2221.6334304839684;2272.5682120397155;2136.3377353020614;2145.6566949288117;2148.6132496150685;2150.967735483969;2156.6657168138963;2149.7420309562795;2176.260071575656;2183.912643494258;2185.4427121084022;2195.4401627585025;7619.657115429819;7663.808404789869;7694.846103077963;7697.076350837935;7705.190954949706;4427.601515863587;4581.633469322446;4601.309803529464;4626.606738427237;4629.467611224719;2688.6101515280175;2725.5775354819834;2742.8765705543296;2745.8489783061923;2924.1958461423064;923.7090316550265;940.4028441939349;980.1374790184664;991.7421470417671;1015.3704703084061;10621;10649.946750266277;10674.573017079307;10702.090322322612;10718.839217411745;4250.852269887175;4272.316429371285;4346.891327716832;4386.320120381346;4395.1868904252815;9164;9168.358214925025;9168.808054952813;9177.954110229406;9221.49281789508;4694.037722266927;4711.7879695413785;4717.410323709536;4719.646026547954;4725.07860967115;3664.4320130379833;4065.776382299002;4172.332426811696;4204.159168166318;4268.658507319407;3630.2013557017412;3633.709303255786;3666.368466032643;3679.8528058877346;3768.9434658480145;1211.4730092409654;1214.4595654933646;1220.2190598017276;1220.353212797219;1228.4410593180082;863.2705363967438;885.4465958775766;886.7206829848577;886.8625363068735;891.9286457083417;5190.11767999441;5397.892042159135;5448.128299472065;5479.287692599936;5575.4424557543925;868.3227082875368;884.56214173983;917.3853518142861;929.4934260827865;929.9581518831534;3707.9814600926825;3709.1839795245005;3735.8792362291206;3794.29805485986;3825.273198092409;9280.535973201448;9550.474723890115;9707.271954603291;9709.465979371202;9760.560774765152;9435.29235307341;9483.90516094844;9520.143187113194;9601.32790704644;9635.22918166545;7307.963460182665;7348;7365.889511657329;7449;7488.850222995618;5306.25712400272;5315.893682126413;5344.331958505187;5368.382635996911;5370.113931201308;8788.560571971504;8827.16141966512;9116.270698343984;9118.40730352525;9163.312751543794;8950.82098358016;9079.68221112258;9103.954480227556;9179.862302065341;9323.160915517636;5753.884922301447;6149.446549810538;6256.311805701278;6954.687039083152;7330.047093877762;7317.853642927218;7389.371903388273;7410.333070023724;7430.591317477591;7474.215207403362;6633.800985970429;6656.101426307387;6716.059751634677;6755.898661519983;6846.554973926679;6459.838504037249;6684.131062961784;6696.7656132035145;6700.765473208415;6718.294579069127;6389.648569328731;6459.61242325462;6529;6547.607143571401;6571.34286571339;4473.619742321809;4601.355810186644;4630.560096790799;4686.343911852412;4737.407824021997;4640.118377508263;4706.647001474971;4713.31656909753;4791.161546729239;4821.831235906727 05:43:41 INFO - PROCESS | 3489 | |4;prototype.html;302.6413699765776;313.8164173958234;316.48729058924545;318.1632307032504;318.51585589903357;4821.517848215177;4853.514648535145;4906.950930490694;5019.322391477154;5032.345795046644;4909.9754501227535;4969.304297398358;4978.278149668296;4979.576735977446;4989.850304490862;3941.0935484838506;3942.7240093193486;3981.2037592481474;3983.088117703504;4000.3399439092514;3728.4780130781714;3963.7819919904396;3965.484487016698;3986.840526378956;3998.1803730235233;3845.250176215639;3864.14988702485;3875.8255878485534;3876.1472476055224;3891;3869.555001174873;3873.0247573737315;3877.689784817208;3898.9805050974564;3901.0442441601704;3473.166440054394;3482.9825850870584;3487.7209823214334;3488.197714525648;3489.1277180704824;4539.409876716006;4738.763061846894;4740.265258884879;4756.549252477993;4778.617710583145;4410.426644536222;4412.691111622188;4438.400815889878;4438.511763705989;4445.488768791598;5127.769250383742;5165.354330708661;5165.612579056548;5168.715720635363;5175.404828444739;3655.817209139559;3745.7077308328585;3748.6813620842263;3767.1900541383734;3779.79211143387;5408.5402740766685;5461.617686761889;5478.616496845222;5479.424660410639;5481.835544933659;3910.296146693566;3911.6283953024417;3911.7066220033043;3922.9215415692097;3923.2153569286256;3945.82243799024;3958.9010274743364;3963.900902477461;3964.4053391991433;3972.940405893914;4332.653387728974;4429.202743506135;4432.578905004019;4441.400410944481;4441.955580444219;5114.43741188469;5177.301064356339;5199.870003249874;5251.474852514794;5251.553617942518;1342.6441992871896;1401.614555997109;1443.8917081218951;1447.3920953199681;1451.361400983564;976.4873441443157;977.9315447918719;985.4333758089127;997.3317877022413;1001.8246806808779;4737.620990320766;4741.980474198064;4769.427668679711;4778.665493415497;4786.16242157621;5631.549476041907;5643.7742490299925;5648.011597970339;5651.547876169897;5658.349289831722;4628.907421851544;4762.357081793983;4800.687955282895;4801.639877009238;4806.519348065165;2986.148947549981;3000.7599392048583;3014.668386477486;3044.1324222596454;3052.236940764809;5226.367674466285;5271.3674359076385;5301.54936830366;5310.4424035476495;5327.174287985368;5635.746391412396;5806.706350991335;5827.969455882917;5833.941660583425;5838.824835254949;5285.841424757264;5324.227986941872;5338.839834804962;5344.652597581145;5367.1680889462195;5518.448155184449;5697.803461273179;5705.7147142643535;5709.20071190042;5736.254286942671;5547.916781248204;5559.16612508127;5573.54763903881;5587.0388693992245;5590.692511911884;5275.261463395051;5282.418933917189;5287.814926477555;5292.285541451854;5320.973395133;3589.9282014360087;4001.2197621463533;4011;4018.5579586244903;4023.5574086851007;5079.314292570456;5157;5311.601629877698;5375.871067075958;5401.838604700009;5157;5198.714070725995;5201.219817027476;5229.555487783429;5233.685978841282;5162.838361368662;5187.170052791686;5188.195829646411;5200.97399513;5216.686998780086;4895.461499235153;5137.8715532112;5156.819511317086;5166.819161329336;5212.192110222922;5226.947730522798;5283.169701966198;5302.946970530245;5322.973385133049;5339.012282727708;5151.5363617274625;5151.896962060813;5175.301334319969;5207.92188117171;5216.40011398694 05:43:41 INFO - PROCESS | 3489 | |5;yui.html;629.6505439481089;654.1071437487831;678.2505331608576;706.6224737749642;709.4466316273308;11365.829512557319;11448;11466.770664586713;11736.53053877845;12066.57766978157;12891.290978996174;12923.289219092947;12955.481780728784;13060.281684507348;13081.084324097317;630.1304200203735;788.6135793461192;799.7161007842219;807.4065561812064;808.2079562029215;804.4891493901356;805.629410471184;807.3984881263438;808.3573559020592;808.6724876425058;843.0641987393988;843.5191940593865;843.7679638099511;844.0293662288386;844.8817165596821;839.202757380491;839.2530647723531;839.7061028639988;840.0591337701813;842.9578521073922;612.6722203621041;619.0590302739855;619.0961196652892;621.7481919822479;626.0234034905562;12710.555130570385;12748.235105893677;12765.680857978625;12767.170133941265;12806.42371093303;11541.192116551845;11683.941580292128;11729.941350293278;11934.522619095225;12261.386930653433;9869.407835529892;9888.159506441889;9999.600015999351;10085.89914100857;10103.040211179927;3141.2618034761813;3187.984060079708;3195.536647186145;3239.1416274687226;3244.610646722385;46897.531024689655;47120.52879471196;47535.5246447538;47608.52391476076;47613.28580071302;9040.231580315747;9092.8636070459;9198.264138868875;9232.538373081454;9242.214411775074;16562.420315288906;16730.4144354947;16745.497635070966;16753.32986680519;16796;6419.51853610981;6479.384458476531;6553.705083271264;6693.631850248283;6730.697118629673;3628.3650361186687;3629.219717760694;3680.190358121209;3686.6681998619715;3835.4822099016833;2771.196353057631;2863.7852161088003;2864.1550742530585;2865.799394042397;2866.512692842222;508.45087305709745;508.80919655129327;516.9095408303532;524.5146004798095;530.7611574791359;515.9226116082617;520.5575261028096;571.3201290464334;575.453319346614;594.0346936228628;7585.544867307979;7672.462927595015;7836.098848632366;7982.481138725964;8048.195180481905;509.3124282219049;624.5128799536369;625.7090452939404;628.9371062893674;629.568745409396;3657.7988210648136;3733.3280009598534;3844.557875844258;3917.2557214129224;3945.8618948337244;49680;50491;51616.48383516192;51908;53215.20177197345;47541.5245847544;48270;48433.273500897514;49765.50234497681;50461.747691261306;43128.137437251076;43793.56206437895;44861;44973;45969.77015114903;7208.387287080657;7230.457715671451;7292.890606640798;7305.744298949511;7416.888746668912;29962.850185749805;30663.540046898866;30888.53667194949;31095.067147985596;31497.8425107873;37492.250154997295;39398.409023865235;39848.40227396534;39991.80004099961;40468.1906361877;9160.541972901196;9291.907080929375;9550.044995500395;10120.332613736331;10491.318064325795;11063;11676.357800321064;11683.299002059903;11846.52613895469;12158.696032599255;10538.81859475796;10825.13398928068;11078.169137314573;11485;11534.307941523535;10195.235357348376;10292.639757608747;10385.546023556557;10692.411917344622;10751.838722419327;10800.513976870903;10966.287191332538;10990.560377584807;11156.49795759209;11297.71755706114;9234.398307142545;9437.528123593656;9452.669156579486;9529.14237718581;9723.222142228464;8977.899862654514;9222.861657075284;9247.630094796134;9352.906470935204;9367.016463271259 05:43:41 INFO - PROCESS | 3489 | __end_tp_report 05:43:41 INFO - PROCESS | 3489 | __start_cc_report 05:43:41 INFO - PROCESS | 3489 | _x_x_mozilla_cycle_collect,366 05:43:41 INFO - PROCESS | 3489 | __end_cc_report 05:43:41 INFO - PROCESS | 3489 | __startTimestamp1461933821521__endTimestamp 05:43:41 INFO - PROCESS | 3489 | 05:43:41 INFO - PROCESS | 3489 | ------- Summary: start ------- 05:43:41 INFO - PROCESS | 3489 | Number of tests: 6 05:43:41 INFO - PROCESS | 3489 | 05:43:41 INFO - PROCESS | 3489 | [#0] dojo.html Cycles:165 Average:4647.22 Median:4758.95 stddev:479.78 (10.1%) stddev-sans-first:453.90 05:43:41 INFO - PROCESS | 3489 | Values: 2611.5 2672.8 2703.6 2718.6 2721.9 4721.4 4751.2 4753.0 4756.3 4797.6 4565.6 4690.9 4707.6 4771.7 4773.3 4334.2 4358.3 4368.9 4390.9 4448.7 4051.6 4328.9 4339.2 4359.3 4373.5 4180.5 4267.0 4340.5 4347.3 4364.0 4229.2 4297.4 4330.4 4332.9 4356.6 4294.1 4309.8 4329.2 4333.7 4361.7 4587.4 4618.2 4649.3 4660.9 4698.8 4992.3 5012.2 5016.7 5049.5 5053.9 4805.5 5053.9 5057.5 5082.5 5119.2 4624.5 4665.4 4685.6 4718.5 4727.5 5107.4 5171.8 5212.6 5227.1 5242.4 4780.9 4961.6 4979.8 5007.1 5052.4 4850.7 5019.8 5058.1 5083.9 5107.8 4938.9 5018.1 5033.0 5044.6 5088.1 4937.3 4964.7 4976.4 4980.7 5010.1 4234.3 4297.5 4302.3 4333.8 4338.1 3715.6 3720.3 3728.1 3735.8 3761.1 4252.3 4361.0 4392.9 4400.8 4447.0 5082.5 5107.5 5119.2 5147.2 5159.4 4308.0 4338.9 4342.4 4353.0 4392.5 4357.3 4500.4 4559.6 4570.0 4571.5 4678.5 4713.4 4715.8 4735.7 4767.8 5010.8 5024.0 5029.6 5032.0 5060.5 4644.5 4691.0 4720.7 4782.9 4794.8 4915.1 4940.6 4942.7 4955.5 4994.1 5010.2 5024.6 5028.1 5034.8 5085.0 4740.9 4793.1 4847.1 4926.0 5013.0 4778.1 4785.4 4806.0 4812.9 4820.0 4719.8 4734.8 4759.0 4762.8 4837.4 4911.9 4922.0 4934.8 4940.8 4989.8 4775.0 4829.0 4831.6 4884.5 4893.3 05:43:41 INFO - PROCESS | 3489 | 05:43:41 INFO - PROCESS | 3489 | [#1] ext.html Cycles:180 Average:45688.45 Median:36269.55 stddev:83592.03 (230.5%) stddev-sans-first:83757.86 05:43:41 INFO - PROCESS | 3489 | Values: 559.5 598.6 598.9 623.0 626.3 35386.0 36287.6 36409.0 36425.8 36433.5 39171.2 39957.0 40053.0 40058.8 40212.4 7637.0 7766.3 7833.5 7834.0 7849.5 7727.1 7883.5 7897.9 7901.4 7903.1 7790.5 7892.3 7918.3 7918.8 7930.0 7750.0 7810.5 7822.4 7863.7 7872.4 7653.2 7778.4 7815.7 7827.7 7865.1 36964.4 37086.6 37248.6 37435.6 37491.8 2924.6 3147.0 3327.4 3761.0 3796.4 29109.3 29460.0 30176.5 30487.8 30603.5 3056.3 3134.7 3188.7 3192.7 3219.0 234081.0 237738.0 238592.0 238944.0 239861.0 31254.8 54767.7 55117.4 55333.2 55428.4 32466.5 32556.2 32752.3 32812.8 32815.0 12420.4 12723.5 12746.4 12751.6 12775.5 10328.9 10362.9 10389.8 10401.1 10427.1 8127.4 8170.8 8191.3 8237.0 8372.7 3228.7 3285.1 3308.5 3321.7 3324.9 865.6 974.7 987.3 998.2 1007.2 25613.2 25815.7 26406.7 26779.5 27049.6 931.5 987.9 998.0 1003.4 1033.2 13598.3 13808.4 14421.9 14459.3 14475.1 364474.0 369086.0 371960.0 374139.0 375090.0 49320.8 50216.0 50262.2 50310.5 50560.5 1219.8 1252.7 1253.2 1264.7 1270.8 26784.9 27405.5 28049.7 28106.2 28233.0 41578.8 42003.6 42152.4 42457.2 42468.0 325682.0 325720.0 327616.0 329036.0 330017.0 25978.4 26308.9 26552.3 37446.4 38684.0 41877.6 41982.4 42467.4 42612.6 43384.0 36260.6 36267.5 36479.6 36545.3 36563.3 35635.6 36023.3 36111.5 36271.6 36323.5 28555.9 33095.7 33231.2 35009.0 36121.6 31713.8 32890.4 33258.3 33288.3 33470.0 25274.9 25282.7 25402.0 25479.7 25496.7 05:43:41 INFO - PROCESS | 3489 | 05:43:41 INFO - PROCESS | 3489 | [#2] jquery.html Cycles:180 Average:25042.80 Median:4794.95 stddev:68428.82 (1427.1%) stddev-sans-first:68595.72 05:43:41 INFO - PROCESS | 3489 | Values: 377.3 381.2 383.2 386.3 392.8 15877.3 16594.6 17016.0 17016.1 17034.7 11319.5 15973.4 16645.8 16691.1 16733.3 4733.6 4856.3 4883.5 4886.4 4893.3 3507.1 5423.5 5654.6 5668.3 5711.5 5663.7 5693.1 5704.3 5708.3 5808.3 6046.3 6071.6 6080.1 6182.0 6191.9 5356.2 5458.5 5533.1 5551.2 5558.3 12719.7 12760.0 12800.2 12846.7 17187.4 1888.5 1964.8 2003.3 2154.0 2383.9 9529.9 9795.5 9849.7 9929.0 10408.3 1726.4 1759.8 1797.8 1860.0 1887.4 71072.3 74866.3 75185.6 75499.6 76525.6 10198.9 10262.8 10442.3 10459.7 10544.2 14349.2 14434.9 14589.5 14615.0 14653.9 7141.4 7256.8 7351.5 7410.0 7440.6 6774.2 6823.5 6931.0 6965.0 7007.1 4288.8 4482.9 4524.0 4605.0 4607.0 1702.5 1806.6 1911.8 1915.0 1918.8 921.2 937.9 970.0 983.8 998.5 15610.8 16251.7 16321.8 16647.2 16836.6 863.7 881.2 885.0 897.3 914.7 9140.7 9175.2 9209.0 9345.3 9394.2 402964.0 406608.0 414572.0 416670.0 426441.0 82900.0 83992.0 86028.6 86917.1 87465.1 982.5 983.4 990.0 999.5 1009.1 14682.9 14770.2 14797.0 15192.8 15501.5 34839.5 35445.3 35900.0 36710.8 37278.0 46315.3 48661.5 49183.5 49517.3 50043.2 7595.0 7642.2 7740.7 7856.0 7865.3 11091.7 11446.5 11460.7 11473.7 11482.4 9496.4 9708.0 9740.8 9847.6 10143.0 9949.9 10032.5 10076.6 10370.9 10404.0 10203.5 10304.7 10330.5 10336.3 10408.3 7727.6 7822.3 7966.2 8032.8 8036.4 8627.2 9755.9 9791.3 9856.8 10070.4 05:43:41 INFO - PROCESS | 3489 | 05:43:41 INFO - PROCESS | 3489 | [#3] mootools.html Cycles:180 Average:5145.31 Median:5369.25 stddev:2845.76 (53.0%) stddev-sans-first:2839.94 05:43:41 INFO - PROCESS | 3489 | Values: 1416.8 1467.3 1587.6 1778.0 1779.9 6790.3 7153.6 7354.7 7494.6 7495.5 7391.1 7463.2 7469.5 7500.9 7520.7 2177.1 2204.6 2211.0 2215.4 2223.6 2164.8 2206.0 2207.8 2223.4 2225.9 2190.9 2205.7 2209.5 2221.6 2272.6 2136.3 2145.7 2148.6 2151.0 2156.7 2149.7 2176.3 2183.9 2185.4 2195.4 7619.7 7663.8 7694.8 7697.1 7705.2 4427.6 4581.6 4601.3 4626.6 4629.5 2688.6 2725.6 2742.9 2745.8 2924.2 923.7 940.4 980.1 991.7 1015.4 10621.0 10649.9 10674.6 10702.1 10718.8 4250.9 4272.3 4346.9 4386.3 4395.2 9164.0 9168.4 9168.8 9178.0 9221.5 4694.0 4711.8 4717.4 4719.6 4725.1 3664.4 4065.8 4172.3 4204.2 4268.7 3630.2 3633.7 3666.4 3679.9 3768.9 1211.5 1214.5 1220.2 1220.4 1228.4 863.3 885.4 886.7 886.9 891.9 5190.1 5397.9 5448.1 5479.3 5575.4 868.3 884.6 917.4 929.5 930.0 3708.0 3709.2 3735.9 3794.3 3825.3 9280.5 9550.5 9707.3 9709.5 9760.6 9435.3 9483.9 9520.1 9601.3 9635.2 7308.0 7348.0 7365.9 7449.0 7488.9 5306.3 5315.9 5344.3 5368.4 5370.1 8788.6 8827.2 9116.3 9118.4 9163.3 8950.8 9079.7 9104.0 9179.9 9323.2 5753.9 6149.4 6256.3 6954.7 7330.0 7317.9 7389.4 7410.3 7430.6 7474.2 6633.8 6656.1 6716.1 6755.9 6846.6 6459.8 6684.1 6696.8 6700.8 6718.3 6389.6 6459.6 6529.0 6547.6 6571.3 4473.6 4601.4 4630.6 4686.3 4737.4 4640.1 4706.6 4713.3 4791.2 4821.8 05:43:41 INFO - PROCESS | 3489 | 05:43:41 INFO - PROCESS | 3489 | [#4] prototype.html Cycles:180 Average:4418.18 Median:4939.64 stddev:1276.05 (25.8%) stddev-sans-first:1241.68 05:43:41 INFO - PROCESS | 3489 | Values: 302.6 313.8 316.5 318.2 318.5 4821.5 4853.5 4907.0 5019.3 5032.3 4910.0 4969.3 4978.3 4979.6 4989.9 3941.1 3942.7 3981.2 3983.1 4000.3 3728.5 3963.8 3965.5 3986.8 3998.2 3845.3 3864.1 3875.8 3876.1 3891.0 3869.6 3873.0 3877.7 3899.0 3901.0 3473.2 3483.0 3487.7 3488.2 3489.1 4539.4 4738.8 4740.3 4756.5 4778.6 4410.4 4412.7 4438.4 4438.5 4445.5 5127.8 5165.4 5165.6 5168.7 5175.4 3655.8 3745.7 3748.7 3767.2 3779.8 5408.5 5461.6 5478.6 5479.4 5481.8 3910.3 3911.6 3911.7 3922.9 3923.2 3945.8 3958.9 3963.9 3964.4 3972.9 4332.7 4429.2 4432.6 4441.4 4442.0 5114.4 5177.3 5199.9 5251.5 5251.6 1342.6 1401.6 1443.9 1447.4 1451.4 976.5 977.9 985.4 997.3 1001.8 4737.6 4742.0 4769.4 4778.7 4786.2 5631.5 5643.8 5648.0 5651.5 5658.3 4628.9 4762.4 4800.7 4801.6 4806.5 2986.1 3000.8 3014.7 3044.1 3052.2 5226.4 5271.4 5301.5 5310.4 5327.2 5635.7 5806.7 5828.0 5833.9 5838.8 5285.8 5324.2 5338.8 5344.7 5367.2 5518.4 5697.8 5705.7 5709.2 5736.3 5547.9 5559.2 5573.5 5587.0 5590.7 5275.3 5282.4 5287.8 5292.3 5321.0 3589.9 4001.2 4011.0 4018.6 4023.6 5079.3 5157.0 5311.6 5375.9 5401.8 5157.0 5198.7 5201.2 5229.6 5233.7 5162.8 5187.2 5188.2 5201.0 5216.7 4895.5 5137.9 5156.8 5166.8 5212.2 5226.9 5283.2 5302.9 5323.0 5339.0 5151.5 5151.9 5175.3 5207.9 5216.4 05:43:41 INFO - PROCESS | 3489 | 05:43:41 INFO - PROCESS | 3489 | [#5] yui.html Cycles:180 Average:12824.77 Median:48351.64 stddev:14842.26 (30.7%) stddev-sans-first:14855.64 05:43:41 INFO - PROCESS | 3489 | Values: 629.7 654.1 678.3 706.6 709.4 11365.8 11448.0 11466.8 11736.5 12066.6 12891.3 12923.3 12955.5 13060.3 13081.1 630.1 788.6 799.7 807.4 808.2 804.5 805.6 807.4 808.4 808.7 843.1 843.5 843.8 844.0 844.9 839.2 839.3 839.7 840.1 843.0 612.7 619.1 619.1 621.7 626.0 12710.6 12748.2 12765.7 12767.2 12806.4 11541.2 11683.9 11729.9 11934.5 12261.4 9869.4 9888.2 9999.6 10085.9 10103.0 3141.3 3188.0 3195.5 3239.1 3244.6 46897.5 47120.5 47535.5 47608.5 47613.3 9040.2 9092.9 9198.3 9232.5 9242.2 16562.4 16730.4 16745.5 16753.3 16796.0 6419.5 6479.4 6553.7 6693.6 6730.7 3628.4 3629.2 3680.2 3686.7 3835.5 2771.2 2863.8 2864.2 2865.8 2866.5 508.5 508.8 516.9 524.5 530.8 515.9 520.6 571.3 575.5 594.0 7585.5 7672.5 7836.1 7982.5 8048.2 509.3 624.5 625.7 628.9 629.6 3657.8 3733.3 3844.6 3917.3 3945.9 49680.0 50491.0 51616.5 51908.0 53215.2 47541.5 48270.0 48433.3 49765.5 50461.7 43128.1 43793.6 44861.0 44973.0 45969.8 7208.4 7230.5 7292.9 7305.7 7416.9 29962.9 30663.5 30888.5 31095.1 31497.8 37492.3 39398.4 39848.4 39991.8 40468.2 9160.5 9291.9 9550.0 10120.3 10491.3 11063.0 11676.4 11683.3 11846.5 12158.7 10538.8 10825.1 11078.2 11485.0 11534.3 10195.2 10292.6 10385.5 10692.4 10751.8 10800.5 10966.3 10990.6 11156.5 11297.7 9234.4 9437.5 9452.7 9529.1 9723.2 8977.9 9222.9 9247.6 9352.9 9367.0 05:43:41 INFO - PROCESS | 3489 | -------- Summary: end -------- 05:43:41 INFO - PROCESS | 3489 | 05:43:42 INFO - TEST-INFO | 3489: exit 0 05:43:42 INFO - TEST-OK | dromaeo_css | took 1119031ms 05:43:42 INFO - TEST-START | kraken 05:43:42 INFO - operating with platform_type : linux_ 05:43:42 INFO - Initialising browser for kraken test... 05:43:42 INFO - TEST-INFO | started process 3721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpju5P1J/profile http://localhost:43270/getInfo.html) 05:43:46 INFO - PROCESS | 3721 | 05:43:46 INFO - PROCESS | 3721 | (process:3789): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:43:47 INFO - PROCESS | 3721 | __metrics Screen width/height:1600/1200 05:43:47 INFO - PROCESS | 3721 | colorDepth:24 05:43:47 INFO - PROCESS | 3721 | Browser inner width/height: 1024/697 05:43:47 INFO - PROCESS | 3721 | __metrics 05:43:47 ERROR - PROCESS | 3721 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:43:48 INFO - TEST-INFO | 3721: exit 0 05:43:48 INFO - Browser initialized. 05:43:48 INFO - Running cycle 1/1 for kraken test... 05:43:48 INFO - TEST-INFO | started process 3840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpju5P1J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:50 INFO - PROCESS | 3840 | 05:43:50 INFO - PROCESS | 3840 | (process:3903): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:44:00 INFO - PROCESS | 3840 | RSS: Main: 165715968 05:44:00 INFO - PROCESS | 3840 | 05:44:03 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43270/tests/kraken/driver.html?testName=audio-beat-detection) 05:44:04 INFO - PROCESS | 3840 | RSS: Main: 170684416 05:44:04 INFO - PROCESS | 3840 | 05:44:07 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43270/tests/kraken/driver.html?testName=audio-dft) 05:44:07 INFO - PROCESS | 3840 | RSS: Main: 173662208 05:44:07 INFO - PROCESS | 3840 | 05:44:10 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43270/tests/kraken/driver.html?testName=audio-fft) 05:44:11 INFO - PROCESS | 3840 | RSS: Main: 165076992 05:44:11 INFO - PROCESS | 3840 | 05:44:13 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43270/tests/kraken/driver.html?testName=audio-oscillator) 05:44:13 INFO - PROCESS | 3840 | RSS: Main: 165392384 05:44:13 INFO - PROCESS | 3840 | 05:44:16 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:44:16 INFO - PROCESS | 3840 | RSS: Main: 166637568 05:44:16 INFO - PROCESS | 3840 | 05:44:20 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43270/tests/kraken/driver.html?testName=imaging-darkroom) 05:44:20 INFO - PROCESS | 3840 | RSS: Main: 165871616 05:44:20 INFO - PROCESS | 3840 | 05:44:24 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43270/tests/kraken/driver.html?testName=imaging-desaturate) 05:44:24 INFO - PROCESS | 3840 | RSS: Main: 165519360 05:44:24 INFO - PROCESS | 3840 | 05:44:27 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43270/tests/kraken/driver.html?testName=json-parse-financial) 05:44:28 INFO - PROCESS | 3840 | RSS: Main: 165990400 05:44:28 INFO - PROCESS | 3840 | 05:44:30 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:44:30 INFO - PROCESS | 3840 | RSS: Main: 166658048 05:44:30 INFO - PROCESS | 3840 | 05:44:32 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43270/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:44:33 INFO - PROCESS | 3840 | RSS: Main: 166846464 05:44:33 INFO - PROCESS | 3840 | 05:44:35 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:44:36 INFO - PROCESS | 3840 | RSS: Main: 167059456 05:44:36 INFO - PROCESS | 3840 | 05:44:38 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:44:39 INFO - PROCESS | 3840 | RSS: Main: 167841792 05:44:39 INFO - PROCESS | 3840 | 05:44:42 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:44:43 INFO - PROCESS | 3840 | RSS: Main: 167641088 05:44:43 INFO - PROCESS | 3840 | 05:44:44 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:43270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43270/tests/kraken/driver.html?testName=ai-astar) 05:44:45 INFO - PROCESS | 3840 | RSS: Main: 168816640 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | __start_tp_report 05:44:45 INFO - PROCESS | 3840 | _x_x_mozilla_page_load 05:44:45 INFO - PROCESS | 3840 | _x_x_mozilla_page_load_details 05:44:45 INFO - PROCESS | 3840 | |i|pagename|runs| 05:44:45 INFO - PROCESS | 3840 | |0;ai-astar;118;111;117;114;115;126;114;114;114;113 05:44:45 INFO - PROCESS | 3840 | |1;audio-beat-detection;173;132;163;183;131;165;157;134;196;136 05:44:45 INFO - PROCESS | 3840 | |2;audio-dft;163;164;163;173;169;161;163;165;163;163 05:44:45 INFO - PROCESS | 3840 | |3;audio-fft;74;74;74;170;76;77;74;75;153;78 05:44:45 INFO - PROCESS | 3840 | |4;audio-oscillator;94;94;135;93;94;95;142;93;95;139 05:44:45 INFO - PROCESS | 3840 | |5;imaging-gaussian-blur;117;118;118;118;117;118;119;117;118;118 05:44:45 INFO - PROCESS | 3840 | |6;imaging-darkroom;147;147;148;147;146;147;146;147;147;147 05:44:45 INFO - PROCESS | 3840 | |7;imaging-desaturate;96;96;95;96;96;95;96;95;96;95 05:44:45 INFO - PROCESS | 3840 | |8;json-parse-financial;67;65;65;64;65;63;65;90;63;64 05:44:45 INFO - PROCESS | 3840 | |9;json-stringify-tinderbox;64;65;67;66;65;66;65;65;66;66 05:44:45 INFO - PROCESS | 3840 | |10;stanford-crypto-aes;81;78;81;88;82;82;80;81;82;80 05:44:45 INFO - PROCESS | 3840 | |11;stanford-crypto-ccm;141;136;133;133;137;134;127;137;163;136 05:44:45 INFO - PROCESS | 3840 | |12;stanford-crypto-pbkdf2;178;186;183;175;177;178;175;172;185;177 05:44:45 INFO - PROCESS | 3840 | |13;stanford-crypto-sha256-iterative;72;72;71;70;71;71;74;71;71;71 05:44:45 INFO - PROCESS | 3840 | __end_tp_report 05:44:45 INFO - PROCESS | 3840 | __start_cc_report 05:44:45 INFO - PROCESS | 3840 | _x_x_mozilla_cycle_collect,922 05:44:45 INFO - PROCESS | 3840 | __end_cc_report 05:44:45 INFO - PROCESS | 3840 | __startTimestamp1461933885075__endTimestamp 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | ------- Summary: start ------- 05:44:45 INFO - PROCESS | 3840 | Number of tests: 14 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#0] ai-astar Cycles:10 Average:115.60 Median:114.50 stddev:4.14 (3.6%) stddev-sans-first:4.30 05:44:45 INFO - PROCESS | 3840 | Values: 118.0 111.0 117.0 114.0 115.0 126.0 114.0 114.0 114.0 113.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:164.00 stddev:23.15 (14.1%) stddev-sans-first:23.82 05:44:45 INFO - PROCESS | 3840 | Values: 173.0 132.0 163.0 183.0 131.0 165.0 157.0 134.0 196.0 136.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:3.59 (2.2%) stddev-sans-first:3.76 05:44:45 INFO - PROCESS | 3840 | Values: 163.0 164.0 163.0 173.0 169.0 161.0 163.0 165.0 163.0 163.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#3] audio-fft Cycles:10 Average:92.50 Median:74.50 stddev:36.61 (49.1%) stddev-sans-first:38.22 05:44:45 INFO - PROCESS | 3840 | Values: 74.0 74.0 74.0 170.0 76.0 77.0 74.0 75.0 153.0 78.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.00 stddev:21.65 (23.0%) stddev-sans-first:22.41 05:44:45 INFO - PROCESS | 3840 | Values: 94.0 94.0 135.0 93.0 94.0 95.0 142.0 93.0 95.0 139.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 05:44:45 INFO - PROCESS | 3840 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 119.0 117.0 118.0 118.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:44:45 INFO - PROCESS | 3840 | Values: 147.0 147.0 148.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:44:45 INFO - PROCESS | 3840 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:65.00 stddev:8.13 (12.5%) stddev-sans-first:8.62 05:44:45 INFO - PROCESS | 3840 | Values: 67.0 65.0 65.0 64.0 65.0 63.0 65.0 90.0 63.0 64.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 05:44:45 INFO - PROCESS | 3840 | Values: 64.0 65.0 67.0 66.0 65.0 66.0 65.0 65.0 66.0 66.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:2.59 (3.2%) stddev-sans-first:2.74 05:44:45 INFO - PROCESS | 3840 | Values: 81.0 78.0 81.0 88.0 82.0 82.0 80.0 81.0 82.0 80.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:136.50 stddev:9.60 (7.0%) stddev-sans-first:10.11 05:44:45 INFO - PROCESS | 3840 | Values: 141.0 136.0 133.0 133.0 137.0 134.0 127.0 137.0 163.0 136.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:178.00 stddev:4.60 (2.6%) stddev-sans-first:4.87 05:44:45 INFO - PROCESS | 3840 | Values: 178.0 186.0 183.0 175.0 177.0 178.0 175.0 172.0 185.0 177.0 05:44:45 INFO - PROCESS | 3840 | 05:44:45 INFO - PROCESS | 3840 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:1.07 (1.5%) stddev-sans-first:1.12 05:44:45 INFO - PROCESS | 3840 | Values: 72.0 72.0 71.0 70.0 71.0 71.0 74.0 71.0 71.0 71.0 05:44:45 INFO - PROCESS | 3840 | -------- Summary: end -------- 05:44:45 INFO - PROCESS | 3840 | 05:44:46 INFO - TEST-INFO | 3840: exit 0 05:44:46 INFO - TEST-OK | kraken | took 63829ms 05:44:46 INFO - SUITE-END | took 1182s 05:44:46 INFO - Completed test suite (00:19:43) 05:44:46 INFO - javascript benchmark 05:44:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.5168693791647, 2672.7728143107843, 2703.63500927375, 2718.578620313852, 2721.8502982335976, 4721.386219791427, 4751.16854550454, 4752.976235118824, 4756.334113224147, 4797.6401769867225, 4565.589096981271, 4690.929636055462, 4707.62339012879, 4771.713697178163, 4773.331733557305, 4334.176506463769, 4358.346248062784, 4368.868933931971, 4390.868273951786, 4448.666350023745, 4051.560094475839, 4328.913421731563, 4339.19724850902, 4359.3025115981445, 4373.518912919576, 4180.47744031996, 4266.957330426687, 4340.544242854487, 4347.2826983547675, 4364.0, 4229.238737027334, 4297.35539669049, 4330.39374487572, 4332.891677708051, 4356.607905288539, 4294.055307832303, 4309.78451077448, 4329.177456283296, 4333.696641235115, 4361.738295702236, 4587.42657167854, 4618.1687296286655, 4649.3026046093355, 4660.930086048712, 4698.8355407560575, 4992.251162325644, 5012.2231054186295, 5016.673916195472, 5049.545540901337, 5053.898922021539, 4805.471398146201, 5053.949460505385, 5057.5448209660935, 5082.542571168576, 5119.232115182753, 4624.514425985257, 4665.4168228971375, 4685.625149988061, 4718.504557021532, 4727.527247275314, 5107.438181799999, 5171.844844654666, 5212.609054320941, 5227.059129356676, 5242.397124330674, 4780.856574302707, 4961.5534601886, 4979.800807967641, 5007.098722230034, 5052.393712754493, 4850.733209673432, 5019.774110165052, 5058.140116180258, 5083.87290317745, 5107.795688172506, 4938.925916111261, 5018.096742586296, 5033.018561380569, 5044.621653376012, 5088.0587091388215, 4937.333459982929, 4964.652474326835, 4976.353074100344, 4980.651354405157, 5010.123228435009, 4234.343676730112, 4297.527272000078, 4302.290122129876, 4333.761643109596, 4338.110687309094, 3715.5727091384297, 3720.330340538675, 3728.086618778417, 3735.813209339522, 3761.097336639242, 4252.277112890816, 4361.0, 4392.912141757147, 4400.75795831226, 4446.977765111218, 5082.491750824888, 5107.514786095315, 5119.155339368963, 5147.150720131136, 5159.406668233126, 4307.956920430818, 4338.891527711832, 4342.370356298319, 4353.020570371705, 4392.516823149451, 4357.281048627005, 4500.437445319335, 4559.589636932692, 4569.95430045702, 4571.519990401027, 4678.461976872567, 4713.410823647044, 4715.78778954941, 4735.668503204743, 4767.76161191946, 5010.824621138243, 5023.995200959896, 5029.622778291716, 5031.974840125776, 5060.468650791614, 4644.535546445329, 4690.9765451172525, 4720.740359280273, 4782.856514304576, 4794.808207671654, 4915.11527924977, 4940.629452790983, 4942.654014218971, 4955.5044495550155, 4994.101061808909, 5010.198368261061, 5024.598032157345, 5028.120078986236, 5034.773435195499, 5085.0, 4740.881477963078, 4793.065352256276, 4847.127517046824, 4926.0, 5012.974935125301, 4778.139934811628, 4785.353977213032, 4806.0, 4812.855614331575, 4819.95180048209, 4719.764011799465, 4734.834280800155, 4758.952410475989, 4762.785674644719, 4837.443693975238, 4911.901761964812, 4921.9507804921495, 4934.753262336797, 4940.827071052496, 4989.775460104232, 4775.044991001744, 4829.034193161311, 4831.589314908272, 4884.511548845087, 4893.314935908905], "value": 4617.576876905383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.462915601023, 598.5510866849862, 598.8592680720031, 622.9783155624776, 626.2703949898369, 35386.0, 36287.63712362875, 36409.0, 36425.81787091061, 36433.45349819748, 39171.21657566847, 39957.0, 40053.0, 40058.799706001504, 40212.39681404774, 7636.961815190916, 7766.262205090507, 7833.5299882006975, 7833.9608301958415, 7849.529028258323, 7727.111382191064, 7883.526988380687, 7897.921020789776, 7901.407394445439, 7903.0911445183965, 7790.45466817323, 7892.250236227578, 7918.32694220989, 7918.80202994924, 7930.048394192705, 7749.961250193769, 7810.49231799934, 7822.374210063182, 7863.724769633035, 7872.448928575002, 7653.15815260321, 7778.416618753616, 7815.687372505093, 7827.6868925242925, 7865.095514015904, 36964.44553331702, 37086.629133708586, 37248.627513725056, 37435.625643743486, 37491.8125409374, 2924.6490421149388, 3147.013629741969, 3327.4212485323824, 3760.9623903761158, 3796.3735983562956, 29109.272268193465, 29460.0, 30176.547351789523, 30487.847560762275, 30603.540946885816, 3056.2512184514712, 3134.7022032907066, 3188.681131886816, 3192.696693814084, 3218.951715724266, 234081.0, 237738.0, 238592.0, 238944.0, 239861.0, 31254.843725781226, 54767.72616136894, 55117.44882551123, 55333.170002449995, 55428.44571554233, 32466.513002304986, 32556.186095347333, 32752.34495310128, 32812.83593582017, 32815.0, 12420.441080151415, 12723.491060357483, 12746.36268186587, 12751.59732429432, 12775.488980440865, 10328.896711032794, 10362.948185259176, 10389.753229612345, 10401.115905147995, 10427.11369533583, 8127.431079824474, 8170.7957301067945, 8191.262786349138, 8236.958815205886, 8372.665093396317, 3228.7255583275214, 3285.0801775502896, 3308.470644696837, 3321.6678332167075, 3324.850381732828, 865.6321063547967, 974.6783561424713, 987.3434166279344, 998.1615443027891, 1007.1791489935679, 25613.23160305194, 25815.741842581334, 26406.73593264081, 26779.464410711676, 27049.594256086173, 931.5156118818177, 987.8814542254831, 998.0418797953901, 1003.4380746781826, 1033.2302434686208, 13598.252096134807, 13808.447662093404, 14421.92789036069, 14459.349329280207, 14475.131492110297, 364474.0, 369086.0, 371960.0, 374139.0, 375090.0, 49320.75339623279, 50216.0, 50262.24606630903, 50310.49689503131, 50560.49439505632, 1219.8353222314875, 1252.6762854904205, 1253.160382543698, 1264.6648638110908, 1270.790319597256, 26784.866075669495, 27405.45189096167, 28049.71950280471, 28106.156815295573, 28233.0, 41578.79210603928, 42003.57996419997, 42152.36771448492, 42457.1508569833, 42468.0, 325682.0, 325720.0, 327616.0, 329036.0, 330017.0, 25978.35054123662, 26308.947642094867, 26552.336191594593, 37446.438303424926, 38684.0, 41877.58122418859, 41982.370264445446, 42467.3629895558, 42612.57387426086, 43384.0, 36260.63739362573, 36267.45598815967, 36479.635203648686, 36545.269094617426, 36563.26873462569, 35635.643643563235, 36023.27953440969, 36111.45832812563, 36271.63728362683, 36323.45514817333, 28555.857220713762, 33095.66904330926, 33231.169220769676, 35009.0, 36121.63878361288, 31713.841430792698, 32890.40329250709, 33258.33483330272, 33288.33423331568, 33470.0, 25274.873625631753, 25282.747172528776, 25402.0, 25479.726013699612, 25496.745032549436], "value": 16485.057996691867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.2775135615296, 381.2223064947506, 383.1666126175569, 386.3007955600362, 392.7878945369497, 15877.297814627662, 16594.58513537159, 17016.0, 17016.149192540386, 17034.74447883283, 11319.547218111265, 15973.440929567467, 16645.83354166461, 16691.08199049052, 16733.330666773345, 4733.621310295177, 4856.271559266121, 4883.536064073925, 4886.413630364344, 4893.339399181118, 3507.140750516114, 5423.538999185074, 5654.6041777075625, 5668.348139963895, 5711.514521265697, 5663.745131469073, 5693.117566777156, 5704.286964129484, 5708.286464191976, 5808.332041815203, 6046.3349031606485, 6071.635701857903, 6080.0575910733905, 6181.969090154543, 6191.876162476748, 5356.223347614613, 5458.5087342139, 5533.142362933751, 5551.2228288039705, 5558.277423934903, 12719.682007949876, 12760.0, 12800.231986080866, 12846.678833029155, 17187.3984410545, 1888.5373083594607, 1964.764228292614, 2003.3388981636026, 2153.956920861574, 2383.927232745254, 9529.904700952971, 9795.461249631267, 9849.704508864745, 9928.95035524825, 10408.271421000532, 1726.3698749956302, 1759.832815882489, 1797.8471829894474, 1859.9721004184948, 1887.3677318098453, 71072.2892771076, 74866.25133748648, 75185.62407187984, 75499.62250188769, 76525.61737191334, 10198.949005255075, 10262.846057309147, 10442.321249118935, 10459.738506537245, 10544.156467482582, 14349.210793406462, 14434.927825360806, 14589.489367872286, 14615.0, 14653.853461465462, 7141.428685705131, 7256.818579535554, 7351.522151060164, 7410.0, 7440.627968601549, 6774.220964589037, 6823.454123670094, 6930.965345173343, 6964.965175174193, 7007.089078419875, 4288.785560721952, 4482.901689086129, 4524.014150660548, 4604.976975115103, 4607.0, 1702.4807433732583, 1806.6386722655523, 1911.8470522358177, 1914.9904250478937, 1918.7933876042384, 921.235374639048, 937.9155875971059, 969.970900872975, 983.7688143286322, 998.4558415663481, 15610.843891561166, 16251.674966500605, 16321.83678163227, 16647.16764161787, 16836.57908552296, 863.7408777366765, 881.1716986033108, 884.9601767920459, 897.2597606974273, 914.6615752171739, 9140.680076197434, 9175.174234318943, 9208.953955230316, 9345.252379809599, 9394.201492873046, 402964.0, 406608.0, 414572.0, 416670.0, 426441.0, 82900.0, 83992.0, 86028.56985715032, 86917.13082869217, 87465.1253487457, 982.5234761140841, 983.439439519467, 989.9505024748589, 999.5002498750624, 1009.0666133826181, 14682.853171468149, 14770.227572691347, 14797.0, 15192.848071519586, 15501.509142158608, 34839.47740783941, 35445.29109417849, 35900.0, 36710.8164459176, 37278.0, 46315.3052704203, 48661.5133848657, 49183.50816491789, 49517.257241140695, 50043.249351260485, 7594.974558828783, 7642.197569255148, 7740.651670674721, 7856.0, 7865.3314468268545, 11091.72270693239, 11446.542138314375, 11460.656180314603, 11473.713157171138, 11482.36846973391, 9496.43021418717, 9707.951460242653, 9740.805183896424, 9847.556859941176, 10143.0, 9949.900500994898, 10032.548535315782, 10076.647317343857, 10370.896291036994, 10404.0, 10203.540840662337, 10304.742381440525, 10330.535125919201, 10336.276460647683, 10408.323458975143, 7727.574983375968, 7822.335101516434, 7966.243206895336, 8032.759017229492, 8036.397270204641, 8627.22354988054, 9755.902440975784, 9791.314607977658, 9856.753581160528, 10070.395776253448], "value": 8243.743547768132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.8370637376702, 1467.3103641288596, 1587.6030992251938, 1778.0, 1779.87540872139, 6790.253072162071, 7153.570785752859, 7354.669039893204, 7494.5503269803785, 7495.512791668538, 7391.0761154855645, 7463.2163622819635, 7469.47713660044, 7500.887486687704, 7520.736774212904, 2177.1182671018264, 2204.603171429142, 2210.9778902211015, 2215.3575463115676, 2223.5997520446313, 2164.7618761936174, 2206.0293470872766, 2207.7792220777956, 2223.377454312787, 2225.899834507451, 2190.912363505458, 2205.71325727656, 2209.5139069404786, 2221.6334304839684, 2272.5682120397155, 2136.3377353020614, 2145.6566949288117, 2148.6132496150685, 2150.967735483969, 2156.6657168138963, 2149.7420309562795, 2176.260071575656, 2183.912643494258, 2185.4427121084022, 2195.4401627585025, 7619.657115429819, 7663.808404789869, 7694.846103077963, 7697.076350837935, 7705.190954949706, 4427.601515863587, 4581.633469322446, 4601.309803529464, 4626.606738427237, 4629.467611224719, 2688.6101515280175, 2725.5775354819834, 2742.8765705543296, 2745.8489783061923, 2924.1958461423064, 923.7090316550265, 940.4028441939349, 980.1374790184664, 991.7421470417671, 1015.3704703084061, 10621.0, 10649.946750266277, 10674.573017079307, 10702.090322322612, 10718.839217411745, 4250.852269887175, 4272.316429371285, 4346.891327716832, 4386.320120381346, 4395.1868904252815, 9164.0, 9168.358214925025, 9168.808054952813, 9177.954110229406, 9221.49281789508, 4694.037722266927, 4711.7879695413785, 4717.410323709536, 4719.646026547954, 4725.07860967115, 3664.4320130379833, 4065.776382299002, 4172.332426811696, 4204.159168166318, 4268.658507319407, 3630.2013557017412, 3633.709303255786, 3666.368466032643, 3679.8528058877346, 3768.9434658480145, 1211.4730092409654, 1214.4595654933646, 1220.2190598017276, 1220.353212797219, 1228.4410593180082, 863.2705363967438, 885.4465958775766, 886.7206829848577, 886.8625363068735, 891.9286457083417, 5190.11767999441, 5397.892042159135, 5448.128299472065, 5479.287692599936, 5575.4424557543925, 868.3227082875368, 884.56214173983, 917.3853518142861, 929.4934260827865, 929.9581518831534, 3707.9814600926825, 3709.1839795245005, 3735.8792362291206, 3794.29805485986, 3825.273198092409, 9280.535973201448, 9550.474723890115, 9707.271954603291, 9709.465979371202, 9760.560774765152, 9435.29235307341, 9483.90516094844, 9520.143187113194, 9601.32790704644, 9635.22918166545, 7307.963460182665, 7348.0, 7365.889511657329, 7449.0, 7488.850222995618, 5306.25712400272, 5315.893682126413, 5344.331958505187, 5368.382635996911, 5370.113931201308, 8788.560571971504, 8827.16141966512, 9116.270698343984, 9118.40730352525, 9163.312751543794, 8950.82098358016, 9079.68221112258, 9103.954480227556, 9179.862302065341, 9323.160915517636, 5753.884922301447, 6149.446549810538, 6256.311805701278, 6954.687039083152, 7330.047093877762, 7317.853642927218, 7389.371903388273, 7410.333070023724, 7430.591317477591, 7474.215207403362, 6633.800985970429, 6656.101426307387, 6716.059751634677, 6755.898661519983, 6846.554973926679, 6459.838504037249, 6684.131062961784, 6696.7656132035145, 6700.765473208415, 6718.294579069127, 6389.648569328731, 6459.61242325462, 6529.0, 6547.607143571401, 6571.34286571339, 4473.619742321809, 4601.355810186644, 4630.560096790799, 4686.343911852412, 4737.407824021997, 4640.118377508263, 4706.647001474971, 4713.31656909753, 4791.161546729239, 4821.831235906727], "value": 4176.917818715353, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.6413699765776, 313.8164173958234, 316.48729058924545, 318.1632307032504, 318.51585589903357, 4821.517848215177, 4853.514648535145, 4906.950930490694, 5019.322391477154, 5032.345795046644, 4909.9754501227535, 4969.304297398358, 4978.278149668296, 4979.576735977446, 4989.850304490862, 3941.0935484838506, 3942.7240093193486, 3981.2037592481474, 3983.088117703504, 4000.3399439092514, 3728.4780130781714, 3963.7819919904396, 3965.484487016698, 3986.840526378956, 3998.1803730235233, 3845.250176215639, 3864.14988702485, 3875.8255878485534, 3876.1472476055224, 3891.0, 3869.555001174873, 3873.0247573737315, 3877.689784817208, 3898.9805050974564, 3901.0442441601704, 3473.166440054394, 3482.9825850870584, 3487.7209823214334, 3488.197714525648, 3489.1277180704824, 4539.409876716006, 4738.763061846894, 4740.265258884879, 4756.549252477993, 4778.617710583145, 4410.426644536222, 4412.691111622188, 4438.400815889878, 4438.511763705989, 4445.488768791598, 5127.769250383742, 5165.354330708661, 5165.612579056548, 5168.715720635363, 5175.404828444739, 3655.817209139559, 3745.7077308328585, 3748.6813620842263, 3767.1900541383734, 3779.79211143387, 5408.5402740766685, 5461.617686761889, 5478.616496845222, 5479.424660410639, 5481.835544933659, 3910.296146693566, 3911.6283953024417, 3911.7066220033043, 3922.9215415692097, 3923.2153569286256, 3945.82243799024, 3958.9010274743364, 3963.900902477461, 3964.4053391991433, 3972.940405893914, 4332.653387728974, 4429.202743506135, 4432.578905004019, 4441.400410944481, 4441.955580444219, 5114.43741188469, 5177.301064356339, 5199.870003249874, 5251.474852514794, 5251.553617942518, 1342.6441992871896, 1401.614555997109, 1443.8917081218951, 1447.3920953199681, 1451.361400983564, 976.4873441443157, 977.9315447918719, 985.4333758089127, 997.3317877022413, 1001.8246806808779, 4737.620990320766, 4741.980474198064, 4769.427668679711, 4778.665493415497, 4786.16242157621, 5631.549476041907, 5643.7742490299925, 5648.011597970339, 5651.547876169897, 5658.349289831722, 4628.907421851544, 4762.357081793983, 4800.687955282895, 4801.639877009238, 4806.519348065165, 2986.148947549981, 3000.7599392048583, 3014.668386477486, 3044.1324222596454, 3052.236940764809, 5226.367674466285, 5271.3674359076385, 5301.54936830366, 5310.4424035476495, 5327.174287985368, 5635.746391412396, 5806.706350991335, 5827.969455882917, 5833.941660583425, 5838.824835254949, 5285.841424757264, 5324.227986941872, 5338.839834804962, 5344.652597581145, 5367.1680889462195, 5518.448155184449, 5697.803461273179, 5705.7147142643535, 5709.20071190042, 5736.254286942671, 5547.916781248204, 5559.16612508127, 5573.54763903881, 5587.0388693992245, 5590.692511911884, 5275.261463395051, 5282.418933917189, 5287.814926477555, 5292.285541451854, 5320.973395133, 3589.9282014360087, 4001.2197621463533, 4011.0, 4018.5579586244903, 4023.5574086851007, 5079.314292570456, 5157.0, 5311.601629877698, 5375.871067075958, 5401.838604700009, 5157.0, 5198.714070725995, 5201.219817027476, 5229.555487783429, 5233.685978841282, 5162.838361368662, 5187.170052791686, 5188.195829646411, 5200.97399513, 5216.686998780086, 4895.461499235153, 5137.8715532112, 5156.819511317086, 5166.819161329336, 5212.192110222922, 5226.947730522798, 5283.169701966198, 5302.946970530245, 5322.973385133049, 5339.012282727708, 5151.5363617274625, 5151.896962060813, 5175.301334319969, 5207.92188117171, 5216.40011398694], "value": 4021.107585063614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.6505439481089, 654.1071437487831, 678.2505331608576, 706.6224737749642, 709.4466316273308, 11365.829512557319, 11448.0, 11466.770664586713, 11736.53053877845, 12066.57766978157, 12891.290978996174, 12923.289219092947, 12955.481780728784, 13060.281684507348, 13081.084324097317, 630.1304200203735, 788.6135793461192, 799.7161007842219, 807.4065561812064, 808.2079562029215, 804.4891493901356, 805.629410471184, 807.3984881263438, 808.3573559020592, 808.6724876425058, 843.0641987393988, 843.5191940593865, 843.7679638099511, 844.0293662288386, 844.8817165596821, 839.202757380491, 839.2530647723531, 839.7061028639988, 840.0591337701813, 842.9578521073922, 612.6722203621041, 619.0590302739855, 619.0961196652892, 621.7481919822479, 626.0234034905562, 12710.555130570385, 12748.235105893677, 12765.680857978625, 12767.170133941265, 12806.42371093303, 11541.192116551845, 11683.941580292128, 11729.941350293278, 11934.522619095225, 12261.386930653433, 9869.407835529892, 9888.159506441889, 9999.600015999351, 10085.89914100857, 10103.040211179927, 3141.2618034761813, 3187.984060079708, 3195.536647186145, 3239.1416274687226, 3244.610646722385, 46897.531024689655, 47120.52879471196, 47535.5246447538, 47608.52391476076, 47613.28580071302, 9040.231580315747, 9092.8636070459, 9198.264138868875, 9232.538373081454, 9242.214411775074, 16562.420315288906, 16730.4144354947, 16745.497635070966, 16753.32986680519, 16796.0, 6419.51853610981, 6479.384458476531, 6553.705083271264, 6693.631850248283, 6730.697118629673, 3628.3650361186687, 3629.219717760694, 3680.190358121209, 3686.6681998619715, 3835.4822099016833, 2771.196353057631, 2863.7852161088003, 2864.1550742530585, 2865.799394042397, 2866.512692842222, 508.45087305709745, 508.80919655129327, 516.9095408303532, 524.5146004798095, 530.7611574791359, 515.9226116082617, 520.5575261028096, 571.3201290464334, 575.453319346614, 594.0346936228628, 7585.544867307979, 7672.462927595015, 7836.098848632366, 7982.481138725964, 8048.195180481905, 509.3124282219049, 624.5128799536369, 625.7090452939404, 628.9371062893674, 629.568745409396, 3657.7988210648136, 3733.3280009598534, 3844.557875844258, 3917.2557214129224, 3945.8618948337244, 49680.0, 50491.0, 51616.48383516192, 51908.0, 53215.20177197345, 47541.5245847544, 48270.0, 48433.273500897514, 49765.50234497681, 50461.747691261306, 43128.137437251076, 43793.56206437895, 44861.0, 44973.0, 45969.77015114903, 7208.387287080657, 7230.457715671451, 7292.890606640798, 7305.744298949511, 7416.888746668912, 29962.850185749805, 30663.540046898866, 30888.53667194949, 31095.067147985596, 31497.8425107873, 37492.250154997295, 39398.409023865235, 39848.40227396534, 39991.80004099961, 40468.1906361877, 9160.541972901196, 9291.907080929375, 9550.044995500395, 10120.332613736331, 10491.318064325795, 11063.0, 11676.357800321064, 11683.299002059903, 11846.52613895469, 12158.696032599255, 10538.81859475796, 10825.13398928068, 11078.169137314573, 11485.0, 11534.307941523535, 10195.235357348376, 10292.639757608747, 10385.546023556557, 10692.411917344622, 10751.838722419327, 10800.513976870903, 10966.287191332538, 10990.560377584807, 11156.49795759209, 11297.71755706114, 9234.398307142545, 9437.528123593656, 9452.669156579486, 9529.14237718581, 9723.222142228464, 8977.899862654514, 9222.861657075284, 9247.630094796134, 9352.906470935204, 9367.016463271259], "value": 5861.174119492129, "unit": "score"}], "name": "dromaeo_css", "value": 6287.480814543841, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 111.0, 117.0, 114.0, 115.0, 126.0, 114.0, 114.0, 114.0, 113.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 132.0, 163.0, 183.0, 131.0, 165.0, 157.0, 134.0, 196.0, 136.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 173.0, 169.0, 161.0, 163.0, 165.0, 163.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 170.0, 76.0, 77.0, 74.0, 75.0, 153.0, 78.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 135.0, 93.0, 94.0, 95.0, 142.0, 93.0, 95.0, 139.0], "value": 107.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 119.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 64.0, 65.0, 63.0, 65.0, 90.0, 63.0, 64.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 67.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 81.0, 88.0, 82.0, 82.0, 80.0, 81.0, 82.0, 80.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 133.0, 133.0, 137.0, 134.0, 127.0, 137.0, 163.0, 136.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 186.0, 183.0, 175.0, 177.0, 178.0, 175.0, 172.0, 185.0, 177.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 70.0, 71.0, 71.0, 74.0, 71.0, 71.0, 71.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1599.3, "alertThreshold": 2.0}]} 05:44:46 INFO - Return code: 0 05:44:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:44:46 ERROR - # TBPL SUCCESS # 05:44:46 INFO - Running post-action listener: _resource_record_post_action 05:44:46 INFO - Running post-run listener: _resource_record_post_run 05:44:47 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7798784; Write bytes: 418721792; Read time: 2352; Write time: 442628 05:44:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7196672; Read time: 0; Write time: 5212 05:44:47 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 6037504; Write bytes: 364662784; Read time: 2296; Write time: 403104 05:44:47 INFO - Running post-run listener: _upload_blobber_files 05:44:47 INFO - Blob upload gear active. 05:44:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:44:47 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 05:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:44:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:44:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:44:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:44:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:48 INFO - (blobuploader) - INFO - Done attempting. 05:44:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:44:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:44:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:49 INFO - (blobuploader) - INFO - Done attempting. 05:44:49 INFO - (blobuploader) - INFO - Iteration through files over. 05:44:49 INFO - Return code: 0 05:44:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:44:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:44:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60d19fe943c22a2d614d0e1e8ea5f5d445e87aab7fea5b2cdbb556eacbfe36a84cc99417de1f5a500b8be4027cb21466b2dfe329833f5e458bd224a504dc8054", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2585dd2aeadfa09715e5e4901916e5cdcd9a843c68cc99f22f851e19a67451167030bb1d5149aa60688bdce09416d4ddc18f9845b2b3e3967aa769575b961b8c"} 05:44:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:44:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:44:49 INFO - Contents: 05:44:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60d19fe943c22a2d614d0e1e8ea5f5d445e87aab7fea5b2cdbb556eacbfe36a84cc99417de1f5a500b8be4027cb21466b2dfe329833f5e458bd224a504dc8054", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2585dd2aeadfa09715e5e4901916e5cdcd9a843c68cc99f22f851e19a67451167030bb1d5149aa60688bdce09416d4ddc18f9845b2b3e3967aa769575b961b8c"} 05:44:49 INFO - Running post-run listener: copy_logs_to_upload_dir 05:44:49 INFO - Copying logs to upload dir... 05:44:49 INFO - mkdir: /builds/slave/test/build/upload/logs 05:44:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.220829 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-29 05:44:49.482972) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 05:44:49.486156) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60d19fe943c22a2d614d0e1e8ea5f5d445e87aab7fea5b2cdbb556eacbfe36a84cc99417de1f5a500b8be4027cb21466b2dfe329833f5e458bd224a504dc8054", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2585dd2aeadfa09715e5e4901916e5cdcd9a843c68cc99f22f851e19a67451167030bb1d5149aa60688bdce09416d4ddc18f9845b2b3e3967aa769575b961b8c"} build_url:https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/U2Bms0KpQ8CPv6tgDo8gyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60d19fe943c22a2d614d0e1e8ea5f5d445e87aab7fea5b2cdbb556eacbfe36a84cc99417de1f5a500b8be4027cb21466b2dfe329833f5e458bd224a504dc8054", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2585dd2aeadfa09715e5e4901916e5cdcd9a843c68cc99f22f851e19a67451167030bb1d5149aa60688bdce09416d4ddc18f9845b2b3e3967aa769575b961b8c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 05:44:49.510961) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:44:49.511317) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1461916598.990378-693732936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:44:49.594296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 05:44:49.594707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 05:44:49.595092) ========= ========= Total master_lag: 0.18 =========