builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1462800286.17 results: success (0) buildid: 20160509005049 builduid: 41dbd660830c4270b4520649f25740b3 revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:46.174922) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:46.175352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:46.175639) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:46.192089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:46.192346) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 06:24:46-- 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% 83.0M=0s 2016-05-09 06:24:46 (83.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102106 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:46.308431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:46.308750) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013564 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:46.358194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:24:46.358546) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --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=a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:24:46,381 truncating revision to first 12 chars 2016-05-09 06:24:46,381 Setting DEBUG logging. 2016-05-09 06:24:46,381 attempt 1/10 2016-05-09 06:24:46,381 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307b5eca8726?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 06:24:47,658 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=1.549273 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:24:47.920156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:47.920483) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:47.920857) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:47.921119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:24:47.930112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-09 06:24:47.930463) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:24:48 INFO - MultiFileLogger online at 20160509 06:24:48 in /builds/slave/test 06:24:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:24:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:48 INFO - {'append_to_log': False, 06:24:48 INFO - 'base_work_dir': '/builds/slave/test', 06:24:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:24:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:48 INFO - 'branch': 'Mozilla-Aurora', 06:24:48 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:48 INFO - 'config_files': ('talos/linux_config.py',), 06:24:48 INFO - 'default_actions': ('clobber', 06:24:48 INFO - 'read-buildbot-config', 06:24:48 INFO - 'download-and-extract', 06:24:48 INFO - 'populate-webroot', 06:24:48 INFO - 'create-virtualenv', 06:24:48 INFO - 'install', 06:24:48 INFO - 'run-tests'), 06:24:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:48 INFO - 'download_minidump_stackwalk': True, 06:24:48 INFO - 'download_symbols': 'ondemand', 06:24:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:48 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:48 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:48 INFO - 'installer_path': 'installer.exe', 06:24:48 INFO - 'log_level': 'info', 06:24:48 INFO - 'log_name': 'talos', 06:24:48 INFO - 'log_to_console': True, 06:24:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:24:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:24:48 INFO - 'opt_config_files': (), 06:24:48 INFO - 'pip_index': False, 06:24:48 INFO - 'sps_profile': False, 06:24:48 INFO - 'sps_profile_interval': 0, 06:24:48 INFO - 'suite': 'dromaeojs-e10s', 06:24:48 INFO - 'system_bits': '32', 06:24:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:48 INFO - 'title': 'talos-linux64-ix-062', 06:24:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:48 INFO - 'use_talos_json': True, 06:24:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:48 INFO - 'work_dir': 'build'} 06:24:48 INFO - ##### 06:24:48 INFO - ##### Running clobber step. 06:24:48 INFO - ##### 06:24:48 INFO - Running pre-action listener: _resource_record_pre_action 06:24:48 INFO - Running main action method: clobber 06:24:48 INFO - rmtree: /builds/slave/test/build 06:24:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:48 INFO - Running post-action listener: _resource_record_post_action 06:24:48 INFO - ##### 06:24:48 INFO - ##### Running read-buildbot-config step. 06:24:48 INFO - ##### 06:24:48 INFO - Running pre-action listener: _resource_record_pre_action 06:24:48 INFO - Running main action method: read_buildbot_config 06:24:48 INFO - Using buildbot properties: 06:24:48 INFO - { 06:24:48 INFO - "project": "", 06:24:48 INFO - "product": "firefox", 06:24:48 INFO - "script_repo_revision": "production", 06:24:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:24:48 INFO - "repository": "", 06:24:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:24:48 INFO - "buildid": "20160509005049", 06:24:48 INFO - "pgo_build": "True", 06:24:48 INFO - "basedir": "/builds/slave/test", 06:24:48 INFO - "buildnumber": 303, 06:24:48 INFO - "slavename": "talos-linux64-ix-062", 06:24:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:24:48 INFO - "platform": "ubuntu64_hw", 06:24:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:24:48 INFO - "branch": "mozilla-aurora", 06:24:48 INFO - "repo_path": "releases/mozilla-aurora", 06:24:48 INFO - "revision": "307b5eca8726f6a72a1d69ba76630a6dbf402477", 06:24:48 INFO - "stage_platform": "linux64-pgo", 06:24:48 INFO - "builduid": "41dbd660830c4270b4520649f25740b3", 06:24:48 INFO - "slavebuilddir": "test" 06:24:48 INFO - } 06:24:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 06:24:48 INFO - Running post-action listener: _resource_record_post_action 06:24:48 INFO - ##### 06:24:48 INFO - ##### Running download-and-extract step. 06:24:48 INFO - ##### 06:24:48 INFO - Running pre-action listener: _resource_record_pre_action 06:24:48 INFO - Running main action method: download_and_extract 06:24:48 INFO - mkdir: /builds/slave/test/build/tests 06:24:48 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')]} 06:24:48 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:24:49 INFO - Downloaded 1361 bytes. 06:24:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:24:49 INFO - Using the following test package requirements: 06:24:49 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:24:49 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:24:49 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:24:49 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:49 INFO - u'jsshell-linux-x86_64.zip'], 06:24:49 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:24:49 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:24:49 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:24:49 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:24:49 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:24:49 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:24:49 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:49 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:24:50 INFO - Downloaded 23798585 bytes. 06:24:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:24:51 INFO - Return code: 0 06:24:51 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:51 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:24:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:24:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:24:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:24:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:24:53 INFO - Downloaded 23798585 bytes. 06:24:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:24:54 INFO - Return code: 0 06:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:54 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:24:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:24:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:24:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:24:55 INFO - Downloaded 10840145 bytes. 06:24:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:24:56 INFO - Return code: 0 06:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:56 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:24:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:24:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:24:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:24:57 INFO - Downloaded 62704189 bytes. 06:24:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:24:57 INFO - mkdir: /builds/slave/test/properties 06:24:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:24:57 INFO - Writing to file /builds/slave/test/properties/build_url 06:24:57 INFO - Contents: 06:24:57 INFO - build_url:https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:24:58 INFO - Running post-action listener: _resource_record_post_action 06:24:58 INFO - Running post-action listener: set_extra_try_arguments 06:24:58 INFO - ##### 06:24:58 INFO - ##### Running populate-webroot step. 06:24:58 INFO - ##### 06:24:58 INFO - Running pre-action listener: _resource_record_pre_action 06:24:58 INFO - Running main action method: populate_webroot 06:24:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:24:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:24:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:24:58 INFO - '--tppagecycles', 06:24:58 INFO - '7'], 06:24:58 INFO - 'tests': ['tsvgm']}}, 06:24:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:24:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:24:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:24:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:24:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:24:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:24:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:58 INFO - 'talos_options': ['--disable-e10s'], 06:24:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:58 INFO - 'talos_options': ['--disable-e10s'], 06:24:58 INFO - 'tests': ['damp', 'tps']}, 06:24:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:58 INFO - 'tests': ['damp', 'tps']}, 06:24:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:24:58 INFO - 'tests': ['dromaeo_dom']}, 06:24:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:24:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:24:58 INFO - 'tests': ['a11yr', 06:24:58 INFO - 'ts_paint', 06:24:58 INFO - 'tpaint', 06:24:58 INFO - 'sessionrestore', 06:24:58 INFO - 'sessionrestore_no_auto_restore', 06:24:58 INFO - 'tabpaint']}, 06:24:58 INFO - 'other-e10s': {'tests': ['a11yr', 06:24:58 INFO - 'ts_paint', 06:24:58 INFO - 'tpaint', 06:24:58 INFO - 'sessionrestore', 06:24:58 INFO - 'sessionrestore_no_auto_restore', 06:24:58 INFO - 'tabpaint']}, 06:24:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:24:58 INFO - 'ts_paint', 06:24:58 INFO - 'tpaint', 06:24:58 INFO - 'sessionrestore', 06:24:58 INFO - 'sessionrestore_no_auto_restore', 06:24:58 INFO - 'tabpaint']}, 06:24:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:24:58 INFO - 'ts_paint', 06:24:58 INFO - 'tpaint', 06:24:58 INFO - 'sessionrestore', 06:24:58 INFO - 'sessionrestore_no_auto_restore', 06:24:58 INFO - 'tabpaint']}, 06:24:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:24:58 INFO - 'tests': ['a11yr', 06:24:58 INFO - 'ts_paint', 06:24:58 INFO - 'tpaint', 06:24:58 INFO - 'sessionrestore', 06:24:58 INFO - 'sessionrestore_no_auto_restore', 06:24:58 INFO - 'tabpaint']}, 06:24:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:24:58 INFO - 'tests': ['a11yr', 06:24:58 INFO - 'ts_paint', 06:24:58 INFO - 'tpaint', 06:24:58 INFO - 'sessionrestore', 06:24:58 INFO - 'sessionrestore_no_auto_restore', 06:24:58 INFO - 'tabpaint']}, 06:24:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:24:58 INFO - 'tests': ['tsvgx', 06:24:58 INFO - 'tsvgr_opacity', 06:24:58 INFO - 'tart', 06:24:58 INFO - 'tscrollx', 06:24:58 INFO - 'cart']}, 06:24:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:24:58 INFO - 'tsvgr_opacity', 06:24:58 INFO - 'tart', 06:24:58 INFO - 'tscrollx', 06:24:58 INFO - 'cart']}, 06:24:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:58 INFO - 'talos_options': ['--disable-e10s'], 06:24:58 INFO - 'tests': ['tp5o']}, 06:24:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:58 INFO - 'tests': ['tp5o']}, 06:24:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:58 INFO - 'talos_options': ['--disable-e10s', 06:24:58 INFO - '--xperf_path', 06:24:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:58 INFO - 'tests': ['tp5n']}, 06:24:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:58 INFO - 'talos_options': ['--xperf_path', 06:24:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:58 INFO - 'tests': ['tp5n']}}, 06:24:58 INFO - 'talos.zip': {'path': '', 06:24:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:24:58 INFO - Running post-action listener: _resource_record_post_action 06:24:58 INFO - ##### 06:24:58 INFO - ##### Running create-virtualenv step. 06:24:58 INFO - ##### 06:24:58 INFO - Running pre-action listener: _resource_record_pre_action 06:24:58 INFO - Running main action method: create_virtualenv 06:24:58 INFO - Creating virtualenv /builds/slave/test/build/venv 06:24:58 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 06:24:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:24:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:24:58 INFO - Using real prefix '/usr' 06:24:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:24:58 INFO - Installing distribute.............................................................................................................................................................................................done. 06:25:00 INFO - Installing pip.................done. 06:25:00 INFO - Return code: 0 06:25:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:00 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 0x7fa3dd658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd410>, '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 0x19be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19be7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', '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 06:25:00 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 06:25:00 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 06:25:00 INFO - Using env: {'DISPLAY': ':0', 06:25:00 INFO - 'HOME': '/home/cltbld', 06:25:00 INFO - 'LANG': 'en_US.UTF-8', 06:25:00 INFO - 'LANGUAGE': 'en_US:en', 06:25:00 INFO - 'LOGNAME': 'cltbld', 06:25:00 INFO - 'MAIL': '/var/mail/cltbld', 06:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:00 INFO - 'MOZ_NO_REMOTE': '1', 06:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:00 INFO - 'NO_EM_RESTART': '1', 06:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:00 INFO - 'PWD': '/builds/slave/test', 06:25:00 INFO - 'SHELL': '/bin/bash', 06:25:00 INFO - 'SHLVL': '1', 06:25:00 INFO - 'TERM': 'linux', 06:25:00 INFO - 'TMOUT': '86400', 06:25:00 INFO - 'USER': 'cltbld', 06:25:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', 06:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:00 INFO - '_': '/tools/buildbot/bin/python'} 06:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:01 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 06:25:01 INFO - Cleaning up... 06:25:01 INFO - Return code: 0 06:25:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06: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')]} 06:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:01 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 0x7fa3dd658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd410>, '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 0x19be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19be7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', '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 06:25:01 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 06:25:01 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 06:25:01 INFO - Using env: {'DISPLAY': ':0', 06:25:01 INFO - 'HOME': '/home/cltbld', 06:25:01 INFO - 'LANG': 'en_US.UTF-8', 06:25:01 INFO - 'LANGUAGE': 'en_US:en', 06:25:01 INFO - 'LOGNAME': 'cltbld', 06:25:01 INFO - 'MAIL': '/var/mail/cltbld', 06:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:01 INFO - 'MOZ_NO_REMOTE': '1', 06:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:01 INFO - 'NO_EM_RESTART': '1', 06:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:01 INFO - 'PWD': '/builds/slave/test', 06:25:01 INFO - 'SHELL': '/bin/bash', 06:25:01 INFO - 'SHLVL': '1', 06:25:01 INFO - 'TERM': 'linux', 06:25:01 INFO - 'TMOUT': '86400', 06:25:01 INFO - 'USER': 'cltbld', 06:25:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', 06:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:01 INFO - '_': '/tools/buildbot/bin/python'} 06:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:01 INFO - Downloading/unpacking psutil>=0.7.1 06:25:01 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 06:25:01 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 06:25:01 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 06:25:01 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 06:25:01 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 06:25:01 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 06:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:25:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:03 INFO - Installing collected packages: psutil 06:25:03 INFO - Running setup.py install for psutil 06:25:03 INFO - building 'psutil._psutil_linux' extension 06:25:03 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 06:25:03 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 06:25:03 INFO - building 'psutil._psutil_posix' extension 06:25:03 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 06:25:03 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 06:25:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:04 INFO - Successfully installed psutil 06:25:04 INFO - Cleaning up... 06:25:04 INFO - Return code: 0 06:25:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:25:04 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')]} 06:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:04 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')]} 06:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:04 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 0x7fa3dd658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd410>, '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 0x19be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19be7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', '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 06:25:04 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 06:25:04 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 06:25:04 INFO - Using env: {'DISPLAY': ':0', 06:25:04 INFO - 'HOME': '/home/cltbld', 06:25:04 INFO - 'LANG': 'en_US.UTF-8', 06:25:04 INFO - 'LANGUAGE': 'en_US:en', 06:25:04 INFO - 'LOGNAME': 'cltbld', 06:25:04 INFO - 'MAIL': '/var/mail/cltbld', 06:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:04 INFO - 'MOZ_NO_REMOTE': '1', 06:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:04 INFO - 'NO_EM_RESTART': '1', 06:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:04 INFO - 'PWD': '/builds/slave/test', 06:25:04 INFO - 'SHELL': '/bin/bash', 06:25:04 INFO - 'SHLVL': '1', 06:25:04 INFO - 'TERM': 'linux', 06:25:04 INFO - 'TMOUT': '86400', 06:25:04 INFO - 'USER': 'cltbld', 06:25:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', 06:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:04 INFO - '_': '/tools/buildbot/bin/python'} 06:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:25:07 INFO - Installing collected packages: mozsystemmonitor 06:25:07 INFO - Running setup.py install for mozsystemmonitor 06:25:07 INFO - Successfully installed mozsystemmonitor 06:25:07 INFO - Cleaning up... 06:25:07 INFO - Return code: 0 06:25:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:25: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')]} 06:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25: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')]} 06:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:07 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 0x7fa3dd658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd410>, '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 0x19be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19be7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', '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 06:25:07 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 06:25:07 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 06:25:07 INFO - Using env: {'DISPLAY': ':0', 06:25:07 INFO - 'HOME': '/home/cltbld', 06:25:07 INFO - 'LANG': 'en_US.UTF-8', 06:25:07 INFO - 'LANGUAGE': 'en_US:en', 06:25:07 INFO - 'LOGNAME': 'cltbld', 06:25:07 INFO - 'MAIL': '/var/mail/cltbld', 06:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:07 INFO - 'MOZ_NO_REMOTE': '1', 06:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:07 INFO - 'NO_EM_RESTART': '1', 06:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:07 INFO - 'PWD': '/builds/slave/test', 06:25:07 INFO - 'SHELL': '/bin/bash', 06:25:07 INFO - 'SHLVL': '1', 06:25:07 INFO - 'TERM': 'linux', 06:25:07 INFO - 'TMOUT': '86400', 06:25:07 INFO - 'USER': 'cltbld', 06:25:07 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', 06:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:07 INFO - '_': '/tools/buildbot/bin/python'} 06:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:07 INFO - Downloading/unpacking blobuploader==1.2.4 06:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:09 INFO - Downloading blobuploader-1.2.4.tar.gz 06:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:25:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:25:09 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 06:25:09 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 06:25:09 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 06:25:09 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 06:25:09 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 06:25:09 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 06:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:25:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:10 INFO - Downloading docopt-0.6.1.tar.gz 06:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:25:10 INFO - Installing collected packages: blobuploader, requests, docopt 06:25:10 INFO - Running setup.py install for blobuploader 06:25:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:25:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:25:10 INFO - Running setup.py install for requests 06:25:10 INFO - Running setup.py install for docopt 06:25:10 INFO - Successfully installed blobuploader requests docopt 06:25:10 INFO - Cleaning up... 06:25:10 INFO - Return code: 0 06:25:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:10 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 0x7fa3dd658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd410>, '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 0x19be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19be7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', '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 06:25:10 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 06:25:10 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 06:25:10 INFO - Using env: {'DISPLAY': ':0', 06:25:10 INFO - 'HOME': '/home/cltbld', 06:25:10 INFO - 'LANG': 'en_US.UTF-8', 06:25:10 INFO - 'LANGUAGE': 'en_US:en', 06:25:10 INFO - 'LOGNAME': 'cltbld', 06:25:10 INFO - 'MAIL': '/var/mail/cltbld', 06:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:10 INFO - 'MOZ_NO_REMOTE': '1', 06:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:10 INFO - 'NO_EM_RESTART': '1', 06:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:10 INFO - 'PWD': '/builds/slave/test', 06:25:10 INFO - 'SHELL': '/bin/bash', 06:25:10 INFO - 'SHLVL': '1', 06:25:10 INFO - 'TERM': 'linux', 06:25:10 INFO - 'TMOUT': '86400', 06:25:10 INFO - 'USER': 'cltbld', 06:25:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', 06:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:10 INFO - '_': '/tools/buildbot/bin/python'} 06:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:11 INFO - Running setup.py (path:/tmp/pip-VIwrqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:11 INFO - Running setup.py (path:/tmp/pip-LWqZb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:11 INFO - Running setup.py (path:/tmp/pip-2jtRUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:11 INFO - Running setup.py (path:/tmp/pip-qhuX53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:11 INFO - Running setup.py (path:/tmp/pip-kfQubk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:11 INFO - Running setup.py (path:/tmp/pip-lLqDxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:11 INFO - Running setup.py (path:/tmp/pip-E0SZgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:11 INFO - Running setup.py (path:/tmp/pip-FJ9E6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:11 INFO - Running setup.py (path:/tmp/pip-6rGoxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:11 INFO - Running setup.py (path:/tmp/pip-lXWQM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:11 INFO - Running setup.py (path:/tmp/pip-bZ9XGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:11 INFO - Running setup.py (path:/tmp/pip-PtCxcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:12 INFO - Running setup.py (path:/tmp/pip-UUcZW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:12 INFO - Running setup.py (path:/tmp/pip-i7T3is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:12 INFO - Running setup.py (path:/tmp/pip-EJ_I1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:12 INFO - Running setup.py (path:/tmp/pip-GcsFcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:12 INFO - Running setup.py (path:/tmp/pip-ZWJ0sM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:25:12 INFO - Running setup.py install for manifestparser 06:25:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:25:12 INFO - Running setup.py install for mozcrash 06:25:12 INFO - Running setup.py install for mozdebug 06:25:12 INFO - Running setup.py install for mozdevice 06:25:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:25:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:25:12 INFO - Running setup.py install for mozfile 06:25:12 INFO - Running setup.py install for mozhttpd 06:25:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:25:12 INFO - Running setup.py install for mozinfo 06:25:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Running setup.py install for mozInstall 06:25:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Running setup.py install for mozleak 06:25:13 INFO - Running setup.py install for mozlog 06:25:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Running setup.py install for moznetwork 06:25:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Running setup.py install for mozprocess 06:25:13 INFO - Running setup.py install for mozprofile 06:25:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Running setup.py install for mozrunner 06:25:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:25:13 INFO - Running setup.py install for mozscreenshot 06:25:13 INFO - Running setup.py install for moztest 06:25:14 INFO - Running setup.py install for mozversion 06:25:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:25:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:25:14 INFO - Cleaning up... 06:25:14 INFO - Return code: 0 06:25:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:14 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')]} 06:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:14 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')]} 06:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:14 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 0x7fa3dd658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd410>, '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 0x19be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19be7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', '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 06:25:14 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 06:25:14 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 06:25:14 INFO - Using env: {'DISPLAY': ':0', 06:25:14 INFO - 'HOME': '/home/cltbld', 06:25:14 INFO - 'LANG': 'en_US.UTF-8', 06:25:14 INFO - 'LANGUAGE': 'en_US:en', 06:25:14 INFO - 'LOGNAME': 'cltbld', 06:25:14 INFO - 'MAIL': '/var/mail/cltbld', 06:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:14 INFO - 'MOZ_NO_REMOTE': '1', 06:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:14 INFO - 'NO_EM_RESTART': '1', 06:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:14 INFO - 'PWD': '/builds/slave/test', 06:25:14 INFO - 'SHELL': '/bin/bash', 06:25:14 INFO - 'SHLVL': '1', 06:25:14 INFO - 'TERM': 'linux', 06:25:14 INFO - 'TMOUT': '86400', 06:25:14 INFO - 'USER': 'cltbld', 06:25:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', 06:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:14 INFO - '_': '/tools/buildbot/bin/python'} 06:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:14 INFO - Running setup.py (path:/tmp/pip-vVyNIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:14 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)) 06:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:14 INFO - Running setup.py (path:/tmp/pip-2UVav5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:14 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)) 06:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:14 INFO - Running setup.py (path:/tmp/pip-LbNnPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:14 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)) 06:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:14 INFO - Running setup.py (path:/tmp/pip-8oPPfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:14 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)) 06:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:14 INFO - Running setup.py (path:/tmp/pip-P2os_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:14 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)) 06:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:14 INFO - Running setup.py (path:/tmp/pip-IN7fSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:14 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)) 06:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:14 INFO - Running setup.py (path:/tmp/pip-h4FQ2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:14 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)) 06:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:14 INFO - Running setup.py (path:/tmp/pip-W1L1AL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:14 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)) 06:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:14 INFO - Running setup.py (path:/tmp/pip-vBdhUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:15 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)) 06:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:15 INFO - Running setup.py (path:/tmp/pip-YaTZQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:15 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)) 06:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:15 INFO - Running setup.py (path:/tmp/pip-VBIvRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:15 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)) 06:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:15 INFO - Running setup.py (path:/tmp/pip-joJ2Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:15 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)) 06:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:15 INFO - Running setup.py (path:/tmp/pip-Usfx8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:15 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)) 06:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:15 INFO - Running setup.py (path:/tmp/pip-4oBKiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:15 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)) 06:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:15 INFO - Running setup.py (path:/tmp/pip-5uPsXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:15 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)) 06:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:15 INFO - Running setup.py (path:/tmp/pip-MlA6or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:15 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)) 06:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:15 INFO - Running setup.py (path:/tmp/pip-Q8juF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:15 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)) 06:25:15 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)) 06:25:15 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)) 06:25:15 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)) 06:25:15 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)) 06:25:15 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)) 06:25:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:25:15 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 06:25:15 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 06:25:15 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 06:25:15 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 06:25:15 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 06:25:15 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 06:25:17 INFO - Downloading blessings-1.6.tar.gz 06:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:25:17 INFO - Installing collected packages: blessings 06:25:17 INFO - Running setup.py install for blessings 06:25:17 INFO - Successfully installed blessings 06:25:17 INFO - Cleaning up... 06:25:17 INFO - Return code: 0 06:25:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:25:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:17 INFO - Reading from file tmpfile_stdout 06:25:17 INFO - Current package versions: 06:25:17 INFO - argparse == 1.2.1 06:25:17 INFO - blessings == 1.6 06:25:17 INFO - blobuploader == 1.2.4 06:25:17 INFO - docopt == 0.6.1 06:25:17 INFO - manifestparser == 1.1 06:25:17 INFO - mozInstall == 1.12 06:25:17 INFO - mozcrash == 0.17 06:25:17 INFO - mozdebug == 0.1 06:25:17 INFO - mozdevice == 0.48 06:25:17 INFO - mozfile == 1.2 06:25:17 INFO - mozhttpd == 0.7 06:25:17 INFO - mozinfo == 0.9 06:25:17 INFO - mozleak == 0.1 06:25:17 INFO - mozlog == 3.1 06:25:17 INFO - moznetwork == 0.27 06:25:17 INFO - mozprocess == 0.22 06:25:17 INFO - mozprofile == 0.28 06:25:17 INFO - mozrunner == 6.11 06:25:17 INFO - mozscreenshot == 0.1 06:25:17 INFO - mozsystemmonitor == 0.0 06:25:17 INFO - moztest == 0.7 06:25:17 INFO - mozversion == 1.4 06:25:17 INFO - psutil == 3.1.1 06:25:17 INFO - requests == 1.2.3 06:25:17 INFO - wsgiref == 0.1.2 06:25:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:17 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 0x7fa3dd658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd410>, '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 0x19be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19be7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', '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 06:25:17 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 06:25:17 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 06:25:17 INFO - Using env: {'DISPLAY': ':0', 06:25:17 INFO - 'HOME': '/home/cltbld', 06:25:17 INFO - 'LANG': 'en_US.UTF-8', 06:25:17 INFO - 'LANGUAGE': 'en_US:en', 06:25:17 INFO - 'LOGNAME': 'cltbld', 06:25:17 INFO - 'MAIL': '/var/mail/cltbld', 06:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:17 INFO - 'MOZ_NO_REMOTE': '1', 06:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:17 INFO - 'NO_EM_RESTART': '1', 06:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:17 INFO - 'PWD': '/builds/slave/test', 06:25:17 INFO - 'SHELL': '/bin/bash', 06:25:17 INFO - 'SHLVL': '1', 06:25:17 INFO - 'TERM': 'linux', 06:25:17 INFO - 'TMOUT': '86400', 06:25:17 INFO - 'USER': 'cltbld', 06:25:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', 06:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:17 INFO - '_': '/tools/buildbot/bin/python'} 06:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:18 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)) 06:25:18 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)) 06:25:18 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)) 06:25:18 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)) 06:25:18 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)) 06:25:18 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)) 06:25:18 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)) 06:25:18 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)) 06:25:18 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)) 06:25:18 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)) 06:25:18 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)) 06:25:18 INFO - Cleaning up... 06:25:18 INFO - Return code: 0 06:25:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:18 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 0x7fa3dd658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd410>, '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 0x19be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19be7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', '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 06:25:18 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 06:25:18 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 06:25:18 INFO - Using env: {'DISPLAY': ':0', 06:25:18 INFO - 'HOME': '/home/cltbld', 06:25:18 INFO - 'LANG': 'en_US.UTF-8', 06:25:18 INFO - 'LANGUAGE': 'en_US:en', 06:25:18 INFO - 'LOGNAME': 'cltbld', 06:25:18 INFO - 'MAIL': '/var/mail/cltbld', 06:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:18 INFO - 'MOZ_NO_REMOTE': '1', 06:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:18 INFO - 'NO_EM_RESTART': '1', 06:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:18 INFO - 'PWD': '/builds/slave/test', 06:25:18 INFO - 'SHELL': '/bin/bash', 06:25:18 INFO - 'SHLVL': '1', 06:25:18 INFO - 'TERM': 'linux', 06:25:18 INFO - 'TMOUT': '86400', 06:25:18 INFO - 'USER': 'cltbld', 06:25:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', 06:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:18 INFO - '_': '/tools/buildbot/bin/python'} 06:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:18 INFO - Downloading/unpacking jsonschema 06:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:25:20 INFO - Downloading/unpacking functools32 (from jsonschema) 06:25:20 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 06:25:20 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 06:25:20 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 06:25:20 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 06:25:20 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 06:25:20 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 06:25:20 INFO - Downloading functools32-3.2.3-2.tar.gz 06:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:25:20 INFO - warning: no files found matching '*.txt' 06:25:20 INFO - no previously-included directories found matching 'build' 06:25:20 INFO - no previously-included directories found matching 'dist' 06:25:20 INFO - no previously-included directories found matching '.git*' 06:25:20 INFO - Installing collected packages: jsonschema, functools32 06:25:20 INFO - Running setup.py install for functools32 06:25:20 INFO - warning: no files found matching '*.txt' 06:25:20 INFO - no previously-included directories found matching 'build' 06:25:20 INFO - no previously-included directories found matching 'dist' 06:25:20 INFO - no previously-included directories found matching '.git*' 06:25:20 INFO - Successfully installed jsonschema functools32 06:25:20 INFO - Cleaning up... 06:25:20 INFO - Return code: 0 06:25:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:25:20 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')]} 06:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:20 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')]} 06:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:20 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 0x7fa3dd658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd410>, '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 0x19be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19be7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', '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 06:25:20 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 06:25:20 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 06:25:20 INFO - Using env: {'DISPLAY': ':0', 06:25:20 INFO - 'HOME': '/home/cltbld', 06:25:20 INFO - 'LANG': 'en_US.UTF-8', 06:25:20 INFO - 'LANGUAGE': 'en_US:en', 06:25:20 INFO - 'LOGNAME': 'cltbld', 06:25:20 INFO - 'MAIL': '/var/mail/cltbld', 06:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:20 INFO - 'MOZ_NO_REMOTE': '1', 06:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:20 INFO - 'NO_EM_RESTART': '1', 06:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:20 INFO - 'PWD': '/builds/slave/test', 06:25:20 INFO - 'SHELL': '/bin/bash', 06:25:20 INFO - 'SHLVL': '1', 06:25:20 INFO - 'TERM': 'linux', 06:25:20 INFO - 'TMOUT': '86400', 06:25:20 INFO - 'USER': 'cltbld', 06:25:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', 06:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:20 INFO - '_': '/tools/buildbot/bin/python'} 06:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:20 INFO - Downloading/unpacking flake8 06:25:20 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 06:25:20 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 06:25:20 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 06:25:20 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 06:25:20 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 06:25:20 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 06:25:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:25:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:25:22 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 06:25:22 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 06:25:22 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 06:25:22 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 06:25:22 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 06:25:22 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 06:25:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:25:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:25:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:23 INFO - no previously-included directories found matching 'docs/_build' 06:25:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:25:23 INFO - Running setup.py install for pep8 06:25:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:23 INFO - no previously-included directories found matching 'docs/_build' 06:25:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:25:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:25:23 INFO - Cleaning up... 06:25:23 INFO - Return code: 0 06:25:23 INFO - Running post-action listener: _resource_record_post_action 06:25:23 INFO - Running post-action listener: _start_resource_monitoring 06:25:23 INFO - Starting resource monitoring. 06:25:23 INFO - ##### 06:25:23 INFO - ##### Running install step. 06:25:23 INFO - ##### 06:25:23 INFO - Running pre-action listener: _resource_record_pre_action 06:25:23 INFO - Running main action method: install 06:25:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:24 INFO - Reading from file tmpfile_stdout 06:25:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:25:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:25:24 INFO - Reading from file tmpfile_stdout 06:25:24 INFO - Output received: 06:25:24 INFO - Usage: mozinstall [options] installer 06:25:24 INFO - Options: 06:25:24 INFO - -h, --help show this help message and exit 06:25:24 INFO - -d DEST, --destination=DEST 06:25:24 INFO - Directory to install application into. [default: 06:25:24 INFO - "/builds/slave/test"] 06:25:24 INFO - --app=APP Application being installed. [default: firefox] 06:25:24 INFO - mkdir: /builds/slave/test/build/application 06:25:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:25:39 INFO - Reading from file tmpfile_stdout 06:25:39 INFO - Output received: 06:25:39 INFO - /builds/slave/test/build/application/firefox/firefox 06:25:39 INFO - Running post-action listener: _resource_record_post_action 06:25:39 INFO - ##### 06:25:39 INFO - ##### Running run-tests step. 06:25:39 INFO - ##### 06:25:39 INFO - Running pre-action listener: _resource_record_pre_action 06:25:39 INFO - Running main action method: run_tests 06:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:25:39 INFO - Python 2.7.3 06:25:39 INFO - Return code: 0 06:25:39 INFO - grabbing minidump binary from tooltool 06:25: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')]} 06:25:39 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 0x19bd410>, '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 0x19be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19be7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:25:39 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 06:25:39 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 06:25:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:25:39 INFO - Return code: 0 06:25:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:25:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:25:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:25:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:25:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:25:40 INFO - Return code: 0 06:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 06:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 06:25:40 INFO - Using env: {'DISPLAY': ':0', 06:25:40 INFO - 'HOME': '/home/cltbld', 06:25:40 INFO - 'LANG': 'en_US.UTF-8', 06:25:40 INFO - 'LANGUAGE': 'en_US:en', 06:25:40 INFO - 'LOGNAME': 'cltbld', 06:25:40 INFO - 'MAIL': '/var/mail/cltbld', 06:25:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:25:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:40 INFO - 'MOZ_NO_REMOTE': '1', 06:25:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:40 INFO - 'NO_EM_RESTART': '1', 06:25:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:40 INFO - 'PWD': '/builds/slave/test', 06:25:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:25:40 INFO - 'SHELL': '/bin/bash', 06:25:40 INFO - 'SHLVL': '1', 06:25:40 INFO - 'TERM': 'linux', 06:25:40 INFO - 'TMOUT': '86400', 06:25:40 INFO - 'USER': 'cltbld', 06:25:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013', 06:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:40 INFO - '_': '/tools/buildbot/bin/python'} 06:25:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 06:25:40 INFO - mozversion application_buildid: 20160509005049 06:25:40 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:25:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:25:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:25:40 INFO - mozversion application_name: Firefox 06:25:40 INFO - mozversion application_remotingname: firefox-dev 06:25:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:25:40 INFO - mozversion application_vendor: Mozilla 06:25:40 INFO - mozversion application_version: 48.0a2 06:25:40 INFO - mozversion platform_buildid: 20160509005049 06:25:40 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:25:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:25:40 INFO - mozversion platform_version: 48.0a2 06:25:40 INFO - using testdate: 1462800340 06:25:40 INFO - actual date: 1462800340 06:25:40 INFO - starting webserver on 'localhost:47327' 06:25:40 INFO - SUITE-START | Running 2 tests 06:25:40 INFO - TEST-START | dromaeo_css 06:25:40 INFO - operating with platform_type : linux_ 06:25:40 INFO - Initialising browser for dromaeo_css test... 06:25:40 INFO - TEST-INFO | started process 10741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKj3j4R/profile http://localhost:47327/getInfo.html) 06:25:44 INFO - PROCESS | 10741 | 06:25:44 INFO - PROCESS | 10741 | (process:10822): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:25:45 INFO - PROCESS | 10741 | __metrics Screen width/height:1600/1200 06:25:45 INFO - PROCESS | 10741 | colorDepth:24 06:25:45 INFO - PROCESS | 10741 | Browser inner width/height: 1024/697 06:25:45 INFO - PROCESS | 10741 | __metrics 06:25:46 ERROR - PROCESS | 10741 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:25:47 INFO - TEST-INFO | 10741: exit 0 06:25:47 INFO - Browser initialized. 06:25:47 INFO - Running cycle 1/1 for dromaeo_css test... 06:25:47 INFO - TEST-INFO | started process 10873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKj3j4R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:25:48 INFO - PROCESS | 10873 | 06:25:48 INFO - PROCESS | 10873 | (process:10939): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:25:58 INFO - PROCESS | 10873 | RSS: Main: 151990272 06:25:58 INFO - PROCESS | 10873 | 06:26:48 INFO - PROCESS | 10873 | 1462800408545 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] 06:28:56 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:47327/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47327/tests/dromaeo/cssquery-ext.html) 06:28:57 INFO - PROCESS | 10873 | RSS: Main: 156741632 06:28:57 INFO - PROCESS | 10873 | 06:31:59 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:47327/tests/dromaeo/cssquery-ext.html (next: http://localhost:47327/tests/dromaeo/cssquery-jquery.html) 06:31:59 INFO - PROCESS | 10873 | RSS: Main: 153477120 06:31:59 INFO - PROCESS | 10873 | 06:35:01 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:47327/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47327/tests/dromaeo/cssquery-mootools.html) 06:35:01 INFO - PROCESS | 10873 | RSS: Main: 153149440 06:35:01 INFO - PROCESS | 10873 | 06:38:03 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:47327/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47327/tests/dromaeo/cssquery-prototype.html) 06:38:04 INFO - PROCESS | 10873 | RSS: Main: 152965120 06:38:04 INFO - PROCESS | 10873 | 06:41:06 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:47327/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47327/tests/dromaeo/cssquery-yui.html) 06:41:07 INFO - PROCESS | 10873 | RSS: Main: 154390528 06:41:07 INFO - PROCESS | 10873 | 06:44:09 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:47327/tests/dromaeo/cssquery-yui.html (next: http://localhost:47327/tests/dromaeo/cssquery-dojo.html) 06:44:09 INFO - PROCESS | 10873 | RSS: Main: 155684864 06:44:09 INFO - PROCESS | 10873 | 06:44:09 INFO - PROCESS | 10873 | __start_tp_report 06:44:09 INFO - PROCESS | 10873 | _x_x_mozilla_page_load 06:44:09 INFO - PROCESS | 10873 | _x_x_mozilla_page_load_details 06:44:09 INFO - PROCESS | 10873 | |i|pagename|runs| 06:44:09 INFO - PROCESS | 10873 | |0;dojo.html;3359.8488068036936;3390.067731373871;3399.694027537521;3417.026147547949;3446.4141096013677;5619.80330688426;5666.433356664332;5672.659640421567;5694.288213973254;5703.17303990921;5686.914696279559;5687.232223649806;5692.544596432286;5742.425757424256;5760.222369980052;5125.282460455539;5149.047426226141;5222.3472065991755;5255.474452554752;5286.524212820846;5080.593552515808;5201.271821944931;5330.493603107699;5331.253624492574;5339;5196.194589838581;5216.9478305217035;5287.629865909388;5295.364556253255;5299.258103865462;5225.9025604623075;5245.396779370383;5246.186841039645;5256;5277.9472205278225;5038.093143234217;5114.667546609458;5155.948440515622;5211.973940130275;5231.659942103751;5543.085390910495;5551.528120109796;5558.027345214571;5566.693831839248;5571.247881535981;6092.238470191226;6092.9695351523405;6095.603785753912;6109.208060097745;6115.87768244637;6094.634321940698;6144.324124346318;6155.969220153916;6166.383361663842;6169.413905678954;5512.80705175317;5700.686462244575;5741.799037033684;5749.993751093583;5773.740181691834;6158.476529495043;6269.467095296951;6275.466585340206;6282.246130464374;6308.211473565804;5841.386654401226;5872.58891877573;5874.383189765099;5876.559258055578;5909.084091965752;5943.31651860033;5979.103134529768;6005.309389420186;6036.667983260875;6073.119397687311;5954.672493012839;5961.642301461926;5967.79112731061;6010.4891084258325;6012.428819262163;5833.329167145747;6009.819705408845;6024.096385542204;6037.758489660452;6054.757809687563;4590.357349971006;4636.976815115903;4641.512641172696;4656.767161641905;4668.696534725232;4150.875473735793;4163.375493675912;4166.312558427825;4168.062186008185;4195;5702.914456283159;5864.970675146597;5916.26046744157;5936.495397891142;5940.495057920125;5942.554308426886;6065.60573562717;6126.142340072393;6151.938480615226;6152.78465253714;5873.2658417697785;5879.764809407576;5880.500157486662;5889.087191485327;5899.085641725539;5130.974345128325;5186.118359878829;5197.856471576247;5219.947800522022;5225.372955245319;6220.564560480723;6276.811695649138;6289.811305660837;6290.528210384239;6297.055441683784;6029.095635654687;6050.576459647782;6065.8180254592435;6068.180795592627;6092.177556030057;6126.3955342902;6219.253689557282;6227.595206311576;6246.875562398812;6291.1192433058495;5978.953683105352;6014.8195554133445;6016.09758536223;6017.428344307284;6027.246594175728;6099.8780024398375;6103.7253323601435;6106.419890110433;6108.511319094373;6121.693915304128;5878.529717622666;5963.612365196248;5976.462118409364;6022.759089636365;6064.878702425838;5821.039528477754;5887;5891.1752354669525;5901.822945311647;5906.940930590639;5652.463016013637;5713.600047996601;5761.279840019997;5775.047117225611;5836.358000619844;5864.413558644102;5873.794417195378;5875.882482350415;5883.441073098049;5914.02418600926;5819.534437244925;5853.473187413153;5880.117982302689;5882.558808089496;5908.586398952032 06:44:09 INFO - PROCESS | 10873 | |1;ext.html;659.9901001484975;665.980020599382;677.9593224406534;696.6029363262942;774.7094839435211;39041.219175616505;39825.0043748906;39830.60169398305;39929.40105898414;39957.600423995755;44100.11799764003;44286;44950.32574511385;45086;45179.77410112945;8840.336974726904;8946;9016.8647470288;9024.32317576181;9050.86423703645;8850.867236991418;8968.865467018;9009.504477253748;9012.954935225314;9030.458172509638;8968.417052891542;8978.820423591524;8988.460692358447;9016.954915225448;9060.864087038666;8917.420367676114;8952.19430251274;8982.10178982103;8994.28045756338;9034.412763170438;8819.691310804092;8988.191062804379;8990.775230619221;8995.865062024075;9026.819463610756;39263;39813;39961.80019099915;39980.40029399561;40052.198956021006;3831.425286207091;3918.9810649231404;3944.250592387466;4048.271311163989;4333.371661109121;33292;33753.662463375294;33910;33933.490997635054;34470.310593788236;4605;4703.506131856174;4740.9555398869825;4779.259214821674;4788.569028787426;314658;317060;318291;318479;319445;55647.72176139093;56021.71989140028;56051.439485605435;56063.71968140133;56107.15839262333;63748;69505.30494694988;70800;70822.64588677023;71019;19070.809291906902;19153.90423047904;19159.32942347039;19325.90337048334;19335.12991915367;14769.926150369394;14895.77656335156;14913.70172596542;15004.324805383783;15033.098014119189;19730.802691972898;20166.69749953752;20183.192672293237;20213;20249.595008099757;7589.8861517077285;7879.921200788033;7885.211478852184;7911.604419779103;7950.880736788953;1143.782681290552;1196.7127889306503;1202.8436303280694;1215.3558613934629;1216.3857252087817;32780.508292375634;33169.83415082909;33399;33468;33838.32323353519;1218.5186851193905;1225.5097960815567;1241.2862604002735;1328.0438084579087;1328.9800652990214;17081.658366832595;17416.912915435594;17421.912890435466;17481.912590436965;17507.299708011793;477591;534677;540500;544672;572099;55782.44217557854;56876.71561642248;56905.14642280369;57077.14384284239;57209;1512.3648067811546;1535.71589255988;1548.0711573056076;1549.2718422341482;1558.7428074367601;30623.846880765454;31706;34042.14894627654;34111.4883276756;34421.82789086038;53946.460535394144;54964;55007.44992550023;55275.17087243614;55520.72239638776;448335;453964;454340;454798;456108;30302.393952121274;30405.391892162475;30608.693913060586;30617.846910765304;30758.692413075583;50919;51030.74484627553;51081.489185107675;51803.74098129636;52353.7382313086;42320.57679423167;42511.57488425076;42897.785511072245;43378.783106084265;44376.77811610921;42000.369994449495;42102.15795684131;42570;42678.14643707171;43429.131417370845;42265.57734422616;42659.573404266805;43325;44150.55849441593;44190.779046104566;35734.64265357313;36561.81719091388;36796.448053278684;37106.8144659275;37541.624583753815;28511.574421278438;29484.410311794072;29485.557716633837;29755.256118597208;29859.402811943204 06:44:09 INFO - PROCESS | 10873 | |2;jquery.html;408.5301902811766;415.50554839740687;420.8169446290864;421.479472851029;428.9957100428996;15645.843541564582;18623.34818281359;19218.615627687454;19361.903190484027;19506.70739938902;18662.346817861377;19000.904995475037;19747.210111595556;20257.898710506426;20341.49146271344;5707.65754054756;5714.285714285715;5912.8226153215255;5966.8806623867495;5976.790812321569;5815.796447124351;5877.235959325303;5888.617239879394;5895.852603684899;5926.970365148169;5649.604527683064;5828.358880523139;5876.853078673024;5880.6765627890445;5959.046552551593;5813.2733408324175;5825.475707186331;5847.356790753014;5861.824145275648;5877.970610146965;5050.191969284933;5161.458046905059;5202.27168196449;5262.921101174288;5288.23320618512;22493.887530562242;23036.884815575984;23122;23179.420514487105;23467.295981120424;2641.141628970592;2814.240155158096;2910.4615646105326;3121.110483512211;3154.4479716049827;14640.853591464162;14773.409063637442;14845.628859278497;15048.398064077424;15339.923300383427;1964.1063316191098;2057.9485512862148;2079.324219628627;2123.946901327464;2131;80365.59817200936;81320.59339703263;82846.58576707139;83522.58238708889;84068.15931840664;10312.948435257777;10502.842457363146;10765.13878889687;10837.512311945982;10982.835257470984;14703.485378011717;14880.70238595222;15088.698226035638;15261.847381526264;15327.770083448757;8460.407771456063;8598.914010859811;8745.650173992968;8814.250788682906;8886.60010299538;8672.956635216784;8694.087120852346;8720.345974051972;8753.737387878375;8782.385233033627;4697.577218050392;4852.102361063215;4854.805807767721;4886.315915771795;4917.311576379309;2000.9199632014556;2006.6789313709737;2054.856160068781;2097.9475513112293;2101.9264325748527;978.9853152202722;1092.7049696582037;1120.5181771838188;1123.095907794217;1131.660501849442;15825.841741582437;17635.294588216584;18274.725879111826;18885.15016824246;19195;1044.8119338518989;1083.653230966099;1087.8912108789216;1096.7313008313015;1138.1350173867754;8847.46915185078;10444.582216711246;10491.947540262403;10521.684349469528;10632.468376581295;562429;565681;569633;576370;591370;94183;96953;97743.51128244455;98724;100354;1163.8428812110258;1165.6677846813618;1176.2707121584672;1180.4805885410565;1202.2185579373477;16741.246643901297;16800.327986880387;16932.661346773242;17081.82918170852;17200.655986880443;40399.3940090893;40442.39336409897;40631.39052914149;41782.79108604559;41787.32850685938;53539;60697.39302607094;61797.38202618096;61921.69039154775;62944.68527657333;8645.8703119452;8650.697225597074;8952.418092823946;8960.641574336954;9095.226905713089;9198;12533.185342952678;12635.557755478514;13519.459221631418;14079.225642589347;11430.885691142983;11637.88362116368;11648.242864213798;11662.94168529152;12008.63974080779;10976.945115274373;11871.76256474883;12051.51793928233;12063.879361206627;12279.386030698251;11099.72250693739;11433.885661143282;11602.883971160518;11761.117916156152;12076.51693932233;8474.533900635524;8631.39580229403;8774.517401542977;8972.730818075468;9129.680461183827;8328.583570821313;10400.791984160425;10942.671719848417;11141.442927853737;11450.312981221154 06:44:09 INFO - PROCESS | 10873 | |3;mootools.html;1547.953561393158;1581.3200323860735;1765.8675599330045;1892.5079479335386;1912.2542208538664;7278.30856068674;8162.102168761447;8277.46196497228;8526.829463410735;8537;8489.702860399888;8492.915070849305;8546.316294696426;8549.91450085499;8583.184597463247;2405.338531903723;2413.1312727418117;2436.792872605831;2437.2688193541953;2458.7418321076298;2415.070197973784;2425.9514809703796;2440.2191298784396;2471;2473.6536884836137;2403.218953840009;2433.6957880264968;2436.4639779248537;2441.1455990403306;2457.8893949772305;2395.5328710901467;2419;2421.685180926486;2425.4785221177353;2461.310832966772;2381.666566680666;2402.951940961171;2440.694913135858;2450.191436825861;2453.386653336666;8489.745307640718;8505.702300419456;8513.616887240089;8537.914620853775;8566.828663426759;5212.166053431471;5237.214417837316;5292.153255479105;5297.576193904517;5303.840884773463;3460.1349662584353;3467.1158854492196;3546.2730140321432;3548.201654627714;3613.331533666254;1208.7522057978094;1248.063952035973;1251.837261156053;1257.145141303913;1291.5092264939358;11332;11487.597934072268;11498.42507874603;11521.251118677259;11580.131490138274;4431.069475410135;4431.512533621299;4502.189605870909;4527;4555.180067587866;9440.669576564787;9554.426734395958;9576.521173941275;9585.329026968046;9595.23238140947;5152.5362717354865;5164.225366195025;5200.427952925175;5203.661761985459;5213.426523082458;4261.829526818955;4634.884127896762;4683.601893838993;4723.598494128038;4842.5157484251295;4053.43251944728;4065.4511640928686;4073.165001174752;4109.869785808866;4169.2703776838935;1300.6033159886135;1363.9454421823016;1368.4321006782272;1372.5607805502343;1382.1154461144874;932.8600709893434;1084.0947808579767;1107.7895199912152;1109.8168802147554;1113.4766659669942;5663.490285874209;5790.218320526759;5840.649561026352;5869.8239052828485;5905.734241959036;447.4161219608377;451.0347855589042;453.6869560003587;468.5361492122774;486.70311110222735;4044.9797751011647;4082.7346222495444;4114.259433302034;4118.990847242445;4140.523839758406;9527.333086684004;9847.852282215772;9931.106200441995;9945.950270248748;9973.900260997443;9625.181859542017;9722.222222222346;9770.804583908282;9815.607375705034;9823.656172033945;7757.9224207758325;7796.532208067534;7974.043114826258;8041.236082572146;8050.59747012647;5514;5733.3406658234835;5773.538116950718;5787.074068149076;5863.2670916135485;8124.63439145228;8319.126491718282;8351.20663536963;8398.286145677686;8429.157084291523;8433.283170930294;8452.070272270168;8518.275946544612;8562.143785621389;8597.65609375643;6760.93239067603;7097.290270972861;7218.602976836324;7313.890291645524;7525.059367579052;7774.105977812624;7913.248241417056;7924.881126783218;7939.920600794149;7980.401469889665;7056.259092795182;7302.9269707304375;7321.267873212636;7364.5581265124265;7419.258074192538;7270.6728197230195;7308.488405811755;7324.597147156957;7324.926750732425;7366.226546212785;6782.25395206517;6783.660816959034;6786.898196526958;6807.5575087619145;6858.3827455529245;4804.5195480451675;4887.095887260726;5012.423571289202;5138.203578445347;5143.202803565453;4945.950540494549;5064.5441910228255;5088.109580823267;5159.303494028408;5174.482551744795 06:44:09 INFO - PROCESS | 10873 | |4;prototype.html;354.1076487252123;357.9123114836865;360.61774519009845;363.48748264946414;366.7487770876951;6601.83495412615;6628.204615446147;6687.632180230085;6728.562643428174;6779.694913728882;6596.802095937118;6610.636414997185;6652.334766523345;6659.134312539375;6667.833304167399;4986.800527978886;4989.600831933455;4991.7504124793795;4998.10034193845;5016.899662006757;4999.775010124535;5014.348134742497;5016.49835016499;5016.871203979112;5032.119379108642;4971.154903666367;4977.6266779991465;4978.2532620107095;4982.103221420143;5013.573846223076;4899.093667671492;4970.329005584236;4977.527134922177;4984.725840078794;4985.825496107637;4270.743755374688;4308.202982448257;4312;4317.438732964726;4324.264874971231;6332.240131184241;6333.524985626096;6339.746410143589;6340.461060809836;6352.174217351715;5704.515116215085;5760.74076666551;5768.509676677446;5780.277465316835;5792.131180322943;6885.414739747128;6946.548474349202;6950.478714096463;6971.3028697129885;6992;4685.554872287162;4760.976195119037;4768.546988036166;4779.163646361872;4786.353842231289;7151.463640227003;7183.245759195262;7189.27457410223;7247.20280769115;7260.6732697028765;4837.588804951548;4855.417349918032;4868.3427737255015;4868.707877527359;4887.511248875155;4936.851894443173;4938.456769755324;4939.678920870132;4941.50584941503;4945.67853089548;5721.685307308138;5739.053056245756;5740.167675687086;5748.396418376094;5757.942420575824;6794.320567943166;6962.7911162665205;6984.720611175598;7016.614086225307;7027.051348068047;1711.4951089428648;1723.83623555762;1739.1478175694072;1740.617064245864;1740.7998080220937;1104.9337039777638;1115.6262652011667;1130.231442619027;1131.6718151735904;1133.6032388664066;6571.704273307712;6679.799606011828;6859.965700171467;6881.002254673044;6881.587104773729;7300.926990730131;7301.415886729049;7314.817129571803;7338.41292696583;7358.11702595692;6748.358905903931;6757.898631520531;6788.219354774165;6803.795886123424;6825.795226143224;3927.8036098194975;3952.782596957195;3953.367461206251;3973.7814420207164;3980.482537270136;7366.668499917517;7595.772126836204;7612.923870761332;7616.80957976055;7638.388928885676;7403;7408.703651853865;7412.555246685216;7419.443541734391;7441.516301440389;7547.886781698169;7557.5465472071855;7592.430567707444;7613.847723045508;7685.11621163551;7215;7335.1197856257595;7337.376323012603;7342.302481264272;7427.888581671171;7227.7831665050135;7238.855222895618;7241;7254.5647261164495;7255.709771609077;7635.083789945242;7638.236176382317;7641.808954775953;7643.464957452925;7643.617819108911;4883.804647814048;4914.5822605078965;4923.630727695366;4935.358403407534;4944.75276236194;7025.543339682904;7330.303621155982;7338.156112047183;7339.926600733925;7348.816279593053;7049.29507049291;7091.361777440055;7129.073220481304;7132.179799323144;7148.428125749823;6943.201531823703;7029.543079700008;7072.3634872861685;7084.822879428056;7104.715811367694;6938.098047254027;6948.513604047668;6948.826279343057;6951.339622735832;6954.235034146139;7012.509124361246;7062.081929349151;7113.039739635083;7129.821754455973;7146.392556632744;6654.268030516736;6846.931530684828;6891.517593768589;6955.686994085379;6998.6500674967065 06:44:09 INFO - PROCESS | 10873 | |5;yui.html;910.4218821048635;918.6509126531919;942.6606421688195;963.3689933093826;964.5996911281818;14857.479988200415;15061.472848450307;15197;16793.160341982883;17312.740308895376;15846.76229856553;15967.600809979756;15995.600109997256;16004.679906401865;16059.036457812539;916.6654171227487;928.2342067794063;932.4871320773582;933.2953620016877;934.7149119518544;921.3320342751518;930.9162175404213;957.6935380678186;960.6541645007792;960.9231261499064;988.8763904511936;992.9900700993006;993.3096497933939;994.0208894239169;996.1184351848593;979.5347210075229;979.8432250839903;983.5279066048302;987.8962708915532;989.6288891665625;725.6045455226862;731.403905816763;732.5714457042636;733.4609062339176;733.7431898835365;16000.919995400065;16129.112898790561;16144.434944776876;16155;16175.83824161755;14601.853981460155;14653.194074325907;14654.194019328932;14666.70666586673;14753.926230368887;11254.568330237862;11581.710457238552;11660.242084264495;11737.530498780125;11802.645920622395;4001.7598944063157;4005.9584508027833;4030.5767894371256;4040.5959404059654;4142.91714165715;55368;56393.43606563923;56784.716076419354;58368.124478132864;59114.40885591132;11228.98939095469;11294.152938529644;11528.538858445736;11614.767704646029;12143.210691305037;19738.60522789536;19830.405087847386;19846.90076549608;19893.801061989485;19928.50178745514;8513.653458331008;8670.696525621574;8763.167499087576;9060.411073280216;9115.635374585076;4977.253411988158;5068.265101560253;5144.794208231704;5146.614003949719;5188.948110518922;3521.859125634946;3562.71498280137;3578.1054736315923;3605.260921511084;3608.855645774192;661.0810972747885;662.1822049768532;667.5260564998905;672.3108813466237;676.7800464848943;831.5135645647243;846.9830603387898;849.7875531117221;853.9359548033798;866.9739907802776;9912.405255684682;9967.302288839712;10025.097741203326;10033.749156271151;10250.231232657581;800.9467550171622;836.0260296754213;843.8396704626101;846.8602680557763;857.4812238595559;4603.217453032992;4777.474477807438;4862.17343051682;4884;4888.95111048885;60091.39908600946;61746.38253617496;62092;62399.6880015597;62423.687881560305;47896;48816.26775598369;49093.509064908896;49267;49597.75201123971;44535;44777;44787.65637030894;45060.54939450629;45467.54532454699;10240.897591024292;10308.203363572751;10381.792364152825;10408.167346612405;10461.843072353768;35535.822320888234;36102.27795444129;36361.27277454489;37161.628383716896;38698.80650596729;45710.54289457196;47750.283745743145;48166.27750583674;48557;48733.756331218116;12880.484780608671;12924.806127907901;13025.088243822842;13061.608151755463;13141.145825521311;13942;14114.78827817563;14201.360938757987;14289.785653215418;14740.48408305747;12168.87831121713;12238.204516706386;12646.114771966242;12672.493100275886;12746.490140394651;13124;13162.670933226364;13290.269035203157;13344.666383340495;13808.447662093404;12871.16337438101;13100.868991310346;13425.66435839112;13444.731105378034;13460.596182114552;11481.36852473122;11489.597864074718;11611.709707257049;11656.708582285512;11711.355875426932;11247.887521124683;11380.715482113013;11417.200795944536;11498.19512634141;11699.12256580777 06:44:09 INFO - PROCESS | 10873 | __end_tp_report 06:44:09 INFO - PROCESS | 10873 | __start_cc_report 06:44:09 INFO - PROCESS | 10873 | _x_x_mozilla_cycle_collect,321 06:44:09 INFO - PROCESS | 10873 | __end_cc_report 06:44:09 INFO - PROCESS | 10873 | __startTimestamp1462801449595__endTimestamp 06:44:09 INFO - PROCESS | 10873 | 06:44:09 INFO - PROCESS | 10873 | ------- Summary: start ------- 06:44:09 INFO - PROCESS | 10873 | Number of tests: 6 06:44:09 INFO - PROCESS | 10873 | 06:44:09 INFO - PROCESS | 10873 | [#0] dojo.html Cycles:165 Average:5648.81 Median:5875.88 stddev:617.45 (10.5%) stddev-sans-first:592.65 06:44:09 INFO - PROCESS | 10873 | Values: 3359.8 3390.1 3399.7 3417.0 3446.4 5619.8 5666.4 5672.7 5694.3 5703.2 5686.9 5687.2 5692.5 5742.4 5760.2 5125.3 5149.0 5222.3 5255.5 5286.5 5080.6 5201.3 5330.5 5331.3 5339.0 5196.2 5216.9 5287.6 5295.4 5299.3 5225.9 5245.4 5246.2 5256.0 5277.9 5038.1 5114.7 5155.9 5212.0 5231.7 5543.1 5551.5 5558.0 5566.7 5571.2 6092.2 6093.0 6095.6 6109.2 6115.9 6094.6 6144.3 6156.0 6166.4 6169.4 5512.8 5700.7 5741.8 5750.0 5773.7 6158.5 6269.5 6275.5 6282.2 6308.2 5841.4 5872.6 5874.4 5876.6 5909.1 5943.3 5979.1 6005.3 6036.7 6073.1 5954.7 5961.6 5967.8 6010.5 6012.4 5833.3 6009.8 6024.1 6037.8 6054.8 4590.4 4637.0 4641.5 4656.8 4668.7 4150.9 4163.4 4166.3 4168.1 4195.0 5702.9 5865.0 5916.3 5936.5 5940.5 5942.6 6065.6 6126.1 6151.9 6152.8 5873.3 5879.8 5880.5 5889.1 5899.1 5131.0 5186.1 5197.9 5219.9 5225.4 6220.6 6276.8 6289.8 6290.5 6297.1 6029.1 6050.6 6065.8 6068.2 6092.2 6126.4 6219.3 6227.6 6246.9 6291.1 5979.0 6014.8 6016.1 6017.4 6027.2 6099.9 6103.7 6106.4 6108.5 6121.7 5878.5 5963.6 5976.5 6022.8 6064.9 5821.0 5887.0 5891.2 5901.8 5906.9 5652.5 5713.6 5761.3 5775.0 5836.4 5864.4 5873.8 5875.9 5883.4 5914.0 5819.5 5853.5 5880.1 5882.6 5908.6 06:44:09 INFO - PROCESS | 10873 | 06:44:09 INFO - PROCESS | 10873 | [#1] ext.html Cycles:180 Average:60589.50 Median:42668.86 stddev:117733.18 (275.9%) stddev-sans-first:117977.47 06:44:09 INFO - PROCESS | 10873 | Values: 660.0 666.0 678.0 696.6 774.7 39041.2 39825.0 39830.6 39929.4 39957.6 44100.1 44286.0 44950.3 45086.0 45179.8 8840.3 8946.0 9016.9 9024.3 9050.9 8850.9 8968.9 9009.5 9013.0 9030.5 8968.4 8978.8 8988.5 9017.0 9060.9 8917.4 8952.2 8982.1 8994.3 9034.4 8819.7 8988.2 8990.8 8995.9 9026.8 39263.0 39813.0 39961.8 39980.4 40052.2 3831.4 3919.0 3944.3 4048.3 4333.4 33292.0 33753.7 33910.0 33933.5 34470.3 4605.0 4703.5 4741.0 4779.3 4788.6 314658.0 317060.0 318291.0 318479.0 319445.0 55647.7 56021.7 56051.4 56063.7 56107.2 63748.0 69505.3 70800.0 70822.6 71019.0 19070.8 19153.9 19159.3 19325.9 19335.1 14769.9 14895.8 14913.7 15004.3 15033.1 19730.8 20166.7 20183.2 20213.0 20249.6 7589.9 7879.9 7885.2 7911.6 7950.9 1143.8 1196.7 1202.8 1215.4 1216.4 32780.5 33169.8 33399.0 33468.0 33838.3 1218.5 1225.5 1241.3 1328.0 1329.0 17081.7 17416.9 17421.9 17481.9 17507.3 477591.0 534677.0 540500.0 544672.0 572099.0 55782.4 56876.7 56905.1 57077.1 57209.0 1512.4 1535.7 1548.1 1549.3 1558.7 30623.8 31706.0 34042.1 34111.5 34421.8 53946.5 54964.0 55007.4 55275.2 55520.7 448335.0 453964.0 454340.0 454798.0 456108.0 30302.4 30405.4 30608.7 30617.8 30758.7 50919.0 51030.7 51081.5 51803.7 52353.7 42320.6 42511.6 42897.8 43378.8 44376.8 42000.4 42102.2 42570.0 42678.1 43429.1 42265.6 42659.6 43325.0 44150.6 44190.8 35734.6 36561.8 36796.4 37106.8 37541.6 28511.6 29484.4 29485.6 29755.3 29859.4 06:44:09 INFO - PROCESS | 10873 | 06:44:09 INFO - PROCESS | 10873 | [#2] jquery.html Cycles:180 Average:31625.93 Median:23323.36 stddev:94234.82 (404.0%) stddev-sans-first:94470.02 06:44:09 INFO - PROCESS | 10873 | Values: 408.5 415.5 420.8 421.5 429.0 15645.8 18623.3 19218.6 19361.9 19506.7 18662.3 19000.9 19747.2 20257.9 20341.5 5707.7 5714.3 5912.8 5966.9 5976.8 5815.8 5877.2 5888.6 5895.9 5927.0 5649.6 5828.4 5876.9 5880.7 5959.0 5813.3 5825.5 5847.4 5861.8 5878.0 5050.2 5161.5 5202.3 5262.9 5288.2 22493.9 23036.9 23122.0 23179.4 23467.3 2641.1 2814.2 2910.5 3121.1 3154.4 14640.9 14773.4 14845.6 15048.4 15339.9 1964.1 2057.9 2079.3 2123.9 2131.0 80365.6 81320.6 82846.6 83522.6 84068.2 10312.9 10502.8 10765.1 10837.5 10982.8 14703.5 14880.7 15088.7 15261.8 15327.8 8460.4 8598.9 8745.7 8814.3 8886.6 8673.0 8694.1 8720.3 8753.7 8782.4 4697.6 4852.1 4854.8 4886.3 4917.3 2000.9 2006.7 2054.9 2097.9 2101.9 979.0 1092.7 1120.5 1123.1 1131.7 15825.8 17635.3 18274.7 18885.2 19195.0 1044.8 1083.7 1087.9 1096.7 1138.1 8847.5 10444.6 10491.9 10521.7 10632.5 562429.0 565681.0 569633.0 576370.0 591370.0 94183.0 96953.0 97743.5 98724.0 100354.0 1163.8 1165.7 1176.3 1180.5 1202.2 16741.2 16800.3 16932.7 17081.8 17200.7 40399.4 40442.4 40631.4 41782.8 41787.3 53539.0 60697.4 61797.4 61921.7 62944.7 8645.9 8650.7 8952.4 8960.6 9095.2 9198.0 12533.2 12635.6 13519.5 14079.2 11430.9 11637.9 11648.2 11662.9 12008.6 10976.9 11871.8 12051.5 12063.9 12279.4 11099.7 11433.9 11602.9 11761.1 12076.5 8474.5 8631.4 8774.5 8972.7 9129.7 8328.6 10400.8 10942.7 11141.4 11450.3 06:44:09 INFO - PROCESS | 10873 | 06:44:09 INFO - PROCESS | 10873 | [#3] mootools.html Cycles:180 Average:5502.13 Median:5187.46 stddev:2926.46 (56.4%) stddev-sans-first:2919.58 06:44:09 INFO - PROCESS | 10873 | Values: 1548.0 1581.3 1765.9 1892.5 1912.3 7278.3 8162.1 8277.5 8526.8 8537.0 8489.7 8492.9 8546.3 8549.9 8583.2 2405.3 2413.1 2436.8 2437.3 2458.7 2415.1 2426.0 2440.2 2471.0 2473.7 2403.2 2433.7 2436.5 2441.1 2457.9 2395.5 2419.0 2421.7 2425.5 2461.3 2381.7 2403.0 2440.7 2450.2 2453.4 8489.7 8505.7 8513.6 8537.9 8566.8 5212.2 5237.2 5292.2 5297.6 5303.8 3460.1 3467.1 3546.3 3548.2 3613.3 1208.8 1248.1 1251.8 1257.1 1291.5 11332.0 11487.6 11498.4 11521.3 11580.1 4431.1 4431.5 4502.2 4527.0 4555.2 9440.7 9554.4 9576.5 9585.3 9595.2 5152.5 5164.2 5200.4 5203.7 5213.4 4261.8 4634.9 4683.6 4723.6 4842.5 4053.4 4065.5 4073.2 4109.9 4169.3 1300.6 1363.9 1368.4 1372.6 1382.1 932.9 1084.1 1107.8 1109.8 1113.5 5663.5 5790.2 5840.6 5869.8 5905.7 447.4 451.0 453.7 468.5 486.7 4045.0 4082.7 4114.3 4119.0 4140.5 9527.3 9847.9 9931.1 9946.0 9973.9 9625.2 9722.2 9770.8 9815.6 9823.7 7757.9 7796.5 7974.0 8041.2 8050.6 5514.0 5733.3 5773.5 5787.1 5863.3 8124.6 8319.1 8351.2 8398.3 8429.2 8433.3 8452.1 8518.3 8562.1 8597.7 6760.9 7097.3 7218.6 7313.9 7525.1 7774.1 7913.2 7924.9 7939.9 7980.4 7056.3 7302.9 7321.3 7364.6 7419.3 7270.7 7308.5 7324.6 7324.9 7366.2 6782.3 6783.7 6786.9 6807.6 6858.4 4804.5 4887.1 5012.4 5138.2 5143.2 4946.0 5064.5 5088.1 5159.3 5174.5 06:44:09 INFO - PROCESS | 10873 | 06:44:09 INFO - PROCESS | 10873 | [#4] prototype.html Cycles:180 Average:5867.28 Median:6708.10 stddev:1805.51 (26.9%) stddev-sans-first:1762.52 06:44:09 INFO - PROCESS | 10873 | Values: 354.1 357.9 360.6 363.5 366.7 6601.8 6628.2 6687.6 6728.6 6779.7 6596.8 6610.6 6652.3 6659.1 6667.8 4986.8 4989.6 4991.8 4998.1 5016.9 4999.8 5014.3 5016.5 5016.9 5032.1 4971.2 4977.6 4978.3 4982.1 5013.6 4899.1 4970.3 4977.5 4984.7 4985.8 4270.7 4308.2 4312.0 4317.4 4324.3 6332.2 6333.5 6339.7 6340.5 6352.2 5704.5 5760.7 5768.5 5780.3 5792.1 6885.4 6946.5 6950.5 6971.3 6992.0 4685.6 4761.0 4768.5 4779.2 4786.4 7151.5 7183.2 7189.3 7247.2 7260.7 4837.6 4855.4 4868.3 4868.7 4887.5 4936.9 4938.5 4939.7 4941.5 4945.7 5721.7 5739.1 5740.2 5748.4 5757.9 6794.3 6962.8 6984.7 7016.6 7027.1 1711.5 1723.8 1739.1 1740.6 1740.8 1104.9 1115.6 1130.2 1131.7 1133.6 6571.7 6679.8 6860.0 6881.0 6881.6 7300.9 7301.4 7314.8 7338.4 7358.1 6748.4 6757.9 6788.2 6803.8 6825.8 3927.8 3952.8 3953.4 3973.8 3980.5 7366.7 7595.8 7612.9 7616.8 7638.4 7403.0 7408.7 7412.6 7419.4 7441.5 7547.9 7557.5 7592.4 7613.8 7685.1 7215.0 7335.1 7337.4 7342.3 7427.9 7227.8 7238.9 7241.0 7254.6 7255.7 7635.1 7638.2 7641.8 7643.5 7643.6 4883.8 4914.6 4923.6 4935.4 4944.8 7025.5 7330.3 7338.2 7339.9 7348.8 7049.3 7091.4 7129.1 7132.2 7148.4 6943.2 7029.5 7072.4 7084.8 7104.7 6938.1 6948.5 6948.8 6951.3 6954.2 7012.5 7062.1 7113.0 7129.8 7146.4 6654.3 6846.9 6891.5 6955.7 6998.7 06:44:09 INFO - PROCESS | 10873 | 06:44:09 INFO - PROCESS | 10873 | [#5] yui.html Cycles:180 Average:15195.23 Median:4035.59 stddev:16705.97 (414.0%) stddev-sans-first:16718.39 06:44:09 INFO - PROCESS | 10873 | Values: 910.4 918.7 942.7 963.4 964.6 14857.5 15061.5 15197.0 16793.2 17312.7 15846.8 15967.6 15995.6 16004.7 16059.0 916.7 928.2 932.5 933.3 934.7 921.3 930.9 957.7 960.7 960.9 988.9 993.0 993.3 994.0 996.1 979.5 979.8 983.5 987.9 989.6 725.6 731.4 732.6 733.5 733.7 16000.9 16129.1 16144.4 16155.0 16175.8 14601.9 14653.2 14654.2 14666.7 14753.9 11254.6 11581.7 11660.2 11737.5 11802.6 4001.8 4006.0 4030.6 4040.6 4142.9 55368.0 56393.4 56784.7 58368.1 59114.4 11229.0 11294.2 11528.5 11614.8 12143.2 19738.6 19830.4 19846.9 19893.8 19928.5 8513.7 8670.7 8763.2 9060.4 9115.6 4977.3 5068.3 5144.8 5146.6 5188.9 3521.9 3562.7 3578.1 3605.3 3608.9 661.1 662.2 667.5 672.3 676.8 831.5 847.0 849.8 853.9 867.0 9912.4 9967.3 10025.1 10033.7 10250.2 800.9 836.0 843.8 846.9 857.5 4603.2 4777.5 4862.2 4884.0 4889.0 60091.4 61746.4 62092.0 62399.7 62423.7 47896.0 48816.3 49093.5 49267.0 49597.8 44535.0 44777.0 44787.7 45060.5 45467.5 10240.9 10308.2 10381.8 10408.2 10461.8 35535.8 36102.3 36361.3 37161.6 38698.8 45710.5 47750.3 48166.3 48557.0 48733.8 12880.5 12924.8 13025.1 13061.6 13141.1 13942.0 14114.8 14201.4 14289.8 14740.5 12168.9 12238.2 12646.1 12672.5 12746.5 13124.0 13162.7 13290.3 13344.7 13808.4 12871.2 13100.9 13425.7 13444.7 13460.6 11481.4 11489.6 11611.7 11656.7 11711.4 11247.9 11380.7 11417.2 11498.2 11699.1 06:44:09 INFO - PROCESS | 10873 | -------- Summary: end -------- 06:44:09 INFO - PROCESS | 10873 | 06:44:10 INFO - TEST-INFO | 10873: exit 0 06:44:10 INFO - TEST-OK | dromaeo_css | took 1109306ms 06:44:10 INFO - TEST-START | kraken 06:44:10 INFO - operating with platform_type : linux_ 06:44:10 INFO - Initialising browser for kraken test... 06:44:10 INFO - TEST-INFO | started process 11116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK3d5TS/profile http://localhost:47327/getInfo.html) 06:44:13 INFO - PROCESS | 11116 | 06:44:13 INFO - PROCESS | 11116 | (process:11195): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:44:14 INFO - PROCESS | 11116 | __metrics Screen width/height:1600/1200 06:44:14 INFO - PROCESS | 11116 | colorDepth:24 06:44:14 INFO - PROCESS | 11116 | Browser inner width/height: 1024/697 06:44:14 INFO - PROCESS | 11116 | __metrics 06:44:15 ERROR - PROCESS | 11116 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:44:15 INFO - TEST-INFO | 11116: exit 0 06:44:15 INFO - Browser initialized. 06:44:15 INFO - Running cycle 1/1 for kraken test... 06:44:15 INFO - TEST-INFO | started process 11246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK3d5TS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:44:17 INFO - PROCESS | 11246 | 06:44:17 INFO - PROCESS | 11246 | (process:11315): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:44:27 INFO - PROCESS | 11246 | RSS: Main: 152195072 06:44:27 INFO - PROCESS | 11246 | 06:44:30 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47327/tests/kraken/driver.html?testName=audio-beat-detection) 06:44:31 INFO - PROCESS | 11246 | RSS: Main: 157200384 06:44:31 INFO - PROCESS | 11246 | 06:44:33 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47327/tests/kraken/driver.html?testName=audio-dft) 06:44:34 INFO - PROCESS | 11246 | RSS: Main: 157073408 06:44:34 INFO - PROCESS | 11246 | 06:44:37 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47327/tests/kraken/driver.html?testName=audio-fft) 06:44:37 INFO - PROCESS | 11246 | RSS: Main: 157605888 06:44:37 INFO - PROCESS | 11246 | 06:44:40 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47327/tests/kraken/driver.html?testName=audio-oscillator) 06:44:40 INFO - PROCESS | 11246 | RSS: Main: 157495296 06:44:40 INFO - PROCESS | 11246 | 06:44:42 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47327/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:44:43 INFO - PROCESS | 11246 | RSS: Main: 157380608 06:44:43 INFO - PROCESS | 11246 | 06:44:46 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47327/tests/kraken/driver.html?testName=imaging-darkroom) 06:44:47 INFO - PROCESS | 11246 | RSS: Main: 157736960 06:44:47 INFO - PROCESS | 11246 | 06:44:50 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47327/tests/kraken/driver.html?testName=imaging-desaturate) 06:44:51 INFO - PROCESS | 11246 | RSS: Main: 157356032 06:44:51 INFO - PROCESS | 11246 | 06:44:54 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47327/tests/kraken/driver.html?testName=json-parse-financial) 06:44:54 INFO - PROCESS | 11246 | RSS: Main: 157646848 06:44:54 INFO - PROCESS | 11246 | 06:44:56 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47327/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:44:56 INFO - PROCESS | 11246 | RSS: Main: 157507584 06:44:56 INFO - PROCESS | 11246 | 06:44:58 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47327/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:44:59 INFO - PROCESS | 11246 | RSS: Main: 157237248 06:44:59 INFO - PROCESS | 11246 | 06:45:01 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47327/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:45:01 INFO - PROCESS | 11246 | RSS: Main: 157261824 06:45:01 INFO - PROCESS | 11246 | 06:45:04 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:45:04 INFO - PROCESS | 11246 | RSS: Main: 157646848 06:45:04 INFO - PROCESS | 11246 | 06:45:07 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:45:08 INFO - PROCESS | 11246 | RSS: Main: 157569024 06:45:08 INFO - PROCESS | 11246 | 06:45:09 INFO - PROCESS | 11246 | Cycle 1(1): loaded http://localhost:47327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47327/tests/kraken/driver.html?testName=ai-astar) 06:45:10 INFO - PROCESS | 11246 | RSS: Main: 159215616 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | __start_tp_report 06:45:10 INFO - PROCESS | 11246 | _x_x_mozilla_page_load 06:45:10 INFO - PROCESS | 11246 | _x_x_mozilla_page_load_details 06:45:10 INFO - PROCESS | 11246 | |i|pagename|runs| 06:45:10 INFO - PROCESS | 11246 | |0;ai-astar;111;112;104;111;114;113;101;110;111;110 06:45:10 INFO - PROCESS | 11246 | |1;audio-beat-detection;156;127;154;178;128;165;155;137;181;128 06:45:10 INFO - PROCESS | 11246 | |2;audio-dft;165;162;162;162;163;165;161;162;162;163 06:45:10 INFO - PROCESS | 11246 | |3;audio-fft;74;74;77;174;73;79;75;73;174;75 06:45:10 INFO - PROCESS | 11246 | |4;audio-oscillator;92;93;149;92;93;92;144;95;93;140 06:45:10 INFO - PROCESS | 11246 | |5;imaging-gaussian-blur;117;118;120;118;117;117;118;119;119;119 06:45:10 INFO - PROCESS | 11246 | |6;imaging-darkroom;148;148;150;148;149;148;148;149;147;148 06:45:10 INFO - PROCESS | 11246 | |7;imaging-desaturate;95;95;96;96;95;96;95;95;95;95 06:45:10 INFO - PROCESS | 11246 | |8;json-parse-financial;54;62;56;57;57;60;55;77;53;53 06:45:10 INFO - PROCESS | 11246 | |9;json-stringify-tinderbox;57;57;57;58;58;58;58;57;57;58 06:45:10 INFO - PROCESS | 11246 | |10;stanford-crypto-aes;73;75;73;81;75;74;75;73;75;74 06:45:10 INFO - PROCESS | 11246 | |11;stanford-crypto-ccm;115;116;114;116;127;115;120;123;132;135 06:45:10 INFO - PROCESS | 11246 | |12;stanford-crypto-pbkdf2;166;162;169;159;167;166;166;162;166;166 06:45:10 INFO - PROCESS | 11246 | |13;stanford-crypto-sha256-iterative;68;71;67;70;68;69;66;71;65;70 06:45:10 INFO - PROCESS | 11246 | __end_tp_report 06:45:10 INFO - PROCESS | 11246 | __start_cc_report 06:45:10 INFO - PROCESS | 11246 | _x_x_mozilla_cycle_collect,836 06:45:10 INFO - PROCESS | 11246 | __end_cc_report 06:45:10 INFO - PROCESS | 11246 | __startTimestamp1462801510240__endTimestamp 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | ------- Summary: start ------- 06:45:10 INFO - PROCESS | 11246 | Number of tests: 14 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:4.06 (3.7%) stddev-sans-first:4.28 06:45:10 INFO - PROCESS | 11246 | Values: 111.0 112.0 104.0 111.0 114.0 113.0 101.0 110.0 111.0 110.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:155.50 stddev:20.29 (13.0%) stddev-sans-first:21.44 06:45:10 INFO - PROCESS | 11246 | Values: 156.0 127.0 154.0 178.0 128.0 165.0 155.0 137.0 181.0 128.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:1.34 (0.8%) stddev-sans-first:1.13 06:45:10 INFO - PROCESS | 11246 | Values: 165.0 162.0 162.0 162.0 163.0 165.0 161.0 162.0 162.0 163.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#3] audio-fft Cycles:10 Average:94.80 Median:74.50 stddev:41.78 (56.1%) stddev-sans-first:43.63 06:45:10 INFO - PROCESS | 11246 | Values: 74.0 74.0 77.0 174.0 73.0 79.0 75.0 73.0 174.0 75.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.50 stddev:24.97 (27.0%) stddev-sans-first:25.78 06:45:10 INFO - PROCESS | 11246 | Values: 92.0 93.0 149.0 92.0 93.0 92.0 144.0 95.0 93.0 140.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.50 stddev:1.03 (0.9%) stddev-sans-first:1.00 06:45:10 INFO - PROCESS | 11246 | Values: 117.0 118.0 120.0 118.0 117.0 117.0 118.0 119.0 119.0 119.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 06:45:10 INFO - PROCESS | 11246 | Values: 148.0 148.0 150.0 148.0 149.0 148.0 148.0 149.0 147.0 148.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:45:10 INFO - PROCESS | 11246 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.00 stddev:7.15 (12.5%) stddev-sans-first:7.41 06:45:10 INFO - PROCESS | 11246 | Values: 54.0 62.0 56.0 57.0 57.0 60.0 55.0 77.0 53.0 53.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:58.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 06:45:10 INFO - PROCESS | 11246 | Values: 57.0 57.0 57.0 58.0 58.0 58.0 58.0 57.0 57.0 58.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:2.35 (3.1%) stddev-sans-first:2.40 06:45:10 INFO - PROCESS | 11246 | Values: 73.0 75.0 73.0 81.0 75.0 74.0 75.0 73.0 75.0 74.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.50 stddev:7.66 (6.3%) stddev-sans-first:7.78 06:45:10 INFO - PROCESS | 11246 | Values: 115.0 116.0 114.0 116.0 127.0 115.0 120.0 123.0 132.0 135.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:166.00 stddev:2.96 (1.8%) stddev-sans-first:3.11 06:45:10 INFO - PROCESS | 11246 | Values: 166.0 162.0 169.0 159.0 167.0 166.0 166.0 162.0 166.0 166.0 06:45:10 INFO - PROCESS | 11246 | 06:45:10 INFO - PROCESS | 11246 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.50 stddev:2.07 (3.0%) stddev-sans-first:2.19 06:45:10 INFO - PROCESS | 11246 | Values: 68.0 71.0 67.0 70.0 68.0 69.0 66.0 71.0 65.0 70.0 06:45:10 INFO - PROCESS | 11246 | -------- Summary: end -------- 06:45:10 INFO - PROCESS | 11246 | 06:45:11 INFO - TEST-INFO | 11246: exit 0 06:45:11 INFO - TEST-OK | kraken | took 60874ms 06:45:11 INFO - SUITE-END | took 1170s 06:45:11 INFO - Completed test suite (00:19:30) 06:45:11 INFO - javascript benchmark 06:45:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.8488068036936, 3390.067731373871, 3399.694027537521, 3417.026147547949, 3446.4141096013677, 5619.80330688426, 5666.433356664332, 5672.659640421567, 5694.288213973254, 5703.17303990921, 5686.914696279559, 5687.232223649806, 5692.544596432286, 5742.425757424256, 5760.222369980052, 5125.282460455539, 5149.047426226141, 5222.3472065991755, 5255.474452554752, 5286.524212820846, 5080.593552515808, 5201.271821944931, 5330.493603107699, 5331.253624492574, 5339.0, 5196.194589838581, 5216.9478305217035, 5287.629865909388, 5295.364556253255, 5299.258103865462, 5225.9025604623075, 5245.396779370383, 5246.186841039645, 5256.0, 5277.9472205278225, 5038.093143234217, 5114.667546609458, 5155.948440515622, 5211.973940130275, 5231.659942103751, 5543.085390910495, 5551.528120109796, 5558.027345214571, 5566.693831839248, 5571.247881535981, 6092.238470191226, 6092.9695351523405, 6095.603785753912, 6109.208060097745, 6115.87768244637, 6094.634321940698, 6144.324124346318, 6155.969220153916, 6166.383361663842, 6169.413905678954, 5512.80705175317, 5700.686462244575, 5741.799037033684, 5749.993751093583, 5773.740181691834, 6158.476529495043, 6269.467095296951, 6275.466585340206, 6282.246130464374, 6308.211473565804, 5841.386654401226, 5872.58891877573, 5874.383189765099, 5876.559258055578, 5909.084091965752, 5943.31651860033, 5979.103134529768, 6005.309389420186, 6036.667983260875, 6073.119397687311, 5954.672493012839, 5961.642301461926, 5967.79112731061, 6010.4891084258325, 6012.428819262163, 5833.329167145747, 6009.819705408845, 6024.096385542204, 6037.758489660452, 6054.757809687563, 4590.357349971006, 4636.976815115903, 4641.512641172696, 4656.767161641905, 4668.696534725232, 4150.875473735793, 4163.375493675912, 4166.312558427825, 4168.062186008185, 4195.0, 5702.914456283159, 5864.970675146597, 5916.26046744157, 5936.495397891142, 5940.495057920125, 5942.554308426886, 6065.60573562717, 6126.142340072393, 6151.938480615226, 6152.78465253714, 5873.2658417697785, 5879.764809407576, 5880.500157486662, 5889.087191485327, 5899.085641725539, 5130.974345128325, 5186.118359878829, 5197.856471576247, 5219.947800522022, 5225.372955245319, 6220.564560480723, 6276.811695649138, 6289.811305660837, 6290.528210384239, 6297.055441683784, 6029.095635654687, 6050.576459647782, 6065.8180254592435, 6068.180795592627, 6092.177556030057, 6126.3955342902, 6219.253689557282, 6227.595206311576, 6246.875562398812, 6291.1192433058495, 5978.953683105352, 6014.8195554133445, 6016.09758536223, 6017.428344307284, 6027.246594175728, 6099.8780024398375, 6103.7253323601435, 6106.419890110433, 6108.511319094373, 6121.693915304128, 5878.529717622666, 5963.612365196248, 5976.462118409364, 6022.759089636365, 6064.878702425838, 5821.039528477754, 5887.0, 5891.1752354669525, 5901.822945311647, 5906.940930590639, 5652.463016013637, 5713.600047996601, 5761.279840019997, 5775.047117225611, 5836.358000619844, 5864.413558644102, 5873.794417195378, 5875.882482350415, 5883.441073098049, 5914.02418600926, 5819.534437244925, 5853.473187413153, 5880.117982302689, 5882.558808089496, 5908.586398952032], "value": 5609.046097934209, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.9901001484975, 665.980020599382, 677.9593224406534, 696.6029363262942, 774.7094839435211, 39041.219175616505, 39825.0043748906, 39830.60169398305, 39929.40105898414, 39957.600423995755, 44100.11799764003, 44286.0, 44950.32574511385, 45086.0, 45179.77410112945, 8840.336974726904, 8946.0, 9016.8647470288, 9024.32317576181, 9050.86423703645, 8850.867236991418, 8968.865467018, 9009.504477253748, 9012.954935225314, 9030.458172509638, 8968.417052891542, 8978.820423591524, 8988.460692358447, 9016.954915225448, 9060.864087038666, 8917.420367676114, 8952.19430251274, 8982.10178982103, 8994.28045756338, 9034.412763170438, 8819.691310804092, 8988.191062804379, 8990.775230619221, 8995.865062024075, 9026.819463610756, 39263.0, 39813.0, 39961.80019099915, 39980.40029399561, 40052.198956021006, 3831.425286207091, 3918.9810649231404, 3944.250592387466, 4048.271311163989, 4333.371661109121, 33292.0, 33753.662463375294, 33910.0, 33933.490997635054, 34470.310593788236, 4605.0, 4703.506131856174, 4740.9555398869825, 4779.259214821674, 4788.569028787426, 314658.0, 317060.0, 318291.0, 318479.0, 319445.0, 55647.72176139093, 56021.71989140028, 56051.439485605435, 56063.71968140133, 56107.15839262333, 63748.0, 69505.30494694988, 70800.0, 70822.64588677023, 71019.0, 19070.809291906902, 19153.90423047904, 19159.32942347039, 19325.90337048334, 19335.12991915367, 14769.926150369394, 14895.77656335156, 14913.70172596542, 15004.324805383783, 15033.098014119189, 19730.802691972898, 20166.69749953752, 20183.192672293237, 20213.0, 20249.595008099757, 7589.8861517077285, 7879.921200788033, 7885.211478852184, 7911.604419779103, 7950.880736788953, 1143.782681290552, 1196.7127889306503, 1202.8436303280694, 1215.3558613934629, 1216.3857252087817, 32780.508292375634, 33169.83415082909, 33399.0, 33468.0, 33838.32323353519, 1218.5186851193905, 1225.5097960815567, 1241.2862604002735, 1328.0438084579087, 1328.9800652990214, 17081.658366832595, 17416.912915435594, 17421.912890435466, 17481.912590436965, 17507.299708011793, 477591.0, 534677.0, 540500.0, 544672.0, 572099.0, 55782.44217557854, 56876.71561642248, 56905.14642280369, 57077.14384284239, 57209.0, 1512.3648067811546, 1535.71589255988, 1548.0711573056076, 1549.2718422341482, 1558.7428074367601, 30623.846880765454, 31706.0, 34042.14894627654, 34111.4883276756, 34421.82789086038, 53946.460535394144, 54964.0, 55007.44992550023, 55275.17087243614, 55520.72239638776, 448335.0, 453964.0, 454340.0, 454798.0, 456108.0, 30302.393952121274, 30405.391892162475, 30608.693913060586, 30617.846910765304, 30758.692413075583, 50919.0, 51030.74484627553, 51081.489185107675, 51803.74098129636, 52353.7382313086, 42320.57679423167, 42511.57488425076, 42897.785511072245, 43378.783106084265, 44376.77811610921, 42000.369994449495, 42102.15795684131, 42570.0, 42678.14643707171, 43429.131417370845, 42265.57734422616, 42659.573404266805, 43325.0, 44150.55849441593, 44190.779046104566, 35734.64265357313, 36561.81719091388, 36796.448053278684, 37106.8144659275, 37541.624583753815, 28511.574421278438, 29484.410311794072, 29485.557716633837, 29755.256118597208, 29859.402811943204], "value": 21094.310547790963, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.5301902811766, 415.50554839740687, 420.8169446290864, 421.479472851029, 428.9957100428996, 15645.843541564582, 18623.34818281359, 19218.615627687454, 19361.903190484027, 19506.70739938902, 18662.346817861377, 19000.904995475037, 19747.210111595556, 20257.898710506426, 20341.49146271344, 5707.65754054756, 5714.285714285715, 5912.8226153215255, 5966.8806623867495, 5976.790812321569, 5815.796447124351, 5877.235959325303, 5888.617239879394, 5895.852603684899, 5926.970365148169, 5649.604527683064, 5828.358880523139, 5876.853078673024, 5880.6765627890445, 5959.046552551593, 5813.2733408324175, 5825.475707186331, 5847.356790753014, 5861.824145275648, 5877.970610146965, 5050.191969284933, 5161.458046905059, 5202.27168196449, 5262.921101174288, 5288.23320618512, 22493.887530562242, 23036.884815575984, 23122.0, 23179.420514487105, 23467.295981120424, 2641.141628970592, 2814.240155158096, 2910.4615646105326, 3121.110483512211, 3154.4479716049827, 14640.853591464162, 14773.409063637442, 14845.628859278497, 15048.398064077424, 15339.923300383427, 1964.1063316191098, 2057.9485512862148, 2079.324219628627, 2123.946901327464, 2131.0, 80365.59817200936, 81320.59339703263, 82846.58576707139, 83522.58238708889, 84068.15931840664, 10312.948435257777, 10502.842457363146, 10765.13878889687, 10837.512311945982, 10982.835257470984, 14703.485378011717, 14880.70238595222, 15088.698226035638, 15261.847381526264, 15327.770083448757, 8460.407771456063, 8598.914010859811, 8745.650173992968, 8814.250788682906, 8886.60010299538, 8672.956635216784, 8694.087120852346, 8720.345974051972, 8753.737387878375, 8782.385233033627, 4697.577218050392, 4852.102361063215, 4854.805807767721, 4886.315915771795, 4917.311576379309, 2000.9199632014556, 2006.6789313709737, 2054.856160068781, 2097.9475513112293, 2101.9264325748527, 978.9853152202722, 1092.7049696582037, 1120.5181771838188, 1123.095907794217, 1131.660501849442, 15825.841741582437, 17635.294588216584, 18274.725879111826, 18885.15016824246, 19195.0, 1044.8119338518989, 1083.653230966099, 1087.8912108789216, 1096.7313008313015, 1138.1350173867754, 8847.46915185078, 10444.582216711246, 10491.947540262403, 10521.684349469528, 10632.468376581295, 562429.0, 565681.0, 569633.0, 576370.0, 591370.0, 94183.0, 96953.0, 97743.51128244455, 98724.0, 100354.0, 1163.8428812110258, 1165.6677846813618, 1176.2707121584672, 1180.4805885410565, 1202.2185579373477, 16741.246643901297, 16800.327986880387, 16932.661346773242, 17081.82918170852, 17200.655986880443, 40399.3940090893, 40442.39336409897, 40631.39052914149, 41782.79108604559, 41787.32850685938, 53539.0, 60697.39302607094, 61797.38202618096, 61921.69039154775, 62944.68527657333, 8645.8703119452, 8650.697225597074, 8952.418092823946, 8960.641574336954, 9095.226905713089, 9198.0, 12533.185342952678, 12635.557755478514, 13519.459221631418, 14079.225642589347, 11430.885691142983, 11637.88362116368, 11648.242864213798, 11662.94168529152, 12008.63974080779, 10976.945115274373, 11871.76256474883, 12051.51793928233, 12063.879361206627, 12279.386030698251, 11099.72250693739, 11433.885661143282, 11602.883971160518, 11761.117916156152, 12076.51693932233, 8474.533900635524, 8631.39580229403, 8774.517401542977, 8972.730818075468, 9129.680461183827, 8328.583570821313, 10400.791984160425, 10942.671719848417, 11141.442927853737, 11450.312981221154], "value": 9547.108926204395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1547.953561393158, 1581.3200323860735, 1765.8675599330045, 1892.5079479335386, 1912.2542208538664, 7278.30856068674, 8162.102168761447, 8277.46196497228, 8526.829463410735, 8537.0, 8489.702860399888, 8492.915070849305, 8546.316294696426, 8549.91450085499, 8583.184597463247, 2405.338531903723, 2413.1312727418117, 2436.792872605831, 2437.2688193541953, 2458.7418321076298, 2415.070197973784, 2425.9514809703796, 2440.2191298784396, 2471.0, 2473.6536884836137, 2403.218953840009, 2433.6957880264968, 2436.4639779248537, 2441.1455990403306, 2457.8893949772305, 2395.5328710901467, 2419.0, 2421.685180926486, 2425.4785221177353, 2461.310832966772, 2381.666566680666, 2402.951940961171, 2440.694913135858, 2450.191436825861, 2453.386653336666, 8489.745307640718, 8505.702300419456, 8513.616887240089, 8537.914620853775, 8566.828663426759, 5212.166053431471, 5237.214417837316, 5292.153255479105, 5297.576193904517, 5303.840884773463, 3460.1349662584353, 3467.1158854492196, 3546.2730140321432, 3548.201654627714, 3613.331533666254, 1208.7522057978094, 1248.063952035973, 1251.837261156053, 1257.145141303913, 1291.5092264939358, 11332.0, 11487.597934072268, 11498.42507874603, 11521.251118677259, 11580.131490138274, 4431.069475410135, 4431.512533621299, 4502.189605870909, 4527.0, 4555.180067587866, 9440.669576564787, 9554.426734395958, 9576.521173941275, 9585.329026968046, 9595.23238140947, 5152.5362717354865, 5164.225366195025, 5200.427952925175, 5203.661761985459, 5213.426523082458, 4261.829526818955, 4634.884127896762, 4683.601893838993, 4723.598494128038, 4842.5157484251295, 4053.43251944728, 4065.4511640928686, 4073.165001174752, 4109.869785808866, 4169.2703776838935, 1300.6033159886135, 1363.9454421823016, 1368.4321006782272, 1372.5607805502343, 1382.1154461144874, 932.8600709893434, 1084.0947808579767, 1107.7895199912152, 1109.8168802147554, 1113.4766659669942, 5663.490285874209, 5790.218320526759, 5840.649561026352, 5869.8239052828485, 5905.734241959036, 447.4161219608377, 451.0347855589042, 453.6869560003587, 468.5361492122774, 486.70311110222735, 4044.9797751011647, 4082.7346222495444, 4114.259433302034, 4118.990847242445, 4140.523839758406, 9527.333086684004, 9847.852282215772, 9931.106200441995, 9945.950270248748, 9973.900260997443, 9625.181859542017, 9722.222222222346, 9770.804583908282, 9815.607375705034, 9823.656172033945, 7757.9224207758325, 7796.532208067534, 7974.043114826258, 8041.236082572146, 8050.59747012647, 5514.0, 5733.3406658234835, 5773.538116950718, 5787.074068149076, 5863.2670916135485, 8124.63439145228, 8319.126491718282, 8351.20663536963, 8398.286145677686, 8429.157084291523, 8433.283170930294, 8452.070272270168, 8518.275946544612, 8562.143785621389, 8597.65609375643, 6760.93239067603, 7097.290270972861, 7218.602976836324, 7313.890291645524, 7525.059367579052, 7774.105977812624, 7913.248241417056, 7924.881126783218, 7939.920600794149, 7980.401469889665, 7056.259092795182, 7302.9269707304375, 7321.267873212636, 7364.5581265124265, 7419.258074192538, 7270.6728197230195, 7308.488405811755, 7324.597147156957, 7324.926750732425, 7366.226546212785, 6782.25395206517, 6783.660816959034, 6786.898196526958, 6807.5575087619145, 6858.3827455529245, 4804.5195480451675, 4887.095887260726, 5012.423571289202, 5138.203578445347, 5143.202803565453, 4945.950540494549, 5064.5441910228255, 5088.109580823267, 5159.303494028408, 5174.482551744795], "value": 4469.552188632864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.1076487252123, 357.9123114836865, 360.61774519009845, 363.48748264946414, 366.7487770876951, 6601.83495412615, 6628.204615446147, 6687.632180230085, 6728.562643428174, 6779.694913728882, 6596.802095937118, 6610.636414997185, 6652.334766523345, 6659.134312539375, 6667.833304167399, 4986.800527978886, 4989.600831933455, 4991.7504124793795, 4998.10034193845, 5016.899662006757, 4999.775010124535, 5014.348134742497, 5016.49835016499, 5016.871203979112, 5032.119379108642, 4971.154903666367, 4977.6266779991465, 4978.2532620107095, 4982.103221420143, 5013.573846223076, 4899.093667671492, 4970.329005584236, 4977.527134922177, 4984.725840078794, 4985.825496107637, 4270.743755374688, 4308.202982448257, 4312.0, 4317.438732964726, 4324.264874971231, 6332.240131184241, 6333.524985626096, 6339.746410143589, 6340.461060809836, 6352.174217351715, 5704.515116215085, 5760.74076666551, 5768.509676677446, 5780.277465316835, 5792.131180322943, 6885.414739747128, 6946.548474349202, 6950.478714096463, 6971.3028697129885, 6992.0, 4685.554872287162, 4760.976195119037, 4768.546988036166, 4779.163646361872, 4786.353842231289, 7151.463640227003, 7183.245759195262, 7189.27457410223, 7247.20280769115, 7260.6732697028765, 4837.588804951548, 4855.417349918032, 4868.3427737255015, 4868.707877527359, 4887.511248875155, 4936.851894443173, 4938.456769755324, 4939.678920870132, 4941.50584941503, 4945.67853089548, 5721.685307308138, 5739.053056245756, 5740.167675687086, 5748.396418376094, 5757.942420575824, 6794.320567943166, 6962.7911162665205, 6984.720611175598, 7016.614086225307, 7027.051348068047, 1711.4951089428648, 1723.83623555762, 1739.1478175694072, 1740.617064245864, 1740.7998080220937, 1104.9337039777638, 1115.6262652011667, 1130.231442619027, 1131.6718151735904, 1133.6032388664066, 6571.704273307712, 6679.799606011828, 6859.965700171467, 6881.002254673044, 6881.587104773729, 7300.926990730131, 7301.415886729049, 7314.817129571803, 7338.41292696583, 7358.11702595692, 6748.358905903931, 6757.898631520531, 6788.219354774165, 6803.795886123424, 6825.795226143224, 3927.8036098194975, 3952.782596957195, 3953.367461206251, 3973.7814420207164, 3980.482537270136, 7366.668499917517, 7595.772126836204, 7612.923870761332, 7616.80957976055, 7638.388928885676, 7403.0, 7408.703651853865, 7412.555246685216, 7419.443541734391, 7441.516301440389, 7547.886781698169, 7557.5465472071855, 7592.430567707444, 7613.847723045508, 7685.11621163551, 7215.0, 7335.1197856257595, 7337.376323012603, 7342.302481264272, 7427.888581671171, 7227.7831665050135, 7238.855222895618, 7241.0, 7254.5647261164495, 7255.709771609077, 7635.083789945242, 7638.236176382317, 7641.808954775953, 7643.464957452925, 7643.617819108911, 4883.804647814048, 4914.5822605078965, 4923.630727695366, 4935.358403407534, 4944.75276236194, 7025.543339682904, 7330.303621155982, 7338.156112047183, 7339.926600733925, 7348.816279593053, 7049.29507049291, 7091.361777440055, 7129.073220481304, 7132.179799323144, 7148.428125749823, 6943.201531823703, 7029.543079700008, 7072.3634872861685, 7084.822879428056, 7104.715811367694, 6938.098047254027, 6948.513604047668, 6948.826279343057, 6951.339622735832, 6954.235034146139, 7012.509124361246, 7062.081929349151, 7113.039739635083, 7129.821754455973, 7146.392556632744, 6654.268030516736, 6846.931530684828, 6891.517593768589, 6955.686994085379, 6998.6500674967065], "value": 5271.103452234749, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.4218821048635, 918.6509126531919, 942.6606421688195, 963.3689933093826, 964.5996911281818, 14857.479988200415, 15061.472848450307, 15197.0, 16793.160341982883, 17312.740308895376, 15846.76229856553, 15967.600809979756, 15995.600109997256, 16004.679906401865, 16059.036457812539, 916.6654171227487, 928.2342067794063, 932.4871320773582, 933.2953620016877, 934.7149119518544, 921.3320342751518, 930.9162175404213, 957.6935380678186, 960.6541645007792, 960.9231261499064, 988.8763904511936, 992.9900700993006, 993.3096497933939, 994.0208894239169, 996.1184351848593, 979.5347210075229, 979.8432250839903, 983.5279066048302, 987.8962708915532, 989.6288891665625, 725.6045455226862, 731.403905816763, 732.5714457042636, 733.4609062339176, 733.7431898835365, 16000.919995400065, 16129.112898790561, 16144.434944776876, 16155.0, 16175.83824161755, 14601.853981460155, 14653.194074325907, 14654.194019328932, 14666.70666586673, 14753.926230368887, 11254.568330237862, 11581.710457238552, 11660.242084264495, 11737.530498780125, 11802.645920622395, 4001.7598944063157, 4005.9584508027833, 4030.5767894371256, 4040.5959404059654, 4142.91714165715, 55368.0, 56393.43606563923, 56784.716076419354, 58368.124478132864, 59114.40885591132, 11228.98939095469, 11294.152938529644, 11528.538858445736, 11614.767704646029, 12143.210691305037, 19738.60522789536, 19830.405087847386, 19846.90076549608, 19893.801061989485, 19928.50178745514, 8513.653458331008, 8670.696525621574, 8763.167499087576, 9060.411073280216, 9115.635374585076, 4977.253411988158, 5068.265101560253, 5144.794208231704, 5146.614003949719, 5188.948110518922, 3521.859125634946, 3562.71498280137, 3578.1054736315923, 3605.260921511084, 3608.855645774192, 661.0810972747885, 662.1822049768532, 667.5260564998905, 672.3108813466237, 676.7800464848943, 831.5135645647243, 846.9830603387898, 849.7875531117221, 853.9359548033798, 866.9739907802776, 9912.405255684682, 9967.302288839712, 10025.097741203326, 10033.749156271151, 10250.231232657581, 800.9467550171622, 836.0260296754213, 843.8396704626101, 846.8602680557763, 857.4812238595559, 4603.217453032992, 4777.474477807438, 4862.17343051682, 4884.0, 4888.95111048885, 60091.39908600946, 61746.38253617496, 62092.0, 62399.6880015597, 62423.687881560305, 47896.0, 48816.26775598369, 49093.509064908896, 49267.0, 49597.75201123971, 44535.0, 44777.0, 44787.65637030894, 45060.54939450629, 45467.54532454699, 10240.897591024292, 10308.203363572751, 10381.792364152825, 10408.167346612405, 10461.843072353768, 35535.822320888234, 36102.27795444129, 36361.27277454489, 37161.628383716896, 38698.80650596729, 45710.54289457196, 47750.283745743145, 48166.27750583674, 48557.0, 48733.756331218116, 12880.484780608671, 12924.806127907901, 13025.088243822842, 13061.608151755463, 13141.145825521311, 13942.0, 14114.78827817563, 14201.360938757987, 14289.785653215418, 14740.48408305747, 12168.87831121713, 12238.204516706386, 12646.114771966242, 12672.493100275886, 12746.490140394651, 13124.0, 13162.670933226364, 13290.269035203157, 13344.666383340495, 13808.447662093404, 12871.16337438101, 13100.868991310346, 13425.66435839112, 13444.731105378034, 13460.596182114552, 11481.36852473122, 11489.597864074718, 11611.709707257049, 11656.708582285512, 11711.355875426932, 11247.887521124683, 11380.715482113013, 11417.200795944536, 11498.19512634141, 11699.12256580777], "value": 7280.200025552572, "unit": "score"}], "name": "dromaeo_css", "value": 7606.984668733196, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 104.0, 111.0, 114.0, 113.0, 101.0, 110.0, 111.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 154.0, 178.0, 128.0, 165.0, 155.0, 137.0, 181.0, 128.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 162.0, 163.0, 165.0, 161.0, 162.0, 162.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 174.0, 73.0, 79.0, 75.0, 73.0, 174.0, 75.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 149.0, 92.0, 93.0, 92.0, 144.0, 95.0, 93.0, 140.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 120.0, 118.0, 117.0, 117.0, 118.0, 119.0, 119.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 150.0, 148.0, 149.0, 148.0, 148.0, 149.0, 147.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 62.0, 56.0, 57.0, 57.0, 60.0, 55.0, 77.0, 53.0, 53.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 81.0, 75.0, 74.0, 75.0, 73.0, 75.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 114.0, 116.0, 127.0, 115.0, 120.0, 123.0, 132.0, 135.0], "value": 121.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 169.0, 159.0, 167.0, 166.0, 166.0, 162.0, 166.0, 166.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 70.0, 68.0, 69.0, 66.0, 71.0, 65.0, 70.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1533.6000000000001, "alertThreshold": 2.0}]} 06:45:11 INFO - Return code: 0 06:45:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:45:11 ERROR - # TBPL SUCCESS # 06:45:11 INFO - Running post-action listener: _resource_record_post_action 06:45:11 INFO - Running post-run listener: _resource_record_post_run 06:45:12 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 270905344; Read time: 28; Write time: 280576 06:45:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 25235456; Read time: 0; Write time: 18236 06:45:12 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 245669888; Read time: 28; Write time: 262340 06:45:12 INFO - Running post-run listener: _upload_blobber_files 06:45:12 INFO - Blob upload gear active. 06:45:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:45:12 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 06:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:45:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:45:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:45:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:45:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:13 INFO - (blobuploader) - INFO - Done attempting. 06:45:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:45:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:45:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:14 INFO - (blobuploader) - INFO - Done attempting. 06:45:14 INFO - (blobuploader) - INFO - Iteration through files over. 06:45:14 INFO - Return code: 0 06:45:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:45:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:45:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9a4b2022c3a42d120a77c6580848a27e2f081a9345fb9ce643b00abe64d41ff618dcbc2f96358bccf92bc8607382b0d7106831ad4469cd00fd4ab1201bf620c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc7048af4da875a24c27e17b2864e42e696541f3cb37482307582fe1fee0d7dbff5d7a01ad5fc7a5cefbc522819114e24cc9a1ee5746db5381f4e4d9971113cb"} 06:45:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:45:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:45:14 INFO - Contents: 06:45:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9a4b2022c3a42d120a77c6580848a27e2f081a9345fb9ce643b00abe64d41ff618dcbc2f96358bccf92bc8607382b0d7106831ad4469cd00fd4ab1201bf620c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc7048af4da875a24c27e17b2864e42e696541f3cb37482307582fe1fee0d7dbff5d7a01ad5fc7a5cefbc522819114e24cc9a1ee5746db5381f4e4d9971113cb"} 06:45:14 INFO - Running post-run listener: copy_logs_to_upload_dir 06:45:14 INFO - Copying logs to upload dir... 06:45:14 INFO - mkdir: /builds/slave/test/build/upload/logs 06:45:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.838250 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-09 06:45:14.783155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:45:14.787862) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013 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/Mozilla-Aurora/sha512/f9a4b2022c3a42d120a77c6580848a27e2f081a9345fb9ce643b00abe64d41ff618dcbc2f96358bccf92bc8607382b0d7106831ad4469cd00fd4ab1201bf620c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc7048af4da875a24c27e17b2864e42e696541f3cb37482307582fe1fee0d7dbff5d7a01ad5fc7a5cefbc522819114e24cc9a1ee5746db5381f4e4d9971113cb"} build_url:https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9a4b2022c3a42d120a77c6580848a27e2f081a9345fb9ce643b00abe64d41ff618dcbc2f96358bccf92bc8607382b0d7106831ad4469cd00fd4ab1201bf620c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc7048af4da875a24c27e17b2864e42e696541f3cb37482307582fe1fee0d7dbff5d7a01ad5fc7a5cefbc522819114e24cc9a1ee5746db5381f4e4d9971113cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:45:14.812311) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:45:14.812642) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462800285.536476-2059895013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:45:14.897257) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:45:14.897585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:45:14.897896) ========= ========= Total master_lag: 0.17 =========