builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1462568944.42 results: success (0) buildid: 20160506113031 builduid: cb260e87b978467d9584ad224252d81c revision: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:04.420533) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:04.421013) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:04.421298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:04.509185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:04.509582) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 14:09:04-- 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% 42.8M=0s 2016-05-06 14:09:04 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118060 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:04.661490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:04.661839) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014972 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:04.765063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 14:09:04.765398) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 --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=8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 14:09:05,132 truncating revision to first 12 chars 2016-05-06 14:09:05,132 Setting DEBUG logging. 2016-05-06 14:09:05,132 attempt 1/10 2016-05-06 14:09:05,132 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98730e9d1455?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 14:09:05,680 unpacking tar archive at: fx-team-98730e9d1455/testing/mozharness/ program finished with exit code 0 elapsedTime=0.982071 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 14:09:05.783542) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:05.783895) ========= script_repo_revision: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:05.784295) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:05.784579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 14:09:05.860244) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-06 14:09:05.860610) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:09:06 INFO - MultiFileLogger online at 20160506 14:09:06 in /builds/slave/test 14:09:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:09:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:09:06 INFO - {'append_to_log': False, 14:09:06 INFO - 'base_work_dir': '/builds/slave/test', 14:09:06 INFO - 'blob_upload_branch': 'Fx-Team', 14:09:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:09:06 INFO - 'branch': 'Fx-Team', 14:09:06 INFO - 'buildbot_json_path': 'buildprops.json', 14:09:06 INFO - 'config_files': ('talos/linux_config.py',), 14:09:06 INFO - 'default_actions': ('clobber', 14:09:06 INFO - 'read-buildbot-config', 14:09:06 INFO - 'download-and-extract', 14:09:06 INFO - 'populate-webroot', 14:09:06 INFO - 'create-virtualenv', 14:09:06 INFO - 'install', 14:09:06 INFO - 'run-tests'), 14:09:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:09:06 INFO - 'download_minidump_stackwalk': True, 14:09:06 INFO - 'download_symbols': 'ondemand', 14:09:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:09:06 INFO - 'tooltool.py': '/tools/tooltool.py', 14:09:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:09:06 INFO - '/tools/misc-python/virtualenv.py')}, 14:09:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:09:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:09:06 INFO - 'installer_path': 'installer.exe', 14:09:06 INFO - 'log_level': 'info', 14:09:06 INFO - 'log_name': 'talos', 14:09:06 INFO - 'log_to_console': True, 14:09:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:09:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:09:06 INFO - 'opt_config_files': (), 14:09:06 INFO - 'pip_index': False, 14:09:06 INFO - 'sps_profile': False, 14:09:06 INFO - 'sps_profile_interval': 0, 14:09:06 INFO - 'suite': 'dromaeojs-e10s', 14:09:06 INFO - 'system_bits': '32', 14:09:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:09:06 INFO - 'title': 'talos-linux64-ix-049', 14:09:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:09:06 INFO - 'use_talos_json': True, 14:09:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:09:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:09:06 INFO - 'work_dir': 'build'} 14:09:06 INFO - ##### 14:09:06 INFO - ##### Running clobber step. 14:09:06 INFO - ##### 14:09:06 INFO - Running pre-action listener: _resource_record_pre_action 14:09:06 INFO - Running main action method: clobber 14:09:06 INFO - rmtree: /builds/slave/test/build 14:09:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:09:06 INFO - Running post-action listener: _resource_record_post_action 14:09:06 INFO - ##### 14:09:06 INFO - ##### Finished clobber step (success) 14:09:06 INFO - ##### 14:09:06 INFO - ##### 14:09:06 INFO - ##### Running read-buildbot-config step. 14:09:06 INFO - ##### 14:09:06 INFO - Running pre-action listener: _resource_record_pre_action 14:09:06 INFO - Running main action method: read_buildbot_config 14:09:06 INFO - Using buildbot properties: 14:09:06 INFO - { 14:09:06 INFO - "project": "", 14:09:06 INFO - "product": "firefox", 14:09:06 INFO - "script_repo_revision": "production", 14:09:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:09:06 INFO - "repository": "", 14:09:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:09:06 INFO - "buildid": "20160506113031", 14:09:06 INFO - "pgo_build": "True", 14:09:06 INFO - "basedir": "/builds/slave/test", 14:09:06 INFO - "buildnumber": 730, 14:09:06 INFO - "slavename": "talos-linux64-ix-049", 14:09:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:09:06 INFO - "platform": "ubuntu64_hw", 14:09:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:09:06 INFO - "branch": "fx-team", 14:09:06 INFO - "repo_path": "integration/fx-team", 14:09:06 INFO - "revision": "98730e9d1455e5819b67a7bdfcd0bc976e509ff1", 14:09:06 INFO - "stage_platform": "linux64-pgo", 14:09:06 INFO - "builduid": "cb260e87b978467d9584ad224252d81c", 14:09:06 INFO - "slavebuilddir": "test" 14:09:06 INFO - } 14:09:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:09:06 INFO - Running post-action listener: _resource_record_post_action 14:09:06 INFO - ##### 14:09:06 INFO - ##### Finished read-buildbot-config step (success) 14:09:06 INFO - ##### 14:09:06 INFO - ##### 14:09:06 INFO - ##### Running download-and-extract step. 14:09:06 INFO - ##### 14:09:06 INFO - Running pre-action listener: _resource_record_pre_action 14:09:06 INFO - Running main action method: download_and_extract 14:09:06 INFO - mkdir: /builds/slave/test/build/tests 14:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:06 INFO - https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:09:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:09:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:09:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:09:07 INFO - Downloaded 1361 bytes. 14:09:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:09:07 INFO - Using the following test package requirements: 14:09:07 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:09:07 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:09:07 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:09:07 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:07 INFO - u'jsshell-linux-x86_64.zip'], 14:09:07 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:09:07 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:09:07 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:09:07 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:09:07 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:09:07 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:09:07 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:09: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')]} 14:09:07 INFO - https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:09:08 INFO - Downloaded 23893930 bytes. 14:09:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:09:09 INFO - Return code: 0 14:09:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:09 INFO - https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:09:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:09:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:09:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:09:11 INFO - Downloaded 23893930 bytes. 14:09:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:09:12 INFO - Return code: 0 14:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:12 INFO - https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:09:13 INFO - Downloaded 10840152 bytes. 14:09:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:09:13 INFO - Return code: 0 14:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:13 INFO - https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:09:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:09:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:09:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:09:14 INFO - Downloaded 58414875 bytes. 14:09:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:09:14 INFO - mkdir: /builds/slave/test/properties 14:09:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:14 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:14 INFO - Contents: 14:09:14 INFO - build_url:https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:09:15 INFO - Running post-action listener: _resource_record_post_action 14:09:15 INFO - Running post-action listener: set_extra_try_arguments 14:09:15 INFO - ##### 14:09:15 INFO - ##### Finished download-and-extract step (success) 14:09:15 INFO - ##### 14:09:15 INFO - ##### 14:09:15 INFO - ##### Running populate-webroot step. 14:09:15 INFO - ##### 14:09:15 INFO - Running pre-action listener: _resource_record_pre_action 14:09:15 INFO - Running main action method: populate_webroot 14:09:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:15 INFO - '--tppagecycles', 14:09:15 INFO - '7'], 14:09:15 INFO - 'tests': ['tsvgm']}}, 14:09:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:09:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:09:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:09:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:15 INFO - 'talos_options': ['--disable-e10s'], 14:09:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:15 INFO - 'talos_options': ['--disable-e10s'], 14:09:15 INFO - 'tests': ['damp', 'tps']}, 14:09:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:15 INFO - 'tests': ['damp', 'tps']}, 14:09:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:09:15 INFO - 'tests': ['dromaeo_dom']}, 14:09:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:09:15 INFO - 'tests': ['a11yr', 14:09:15 INFO - 'ts_paint', 14:09:15 INFO - 'tpaint', 14:09:15 INFO - 'sessionrestore', 14:09:15 INFO - 'sessionrestore_no_auto_restore', 14:09:15 INFO - 'tabpaint']}, 14:09:15 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:15 INFO - 'ts_paint', 14:09:15 INFO - 'tpaint', 14:09:15 INFO - 'sessionrestore', 14:09:15 INFO - 'sessionrestore_no_auto_restore', 14:09:15 INFO - 'tabpaint']}, 14:09:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:09:15 INFO - 'ts_paint', 14:09:15 INFO - 'tpaint', 14:09:15 INFO - 'sessionrestore', 14:09:15 INFO - 'sessionrestore_no_auto_restore', 14:09:15 INFO - 'tabpaint']}, 14:09:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:09:15 INFO - 'ts_paint', 14:09:15 INFO - 'tpaint', 14:09:15 INFO - 'sessionrestore', 14:09:15 INFO - 'sessionrestore_no_auto_restore', 14:09:15 INFO - 'tabpaint']}, 14:09:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:09:15 INFO - 'tests': ['a11yr', 14:09:15 INFO - 'ts_paint', 14:09:15 INFO - 'tpaint', 14:09:15 INFO - 'sessionrestore', 14:09:15 INFO - 'sessionrestore_no_auto_restore', 14:09:15 INFO - 'tabpaint']}, 14:09:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:09:15 INFO - 'tests': ['a11yr', 14:09:15 INFO - 'ts_paint', 14:09:15 INFO - 'tpaint', 14:09:15 INFO - 'sessionrestore', 14:09:15 INFO - 'sessionrestore_no_auto_restore', 14:09:15 INFO - 'tabpaint']}, 14:09:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:09:15 INFO - 'tests': ['tsvgx', 14:09:15 INFO - 'tsvgr_opacity', 14:09:15 INFO - 'tart', 14:09:15 INFO - 'tscrollx', 14:09:15 INFO - 'cart']}, 14:09:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:15 INFO - 'tsvgr_opacity', 14:09:15 INFO - 'tart', 14:09:15 INFO - 'tscrollx', 14:09:15 INFO - 'cart']}, 14:09:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:15 INFO - 'talos_options': ['--disable-e10s'], 14:09:15 INFO - 'tests': ['tp5o']}, 14:09:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:15 INFO - 'tests': ['tp5o']}, 14:09:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:15 INFO - 'talos_options': ['--disable-e10s', 14:09:15 INFO - '--xperf_path', 14:09:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:15 INFO - 'tests': ['tp5n']}, 14:09:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:15 INFO - 'talos_options': ['--xperf_path', 14:09:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:15 INFO - 'tests': ['tp5n']}}, 14:09:15 INFO - 'talos.zip': {'path': '', 14:09:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:15 INFO - Running post-action listener: _resource_record_post_action 14:09:15 INFO - ##### 14:09:15 INFO - ##### Finished populate-webroot step (success) 14:09:15 INFO - ##### 14:09:15 INFO - ##### 14:09:15 INFO - ##### Running create-virtualenv step. 14:09:15 INFO - ##### 14:09:15 INFO - Running pre-action listener: _resource_record_pre_action 14:09:15 INFO - Running main action method: create_virtualenv 14:09:15 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09:15 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 14:09:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:16 INFO - Using real prefix '/usr' 14:09:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:18 INFO - Installing pip.................done. 14:09:18 INFO - Return code: 0 14:09:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe64a455f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5410>, '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 0x2ca6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca67a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', '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 14:09: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', 'pip>=1.5'] in /builds/slave/test/build 14:09: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 pip>=1.5 14:09:18 INFO - Using env: {'DISPLAY': ':0', 14:09:18 INFO - 'HOME': '/home/cltbld', 14:09:18 INFO - 'LANG': 'en_US.UTF-8', 14:09:18 INFO - 'LANGUAGE': 'en_US:en', 14:09:18 INFO - 'LOGNAME': 'cltbld', 14:09:18 INFO - 'MAIL': '/var/mail/cltbld', 14:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:18 INFO - 'MOZ_NO_REMOTE': '1', 14:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:18 INFO - 'NO_EM_RESTART': '1', 14:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:18 INFO - 'PWD': '/builds/slave/test', 14:09:18 INFO - 'SHELL': '/bin/bash', 14:09:18 INFO - 'SHLVL': '1', 14:09:18 INFO - 'TERM': 'linux', 14:09:18 INFO - 'TMOUT': '86400', 14:09:18 INFO - 'USER': 'cltbld', 14:09:18 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', 14:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:18 INFO - '_': '/tools/buildbot/bin/python'} 14:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:18 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 14:09:18 INFO - Cleaning up... 14:09:18 INFO - Return code: 0 14:09:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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', '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 0x7fe64a455f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5410>, '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 0x2ca6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca67a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', '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 14:09: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', 'psutil>=0.7.1'] in /builds/slave/test/build 14:09: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 psutil>=0.7.1 14:09:18 INFO - Using env: {'DISPLAY': ':0', 14:09:18 INFO - 'HOME': '/home/cltbld', 14:09:18 INFO - 'LANG': 'en_US.UTF-8', 14:09:18 INFO - 'LANGUAGE': 'en_US:en', 14:09:18 INFO - 'LOGNAME': 'cltbld', 14:09:18 INFO - 'MAIL': '/var/mail/cltbld', 14:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:18 INFO - 'MOZ_NO_REMOTE': '1', 14:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:18 INFO - 'NO_EM_RESTART': '1', 14:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:18 INFO - 'PWD': '/builds/slave/test', 14:09:18 INFO - 'SHELL': '/bin/bash', 14:09:18 INFO - 'SHLVL': '1', 14:09:18 INFO - 'TERM': 'linux', 14:09:18 INFO - 'TMOUT': '86400', 14:09:18 INFO - 'USER': 'cltbld', 14:09:18 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', 14:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:18 INFO - '_': '/tools/buildbot/bin/python'} 14:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:18 INFO - Downloading/unpacking psutil>=0.7.1 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:09:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:20 INFO - Installing collected packages: psutil 14:09:20 INFO - Running setup.py install for psutil 14:09:21 INFO - building 'psutil._psutil_linux' extension 14:09:21 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 14:09:21 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 14:09:21 INFO - building 'psutil._psutil_posix' extension 14:09:21 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 14:09:21 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 14:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:21 INFO - Successfully installed psutil 14:09:21 INFO - Cleaning up... 14:09:21 INFO - Return code: 0 14:09:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:09:21 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')]} 14:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:21 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')]} 14:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:21 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 0x7fe64a455f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5410>, '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 0x2ca6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca67a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', '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 14:09:21 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 14:09:21 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 14:09:21 INFO - Using env: {'DISPLAY': ':0', 14:09:21 INFO - 'HOME': '/home/cltbld', 14:09:21 INFO - 'LANG': 'en_US.UTF-8', 14:09:21 INFO - 'LANGUAGE': 'en_US:en', 14:09:21 INFO - 'LOGNAME': 'cltbld', 14:09:21 INFO - 'MAIL': '/var/mail/cltbld', 14:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:21 INFO - 'MOZ_NO_REMOTE': '1', 14:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:21 INFO - 'NO_EM_RESTART': '1', 14:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:21 INFO - 'PWD': '/builds/slave/test', 14:09:21 INFO - 'SHELL': '/bin/bash', 14:09:21 INFO - 'SHLVL': '1', 14:09:21 INFO - 'TERM': 'linux', 14:09:21 INFO - 'TMOUT': '86400', 14:09:21 INFO - 'USER': 'cltbld', 14:09:21 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', 14:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:21 INFO - '_': '/tools/buildbot/bin/python'} 14:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:09:21 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 14:09:21 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 14:09:21 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 14:09:21 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 14:09:21 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 14:09:21 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 14:09:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:09:24 INFO - Installing collected packages: mozsystemmonitor 14:09:24 INFO - Running setup.py install for mozsystemmonitor 14:09:24 INFO - Successfully installed mozsystemmonitor 14:09:24 INFO - Cleaning up... 14:09:24 INFO - Return code: 0 14:09:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:09:24 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')]} 14:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:24 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')]} 14:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:24 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 0x7fe64a455f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5410>, '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 0x2ca6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca67a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', '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 14:09:24 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 14:09:24 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 14:09:24 INFO - Using env: {'DISPLAY': ':0', 14:09:24 INFO - 'HOME': '/home/cltbld', 14:09:24 INFO - 'LANG': 'en_US.UTF-8', 14:09:24 INFO - 'LANGUAGE': 'en_US:en', 14:09:24 INFO - 'LOGNAME': 'cltbld', 14:09:24 INFO - 'MAIL': '/var/mail/cltbld', 14:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:24 INFO - 'MOZ_NO_REMOTE': '1', 14:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:24 INFO - 'NO_EM_RESTART': '1', 14:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:24 INFO - 'PWD': '/builds/slave/test', 14:09:24 INFO - 'SHELL': '/bin/bash', 14:09:24 INFO - 'SHLVL': '1', 14:09:24 INFO - 'TERM': 'linux', 14:09:24 INFO - 'TMOUT': '86400', 14:09:24 INFO - 'USER': 'cltbld', 14:09:24 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', 14:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:24 INFO - '_': '/tools/buildbot/bin/python'} 14:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:24 INFO - Downloading/unpacking blobuploader==1.2.4 14:09:24 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 14:09:24 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 14:09:24 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 14:09:24 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 14:09:24 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 14:09:24 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 14:09:26 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:27 INFO - Downloading docopt-0.6.1.tar.gz 14:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:27 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:27 INFO - Running setup.py install for blobuploader 14:09:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:27 INFO - Running setup.py install for requests 14:09:27 INFO - Running setup.py install for docopt 14:09:27 INFO - Successfully installed blobuploader requests docopt 14:09:27 INFO - Cleaning up... 14:09:27 INFO - Return code: 0 14:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:27 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')]} 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:27 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')]} 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:27 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 0x7fe64a455f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5410>, '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 0x2ca6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca67a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', '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 14:09:27 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 14:09:27 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 14:09:27 INFO - Using env: {'DISPLAY': ':0', 14:09:27 INFO - 'HOME': '/home/cltbld', 14:09:27 INFO - 'LANG': 'en_US.UTF-8', 14:09:27 INFO - 'LANGUAGE': 'en_US:en', 14:09:27 INFO - 'LOGNAME': 'cltbld', 14:09:27 INFO - 'MAIL': '/var/mail/cltbld', 14:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:27 INFO - 'MOZ_NO_REMOTE': '1', 14:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:27 INFO - 'NO_EM_RESTART': '1', 14:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:27 INFO - 'PWD': '/builds/slave/test', 14:09:27 INFO - 'SHELL': '/bin/bash', 14:09:27 INFO - 'SHLVL': '1', 14:09:27 INFO - 'TERM': 'linux', 14:09:27 INFO - 'TMOUT': '86400', 14:09:27 INFO - 'USER': 'cltbld', 14:09:27 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', 14:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:27 INFO - '_': '/tools/buildbot/bin/python'} 14:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:28 INFO - Running setup.py (path:/tmp/pip-tASTko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:28 INFO - Running setup.py (path:/tmp/pip-79sSA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:28 INFO - Running setup.py (path:/tmp/pip-ZPUmzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:28 INFO - Running setup.py (path:/tmp/pip-dq4yM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:28 INFO - Running setup.py (path:/tmp/pip-IBLfVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:28 INFO - Running setup.py (path:/tmp/pip-18Nmir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:28 INFO - Running setup.py (path:/tmp/pip-ej4gFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:28 INFO - Running setup.py (path:/tmp/pip-bvZyy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:28 INFO - Running setup.py (path:/tmp/pip-ONVg6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:28 INFO - Running setup.py (path:/tmp/pip-XcqxJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:28 INFO - Running setup.py (path:/tmp/pip-Kn1BJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:28 INFO - Running setup.py (path:/tmp/pip-L6tJjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:28 INFO - Running setup.py (path:/tmp/pip-KNS5JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:28 INFO - Running setup.py (path:/tmp/pip-1hSXpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:29 INFO - Running setup.py (path:/tmp/pip-cfm59I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:29 INFO - Running setup.py (path:/tmp/pip-DHkfIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:29 INFO - Running setup.py (path:/tmp/pip-KqjQmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:29 INFO - Running setup.py install for manifestparser 14:09:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Running setup.py install for mozcrash 14:09:29 INFO - Running setup.py install for mozdebug 14:09:29 INFO - Running setup.py install for mozdevice 14:09:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Running setup.py install for mozfile 14:09:29 INFO - Running setup.py install for mozhttpd 14:09:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Running setup.py install for mozinfo 14:09:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Running setup.py install for mozInstall 14:09:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Running setup.py install for mozleak 14:09:30 INFO - Running setup.py install for mozlog 14:09:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Running setup.py install for moznetwork 14:09:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Running setup.py install for mozprocess 14:09:30 INFO - Running setup.py install for mozprofile 14:09:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Running setup.py install for mozrunner 14:09:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Running setup.py install for mozscreenshot 14:09:30 INFO - Running setup.py install for moztest 14:09:30 INFO - Running setup.py install for mozversion 14:09:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:09:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:31 INFO - Cleaning up... 14:09:31 INFO - Return code: 0 14:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:31 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')]} 14:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:31 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')]} 14:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:31 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 0x7fe64a455f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5410>, '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 0x2ca6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca67a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', '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 14:09:31 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 14:09:31 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 14:09:31 INFO - Using env: {'DISPLAY': ':0', 14:09:31 INFO - 'HOME': '/home/cltbld', 14:09:31 INFO - 'LANG': 'en_US.UTF-8', 14:09:31 INFO - 'LANGUAGE': 'en_US:en', 14:09:31 INFO - 'LOGNAME': 'cltbld', 14:09:31 INFO - 'MAIL': '/var/mail/cltbld', 14:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:31 INFO - 'MOZ_NO_REMOTE': '1', 14:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:31 INFO - 'NO_EM_RESTART': '1', 14:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:31 INFO - 'PWD': '/builds/slave/test', 14:09:31 INFO - 'SHELL': '/bin/bash', 14:09:31 INFO - 'SHLVL': '1', 14:09:31 INFO - 'TERM': 'linux', 14:09:31 INFO - 'TMOUT': '86400', 14:09:31 INFO - 'USER': 'cltbld', 14:09:31 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', 14:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:31 INFO - '_': '/tools/buildbot/bin/python'} 14:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:31 INFO - Running setup.py (path:/tmp/pip-kOtn32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:31 INFO - Running setup.py (path:/tmp/pip-zUSmju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:31 INFO - Running setup.py (path:/tmp/pip-wumTxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:31 INFO - Running setup.py (path:/tmp/pip-l0TQzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:31 INFO - Running setup.py (path:/tmp/pip-HPYubZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:31 INFO - Running setup.py (path:/tmp/pip-atx0Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:31 INFO - Running setup.py (path:/tmp/pip-BuD4_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:31 INFO - Running setup.py (path:/tmp/pip-9RsBiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:31 INFO - Running setup.py (path:/tmp/pip-YPHQAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:31 INFO - Running setup.py (path:/tmp/pip-v3XSho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:31 INFO - Running setup.py (path:/tmp/pip-PWHEpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:32 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)) 14:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:32 INFO - Running setup.py (path:/tmp/pip-GVNZrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:32 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)) 14:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:32 INFO - Running setup.py (path:/tmp/pip-LKWu9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:32 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)) 14:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:32 INFO - Running setup.py (path:/tmp/pip-hrkOwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:32 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)) 14:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:32 INFO - Running setup.py (path:/tmp/pip-WLS708-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:32 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)) 14:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:32 INFO - Running setup.py (path:/tmp/pip-y4aKhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:32 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)) 14:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:32 INFO - Running setup.py (path:/tmp/pip-BI9XYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:32 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)) 14:09:32 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)) 14:09:32 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)) 14:09:32 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)) 14:09:32 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)) 14:09:32 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)) 14:09:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:32 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 14:09:32 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 14:09:32 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 14:09:32 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 14:09:32 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 14:09:32 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 14:09:34 INFO - Downloading blessings-1.6.tar.gz 14:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:34 INFO - Installing collected packages: blessings 14:09:34 INFO - Running setup.py install for blessings 14:09:34 INFO - Successfully installed blessings 14:09:34 INFO - Cleaning up... 14:09:34 INFO - Return code: 0 14:09:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:34 INFO - Reading from file tmpfile_stdout 14:09:34 INFO - Current package versions: 14:09:34 INFO - argparse == 1.2.1 14:09:34 INFO - blessings == 1.6 14:09:34 INFO - blobuploader == 1.2.4 14:09:34 INFO - docopt == 0.6.1 14:09:34 INFO - manifestparser == 1.1 14:09:34 INFO - mozInstall == 1.12 14:09:34 INFO - mozcrash == 0.17 14:09:34 INFO - mozdebug == 0.1 14:09:34 INFO - mozdevice == 0.48 14:09:34 INFO - mozfile == 1.2 14:09:34 INFO - mozhttpd == 0.7 14:09:34 INFO - mozinfo == 0.9 14:09:34 INFO - mozleak == 0.1 14:09:34 INFO - mozlog == 3.1 14:09:34 INFO - moznetwork == 0.27 14:09:34 INFO - mozprocess == 0.22 14:09:34 INFO - mozprofile == 0.28 14:09:34 INFO - mozrunner == 6.11 14:09:34 INFO - mozscreenshot == 0.1 14:09:34 INFO - mozsystemmonitor == 0.0 14:09:34 INFO - moztest == 0.7 14:09:34 INFO - mozversion == 1.4 14:09:34 INFO - psutil == 3.1.1 14:09:34 INFO - requests == 1.2.3 14:09:34 INFO - wsgiref == 0.1.2 14:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:34 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')]} 14:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:34 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')]} 14:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:34 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 0x7fe64a455f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5410>, '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 0x2ca6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca67a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', '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 14:09:34 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 14:09:34 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 14:09:34 INFO - Using env: {'DISPLAY': ':0', 14:09:34 INFO - 'HOME': '/home/cltbld', 14:09:34 INFO - 'LANG': 'en_US.UTF-8', 14:09:34 INFO - 'LANGUAGE': 'en_US:en', 14:09:34 INFO - 'LOGNAME': 'cltbld', 14:09:34 INFO - 'MAIL': '/var/mail/cltbld', 14:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:34 INFO - 'MOZ_NO_REMOTE': '1', 14:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:34 INFO - 'NO_EM_RESTART': '1', 14:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:34 INFO - 'PWD': '/builds/slave/test', 14:09:34 INFO - 'SHELL': '/bin/bash', 14:09:34 INFO - 'SHLVL': '1', 14:09:34 INFO - 'TERM': 'linux', 14:09:34 INFO - 'TMOUT': '86400', 14:09:34 INFO - 'USER': 'cltbld', 14:09:34 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', 14:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:34 INFO - '_': '/tools/buildbot/bin/python'} 14:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:35 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)) 14:09:35 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)) 14:09:35 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)) 14:09:35 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)) 14:09:35 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)) 14:09:35 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)) 14:09:35 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)) 14:09:35 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)) 14:09:35 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)) 14:09:35 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)) 14:09:35 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)) 14:09:35 INFO - Cleaning up... 14:09:35 INFO - Return code: 0 14:09:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:35 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 0x7fe64a455f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5410>, '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 0x2ca6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca67a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', '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 14:09:35 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 14:09:35 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 14:09:35 INFO - Using env: {'DISPLAY': ':0', 14:09:35 INFO - 'HOME': '/home/cltbld', 14:09:35 INFO - 'LANG': 'en_US.UTF-8', 14:09:35 INFO - 'LANGUAGE': 'en_US:en', 14:09:35 INFO - 'LOGNAME': 'cltbld', 14:09:35 INFO - 'MAIL': '/var/mail/cltbld', 14:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:35 INFO - 'MOZ_NO_REMOTE': '1', 14:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:35 INFO - 'NO_EM_RESTART': '1', 14:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:35 INFO - 'PWD': '/builds/slave/test', 14:09:35 INFO - 'SHELL': '/bin/bash', 14:09:35 INFO - 'SHLVL': '1', 14:09:35 INFO - 'TERM': 'linux', 14:09:35 INFO - 'TMOUT': '86400', 14:09:35 INFO - 'USER': 'cltbld', 14:09:35 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', 14:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:35 INFO - '_': '/tools/buildbot/bin/python'} 14:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:35 INFO - Downloading/unpacking jsonschema 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 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 14:09:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:37 INFO - Downloading/unpacking functools32 (from jsonschema) 14:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:37 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:37 INFO - warning: no files found matching '*.txt' 14:09:37 INFO - no previously-included directories found matching 'build' 14:09:37 INFO - no previously-included directories found matching 'dist' 14:09:37 INFO - no previously-included directories found matching '.git*' 14:09:37 INFO - Installing collected packages: jsonschema, functools32 14:09:37 INFO - Running setup.py install for functools32 14:09:37 INFO - warning: no files found matching '*.txt' 14:09:37 INFO - no previously-included directories found matching 'build' 14:09:37 INFO - no previously-included directories found matching 'dist' 14:09:37 INFO - no previously-included directories found matching '.git*' 14:09:37 INFO - Successfully installed jsonschema functools32 14:09:37 INFO - Cleaning up... 14:09:37 INFO - Return code: 0 14:09:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:37 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 0x7fe64a455f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5410>, '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 0x2ca6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca67a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', '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 14:09:37 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 14:09:37 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 14:09:37 INFO - Using env: {'DISPLAY': ':0', 14:09:37 INFO - 'HOME': '/home/cltbld', 14:09:37 INFO - 'LANG': 'en_US.UTF-8', 14:09:37 INFO - 'LANGUAGE': 'en_US:en', 14:09:37 INFO - 'LOGNAME': 'cltbld', 14:09:37 INFO - 'MAIL': '/var/mail/cltbld', 14:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:37 INFO - 'MOZ_NO_REMOTE': '1', 14:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:37 INFO - 'NO_EM_RESTART': '1', 14:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:37 INFO - 'PWD': '/builds/slave/test', 14:09:37 INFO - 'SHELL': '/bin/bash', 14:09:37 INFO - 'SHLVL': '1', 14:09:37 INFO - 'TERM': 'linux', 14:09:37 INFO - 'TMOUT': '86400', 14:09:37 INFO - 'USER': 'cltbld', 14:09:37 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', 14:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:37 INFO - '_': '/tools/buildbot/bin/python'} 14:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:37 INFO - Downloading/unpacking flake8 14:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:09:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:09:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:09:40 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 14:09:40 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 14:09:40 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 14:09:40 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 14:09:40 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 14:09:40 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 14:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:09:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:40 INFO - no previously-included directories found matching 'docs/_build' 14:09:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:09:40 INFO - Running setup.py install for pep8 14:09:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:40 INFO - no previously-included directories found matching 'docs/_build' 14:09:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:09:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:09:40 INFO - Cleaning up... 14:09:40 INFO - Return code: 0 14:09:40 INFO - Running post-action listener: _resource_record_post_action 14:09:40 INFO - Running post-action listener: _start_resource_monitoring 14:09:40 INFO - Starting resource monitoring. 14:09:40 INFO - ##### 14:09:40 INFO - ##### Finished create-virtualenv step (success) 14:09:40 INFO - ##### 14:09:40 INFO - ##### 14:09:40 INFO - ##### Running install step. 14:09:40 INFO - ##### 14:09:40 INFO - Running pre-action listener: _resource_record_pre_action 14:09:40 INFO - Running main action method: install 14:09:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:40 INFO - Reading from file tmpfile_stdout 14:09:40 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:41 INFO - Reading from file tmpfile_stdout 14:09:41 INFO - Output received: 14:09:41 INFO - Usage: mozinstall [options] installer 14:09:41 INFO - Options: 14:09:41 INFO - -h, --help show this help message and exit 14:09:41 INFO - -d DEST, --destination=DEST 14:09:41 INFO - Directory to install application into. [default: 14:09:41 INFO - "/builds/slave/test"] 14:09:41 INFO - --app=APP Application being installed. [default: firefox] 14:09:41 INFO - mkdir: /builds/slave/test/build/application 14:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:09:57 INFO - Reading from file tmpfile_stdout 14:09:57 INFO - Output received: 14:09:57 INFO - /builds/slave/test/build/application/firefox/firefox 14:09:57 INFO - Running post-action listener: _resource_record_post_action 14:09:57 INFO - ##### 14:09:57 INFO - ##### Finished install step (success) 14:09:57 INFO - ##### 14:09:57 INFO - ##### 14:09:57 INFO - ##### Running run-tests step. 14:09:57 INFO - ##### 14:09:57 INFO - Running pre-action listener: _resource_record_pre_action 14:09:57 INFO - Running main action method: run_tests 14:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:09:57 INFO - Python 2.7.3 14:09:57 INFO - Return code: 0 14:09:57 INFO - grabbing minidump binary from tooltool 14:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:57 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 0x2ca5410>, '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 0x2ca6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:09:57 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 14:09:57 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 14:09:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:09:57 INFO - Return code: 0 14:09:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:09:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:09:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:09:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:09:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:09:58 INFO - Return code: 0 14:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 14:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 14:09:58 INFO - Using env: {'DISPLAY': ':0', 14:09:58 INFO - 'HOME': '/home/cltbld', 14:09:58 INFO - 'LANG': 'en_US.UTF-8', 14:09:58 INFO - 'LANGUAGE': 'en_US:en', 14:09:58 INFO - 'LOGNAME': 'cltbld', 14:09:58 INFO - 'MAIL': '/var/mail/cltbld', 14:09:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:09:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:58 INFO - 'MOZ_NO_REMOTE': '1', 14:09:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:58 INFO - 'NO_EM_RESTART': '1', 14:09:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:58 INFO - 'PWD': '/builds/slave/test', 14:09:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:09:58 INFO - 'SHELL': '/bin/bash', 14:09:58 INFO - 'SHLVL': '1', 14:09:58 INFO - 'TERM': 'linux', 14:09:58 INFO - 'TMOUT': '86400', 14:09:58 INFO - 'USER': 'cltbld', 14:09:58 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831', 14:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:58 INFO - '_': '/tools/buildbot/bin/python'} 14:09:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 14:09:58 INFO - mozversion application_buildid: 20160506113031 14:09:58 INFO - mozversion application_changeset: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 14:09:58 INFO - mozversion application_display_name: Nightly 14:09:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:09:58 INFO - mozversion application_name: Firefox 14:09:58 INFO - mozversion application_remotingname: firefox 14:09:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:09:58 INFO - mozversion application_vendor: Mozilla 14:09:58 INFO - mozversion application_version: 49.0a1 14:09:58 INFO - mozversion platform_buildid: 20160506113031 14:09:58 INFO - mozversion platform_changeset: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 14:09:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:09:58 INFO - mozversion platform_version: 49.0a1 14:09:58 INFO - using testdate: 1462568998 14:09:58 INFO - actual date: 1462568998 14:09:58 INFO - starting webserver on 'localhost:45467' 14:09:58 INFO - SUITE-START | Running 2 tests 14:09:58 INFO - TEST-START | dromaeo_css 14:09:58 INFO - operating with platform_type : linux_ 14:09:58 INFO - Initialising browser for dromaeo_css test... 14:09:58 INFO - TEST-INFO | started process 15185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdBbuMH/profile http://localhost:45467/getInfo.html) 14:10:02 INFO - PROCESS | 15185 | 14:10:02 INFO - PROCESS | 15185 | (process:15252): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:10:03 INFO - PROCESS | 15185 | __metrics Screen width/height:1600/1200 14:10:03 INFO - PROCESS | 15185 | colorDepth:24 14:10:03 INFO - PROCESS | 15185 | Browser inner width/height: 1024/697 14:10:03 INFO - PROCESS | 15185 | __metrics 14:10:03 ERROR - PROCESS | 15185 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:10:04 INFO - TEST-INFO | 15185: exit 0 14:10:04 INFO - Browser initialized. 14:10:04 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:04 INFO - TEST-INFO | started process 15303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdBbuMH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:06 INFO - PROCESS | 15303 | 14:10:06 INFO - PROCESS | 15303 | (process:15363): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:10:16 INFO - PROCESS | 15303 | RSS: Main: 163557376 14:10:16 INFO - PROCESS | 15303 | 14:11:05 INFO - PROCESS | 15303 | 1462569065994 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] 14:13:13 INFO - PROCESS | 15303 | Cycle 1(1): loaded http://localhost:45467/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45467/tests/dromaeo/cssquery-ext.html) 14:13:14 INFO - PROCESS | 15303 | RSS: Main: 165572608 14:13:14 INFO - PROCESS | 15303 | 14:16:16 INFO - PROCESS | 15303 | Cycle 1(1): loaded http://localhost:45467/tests/dromaeo/cssquery-ext.html (next: http://localhost:45467/tests/dromaeo/cssquery-jquery.html) 14:16:17 INFO - PROCESS | 15303 | RSS: Main: 166703104 14:16:17 INFO - PROCESS | 15303 | 14:19:19 INFO - PROCESS | 15303 | Cycle 1(1): loaded http://localhost:45467/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45467/tests/dromaeo/cssquery-mootools.html) 14:19:19 INFO - PROCESS | 15303 | RSS: Main: 168026112 14:19:19 INFO - PROCESS | 15303 | 14:22:21 INFO - PROCESS | 15303 | Cycle 1(1): loaded http://localhost:45467/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45467/tests/dromaeo/cssquery-prototype.html) 14:22:22 INFO - PROCESS | 15303 | RSS: Main: 165470208 14:22:22 INFO - PROCESS | 15303 | 14:25:24 INFO - PROCESS | 15303 | Cycle 1(1): loaded http://localhost:45467/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45467/tests/dromaeo/cssquery-yui.html) 14:25:25 INFO - PROCESS | 15303 | RSS: Main: 166449152 14:25:25 INFO - PROCESS | 15303 | 14:28:27 INFO - PROCESS | 15303 | Cycle 1(1): loaded http://localhost:45467/tests/dromaeo/cssquery-yui.html (next: http://localhost:45467/tests/dromaeo/cssquery-dojo.html) 14:28:27 INFO - PROCESS | 15303 | RSS: Main: 168775680 14:28:27 INFO - PROCESS | 15303 | 14:28:27 INFO - PROCESS | 15303 | __start_tp_report 14:28:27 INFO - PROCESS | 15303 | _x_x_mozilla_page_load 14:28:27 INFO - PROCESS | 15303 | _x_x_mozilla_page_load_details 14:28:27 INFO - PROCESS | 15303 | |i|pagename|runs| 14:28:27 INFO - PROCESS | 15303 | |0;dojo.html;3154.1641465011776;3167.5565420841085;3185.490321548552;3195.680431956806;3215.2122729931157;5335.386430560482;5347.919781203285;5357.383900851399;5439.5920305977115;5481.369642491115;5300.072487314724;5410.5401040911565;5448.618596698233;5466.972665136679;5469.644473109245;4894.804207831691;4936.086823937565;4989.052080104787;5052.9747351263195;5108.744562771846;4937.753112344369;5093.516115968995;5120.257562653413;5128.4102328232175;5135.897282054357;4888.804447822083;4922.556969872693;4944.134776414113;4951.752412379366;4959.727215003173;4972.328735620681;4972.676776009584;4980.377452818398;4987.102321582114;5025.497450254945;4947.579455746266;4948.703077815343;4954.950450495485;4967;5002.049610574016;5218.2955301034635;5264.894372181808;5352.090144675414;5405.567554595662;5440.619156659035;5865.824025279248;5868.882622347572;5876.823695289148;5895.056790913433;5897.734601942923;5780.739866706008;5904.9704751475965;5929.851753706149;5934.792282270143;5951.761929522814;5357.491038351351;5366.6511676741275;5406.270153529302;5413.783448662049;5419.945800542023;5884;5890.676012819336;5891.116332550066;5897.056470964625;5899.380565040609;5558.277423934944;5625.887482250332;5629;5633.492985631313;5634.97182514093;5759.308882933991;5765.971170144207;5772.94227057724;5776.335721392094;5835.328937172279;5679.716014199274;5717.256756621613;5718.628289161191;5726.541876649858;5726.685032323262;5549.5837812164245;5734.541236701054;5746.540276777848;5775.364709881909;5785.1322301654245;4382.69321147523;4407.449068866392;4412.624926881187;4413.3821265022925;4428.911421771547;3948.7433316834313;3964.7224694271126;3971.860984865516;3977.423273625308;3993.4608827808456;5451.400345961941;5522.5581953443625;5554.583406244547;5556.91664625031;5587.161925711176;5804.767809287666;5817.534597232211;5847.356790753014;5855.443732845373;5894.764209431574;5552.222688823568;5560.277163968658;5562.888742225133;5567.415421380778;5575.860603484864;4887.682300650446;4972.90054198914;4973.925391119136;5011.173156429221;5022.121128802445;6047.244094488189;6056.818295451144;6066.575339726177;6074.939250607437;6085.5435842312;5876.294844618673;5881.32364778056;5885.264341957255;5895.64626122434;5918.911216331672;5879.5002424792665;5892.234009578728;5937.5249980000635;5961.91057134152;5985.042393217064;5678.346990096026;5691.3170419549915;5693.658380497183;5705.4579814917515;5714.171445140349;5690.630109042899;5770.798022069207;5789;5793.594448388572;5795.565332599987;5579.721013949205;5626.662400255997;5663.886722265449;5683.943160568341;5684.516816070681;5520.834374968757;5577.637453565505;5653.123765816305;5663.886722265449;5715.857103572278;5614.101743720985;5622.3815380307315;5623.746931388016;5627.0434026214825;5653;5603.131514615078;5621.409751976147;5623.8875222496135;5633.267675202197;5654.236678048411;5534.723263836872;5542.0855558832345;5548.445155484419;5556.416576259435;5590.468905453975 14:28:27 INFO - PROCESS | 15303 | |1;ext.html;590.5688847141587;653.483747839207;666.5700623098098;666.5733930284619;686.5091459606381;37078;41917.371239431435;42092.57907420929;42174;42434;41493.37759933603;41985.790071049676;42036.78981605088;42170.7891460543;42186.789066054705;8730.476171429718;8795.95602021989;8862.911370886306;8887.644494220223;8889.422187557788;8642.697505587306;8757.7810554736;8768.517731524764;8805.559722013906;8826.514541700204;8772.473651580925;8801.427907186044;8822;8823.867641985375;8869.290456763443;8743.30053595714;8778.824423511558;8797.692080777206;8803.251723603502;8816;8718.607662655133;8722.215000649972;8763.12368763125;8764.780880477976;8796.780080497974;39827.40258896119;39832;39966.200675986314;39992.80003599964;40012;3510.5260789793306;3755.605661405568;4009.3384591542363;4088.632023117934;4297.871063868089;31407.528887066714;31620;31996.200094997577;32055.83972080148;33988.83005584981;4298.355246712987;4330.198913201068;4371.0820727646915;4475.306327519207;4509.458864936196;317669;319531;320121;320398.9800509965;322763;34605.65394346075;35170.648293517246;35318;37497;55947;37352.62647373546;37396.252074958895;37431.4385284221;37465;37634.8118259407;15491.612709682122;15606.609834754221;15606.687866242612;15631.609209769847;15692.529224123295;12205;12224.083193760503;12248.938755306166;12315.014798816073;12319.815202771966;8500.914990850137;8534.957325213458;8548.700795472128;8556.058833528306;8684.348673849487;3388.423967925459;3399.9320013600086;3407.539982102434;3430.794152350867;3461.2039230977016;1056.9735756606146;1070.9571617135384;1083.0847933496184;1112.393745408738;1271.968200794969;29109.708902911123;30737.538936915964;30788.30540335174;31044.379112417624;31795.84102079475;1158.6292386436428;1167.4046236419488;1169.5497233565138;1174.7121955120879;1224.675461002835;16227.918860405622;16284.918575407048;16328.673426531403;16621.66756664884;16720.16399180036;451965;455344;458937;459182;460066;57777.42222577804;58355;58674;58814;58829;1338.1837079381569;1394.6164804678592;1423.2172305232082;1429.1996481969923;1436.3608194353621;29868.402631947672;30011.099667010025;30483.2639433824;30509.389812204077;30826.383472330876;48556.5144348552;48774;49302.26046609232;49309.753451232515;49358.50641493539;422277;428028;428048;429842;433285;27372.178834634993;27754.44491110207;28063.859680701466;28148.577771333858;28308.150755477367;47514.76242618765;47762;47888.2816757742;48456.27315590198;48983.26525102055;40214.597854021085;40995.79502102471;41872.1625567493;41923;42218.36672449854;39910.80044599874;40308.39537406882;40589.39115913323;40702.59297406988;41096.589034109275;40622;41785.16429671329;43334.56665433432;43452.565474344854;45427.54572454233;35833.82083089568;36787.63212367842;37170.25659486849;37444;37593.81203093967;28906;29135.562966555943;29355.11934641964;29463.410731785672;29540.556891646214 14:28:27 INFO - PROCESS | 15303 | |2;jquery.html;379.8214839025659;383.9347310957138;386.11386867139913;393.21553500765975;407.4947065638609;17285.913570432145;19247.23011079555;19723.605527889435;19736.111874965623;19899.502512437197;18571.814281857176;18621.720674189863;18815.30662240398;18850.43448696538;19103.52241193971;5495.560355171597;5664.178694089365;5774.624649397776;5822.417758224186;5824.563157763164;5705.828825135252;5710.885782284352;5745.798897038604;5749.741261643236;5750.993576124182;5333.70664613448;5560.36055853578;5663.773449062032;5688.744006519696;5727.083666613343;5630.324361076677;5677.772889084432;5714.657120572758;5768.278965129359;5977;5744.971275143639;5765.250517432749;5769.740361683693;5784.1034639630925;5806;13285.73428531424;13544.119407750246;21801.127954881787;22392.77607223923;22485.662715059123;2271.6251818449937;2279.3845661671257;2392.485615592656;2451.4361696809833;2933.5013047781927;9828.21374290055;10098.192144628412;10100.090991810699;10104.94947525265;10410.635627753069;1998.2506560039985;2009.0557438004114;2020.7474065741783;2070.5444802143506;2100.8004239597367;62549;74811;82041.58979205065;84137.57931210365;85624.57187714084;10437.739056523496;10739.785204296026;10905.127589792797;10922.72693182661;10936.617218397318;15084.698306033817;15109.848901510844;15159.24203789806;15321.846781532042;15382.461613843461;7821.687132514636;8034.517928924283;8105.797355066171;8349.45728527656;8383.077861435237;7931.801704957422;8063.193680632007;8194.67221311141;8237.423380363436;8340.958295208606;4557.886052848706;4609.1703493371515;4609.769511524478;4667.8366257181515;4708.058388322349;1885.4720678210124;1893.1764682363216;1935.167877812526;1937.0798870536382;1964.4695932098252;901.693424235763;995.785906030207;1092.5138313450598;1094.1192340166242;1138.0781566930812;18626.813731862778;18802.34191803308;19301.80698193028;19413.708794368096;19476.254504921082;1015.5531566110888;1049.8057859295902;1050.9947450262853;1074.4305518075432;1100.0979197058334;10176.745581360525;10608;10725.195610329256;10747.301425407324;10764.677059688222;489068;497520.07439776865;499777;517639;518673;86956.56521717478;92277;92358.53820730853;92411.53794230986;92715;1034.3225187502198;1047.617619568852;1101.366714139373;1120.7030137013699;1121.3384103379046;16595.91702041482;16957.74563381575;16976.23606937666;17057.232424541173;17193.57016074608;37261.81369093137;38475.230495389376;39077;39932.20135597214;40274.194516108924;52002.73998629983;53654.73172634112;54333;54576.72711636575;54717.45282547283;8376.83246335082;8477.364197685074;8568.828623427622;8589.398742087993;8629.95685021596;9761.85357219628;13161.736765264832;13177.27524986135;13408.798868016793;13587.32063396846;11439.485223164811;11576.768464630492;11602.70993225176;11684.824727629262;11984.64046078619;11468.770624587629;11497.712557185803;11514.53941842317;11515.19393642437;11765.235259708092;11592.420378980849;11621.477033533341;12010.879891201326;12197.573084941985;12256.509739610672;7145.535540190079;7598.96200519016;8501;8615.913840861762;8692.695755648521;10939.234253602172;11235.71910702239;11481.253718508271;11617.186796924134;11704.824427633763 14:28:28 INFO - PROCESS | 15303 | |3;mootools.html;1318.3276528970225;1355.8711922367372;1423.1603354021127;1511.13109961772;1512.8033355663763;7871.2128787121255;8438.451500652462;8561.186687264715;8975.506347150904;9088.13662702044;8654.134586541342;8927.776805579864;8932.285417166628;8967.95516022419;8980.775480612989;2298.977010229901;2327.325075728037;2332.918347857825;2334.4514039200776;2335.3577766114286;2346.7887890089887;2360.209329874494;2375.9881200593973;2376.192094687806;2385.320183747632;2353.0705371378294;2354.446705024318;2374.097842819726;2388.868612226327;2398.4483568779106;2243.0130742473343;2246.05665620439;2249.8312626553075;2259.6271615183473;2308.1690591387087;2255.729312482496;2256.8533045352;2262.3552287597954;2262.4570103175283;2262.5814224368546;8642.567871606458;8810.251128654072;8810.735677929672;8817.823643527094;8824.205821476098;5191.818286359997;5352.4915133062295;5353.839384818461;5353.946460535422;5356.54469370104;3452.879149229765;3498.2303893143467;3632.237230181665;3634.400323946572;3678.2091850252054;1170.3504554971987;1195.4261954262004;1201.5133870782347;1207.963761087169;1225.462045133352;12201.145919785618;12211.572594959223;12216.2670239785;12271.263724176579;12298.385080745928;4690.179218636725;4690.695104818176;4812.903741925142;4827.275908613736;4833.879153021132;10317.071463568314;10338.689839304832;10342.534585943651;10356.17150627948;10373.896261037293;5293.788248470018;5331.653442526223;5332.973335133377;5356.91964620531;5394.433584473652;4364.083542456056;4733.479317275097;4867.780949857265;4904.705717656952;4972.303877457159;3922.0783115967724;3950.6444420001762;3961.7028722845903;4034.5561988181275;4071;1244.6701624069628;1251.6808213905397;1269.0355329949305;1280.667026573079;1282.4805953588625;1013.4476710192963;1017.6336518853354;1017.7048655889857;1039.158281791736;1048.4128887822692;5971.724412584662;5982.910256346158;6065.636061836304;6159.291681456601;6228.968855155786;439.52970321756055;456.8127067902144;465.54376710823584;471.08609297961846;1031.7575369788094;4189.476315460567;4299.462567179103;4329.480462344539;4329.800560736483;4447.733136011785;10900.50947707355;11237.381943992996;11271.380074096003;11329.660110196708;11352.545898164146;11143;11145.777084458265;11173.441327933571;11223.158263130297;11226.494807733672;7917.643706033243;8001.8399632008195;8291.253787159185;8292.419530632798;8350.24847763692;6086.756529738761;6173.228346456693;6184.659843708459;6233.781817636361;6351.841203969938;9900.752481188028;10053;10178.694639160836;10213.540390682585;10290.073893349336;10257.128144107834;10331.638392656221;10562.524686388977;10577.100946419641;10697.572097116028;7002.2647622000995;7536.773896783106;7736.535807851547;7816.374690024671;7912.28789408933;8448;8458.111898250596;8500.404971651926;8554.31565474773;8600.827983440171;7404.481686282124;7718.112417071884;7752;7763.534187948741;7830.412719046209;7143.392811610864;7362.7423040193335;7507.249275072668;7593.240675932362;7618.96190519066;7105.147382313949;7119.074520312326;7169;7202.96398518004;7211.278872112747;5225.320708307896;5253.212018197301;5356.089464791073;5369.48989845964;5437.157240627709;5116.6418350716585;5121.718305493234;5188.481151884781;5219.138842091164;5389.919151212814 14:28:28 INFO - PROCESS | 15303 | |4;prototype.html;333.5413806016727;340.1309653834452;343.7610860451985;343.85214357826135;344.0589986387232;5459.317585301837;5583.469570390816;5588.720563971806;5617.691026993513;5618.9604923089255;5449.139201918984;5496.4503549645015;5518.696471694056;5562.16567514873;5576.525995290405;4096.85661001865;4168.520620128678;4287.871363859089;4296.64655633476;4301.505326887417;4221.282381995053;4251.107267473834;4267.573242675739;4286.485621725382;4320.935185972213;4302.612764851163;4303.870883873473;4309.806058727349;4319.69762116652;4328.826846926135;4024.5975402459667;4225.767582782945;4270.466191726035;4283.121959998193;4304.483461984566;3714.758540694846;3720.8697695580527;3724.348239058154;3726.9440958385644;3745.250949810049;5309.150535914235;5328.387235467932;5353.357597088336;5371.409144994048;5377.516023557899;4615.492295847454;4871.196252618313;4877.951220487821;4911.533404326583;4911.705297682151;5724.627899186539;5780.9710951445395;5783.624064435799;5788.160716696056;5792.507636850873;4148.896277593054;4163.417121602978;4167.708260421772;4172.059992103656;4186.790660466964;5885.823425297248;6003.6397816131175;6033.788817391414;6041.426064523863;6121.969390153065;4172.4993000840095;4174.666026717855;4209.663226941837;4235.7035007549175;4235.830566777356;4271.252530807096;4282.807273672693;4286.164197981364;4291.163223171452;4300.892477688083;4620.976895115503;4866.78099485524;4873.1959226727195;4939;4948.802047918043;5767.682777447197;5809.796657116981;5867.471927526458;5890.911636325459;5935.231128233603;1439.2947455746819;1440.7334643091062;1447.3848614338865;1449.7173051254904;1456.0535651826397;902.444996327254;979.1823827104448;981.8429051351892;982.8132654795565;992.2161492421051;5406.432324605859;5407.810726624628;5416.593755468356;5426.620136590401;5432.402435732066;5765.1928729977835;5770.913436298459;5784.3926387729525;5812.564057695689;5849.548766227861;5158.226266060121;5463.836084917459;5472.425395333512;5481.890362192734;5487.38122253936;3042.034016833614;3059.7705172112182;3085.182426656938;3101.17818778024;3101.5037593984853;5678.261825962681;5823.475887170091;5945.632504523897;6005;6060.909086363708;5775.220345253421;5870.236869207061;5933.199018132497;5965;6018.879622407528;5935.910961335583;5943.673097979567;5954.910676339859;5987.251593550806;6010.879782404328;5460.672359658433;5747.597668163188;5757.884842303214;5776.797812076557;5782.3639399666845;5610.410906854721;5676.2337084493065;5701.230333904869;5774.595778295479;5775.075987841925;5867.386468721136;5895.734691938959;5988.940110598838;6073;6099.634021958696;4057.91884162321;4086.959130408658;4094.385842123705;4120.711550191458;4135.635240370731;5698.914516282176;5770.221020162225;5776.162456443708;5805.41945805433;5807.8548036299435;5450.454954504517;5589.832305030855;5611.5230205433;5616.708157123966;5842.649441033552;5811.099279611667;5819.476247137609;5886.764529418775;5918.644881307136;5931.436513531207;5563.442236173878;5636.126400407943;5657.858553536194;5710.657995371168;5728.570357223308;5867.647941123546;5881.441263080001;5886.58793884424;5898.203742494708;5926.348101708722;5745.856353591026;5753.971230143822;5757.683327417032;5764.913526297193;5781.797637082682 14:28:28 INFO - PROCESS | 15303 | |5;yui.html;747.8915557244203;750.3509464313368;765.2232983521723;783.385042741448;802.6909639788681;13763.44946202152;14000.089994150374;14004.22976736279;14048.578542643725;14148.646283842883;13111.80332295014;13131.6717082073;13260.1380910241;13363;13411.128276662035;685.0819901332214;796.2753893956515;807.0678366486688;823.5017814222399;831.0775039705952;812.1310198088048;812.9065157506874;815.64927081355;819.6188772220916;824.5052968219051;879.1604018162672;879.705298724928;880.190224993008;884.9026607073217;886.8758373827669;874.8075423406872;875.6847534887436;877.6050777150276;880.9912650015729;881.7310720230328;639.0605809460086;640.7244884699577;643.7714611313011;644.0371644391664;644.1625886347776;13765.587032388945;13799.310034498336;13820.516281930184;13850.307484625728;13929.791053134211;14027.43890244389;14029.929850350683;14068.507602233873;14171.929140354232;14208.147511149364;11408.657740267723;11447.313161210272;11467.77064458706;11519.827202591969;11701.824472632918;3737.2712321097397;3753.71847111465;3835.271298453285;3914.862979795722;3921.803909804527;52055.73972130115;52357.476425236026;53230;53989;54392.18411723788;10223.496610161152;10358.26824569532;10524.789504210026;10578.947105264424;10641.361518308926;19069;19134.71297930532;19200.61598768017;19359;19364.903175484033;7914.485558438683;8053.395995300376;8083.151269116775;8097.838043239102;8210.30212431938;4804.42346918372;4817;4845.370101886732;4885.95114048855;4934.506549345037;3239.1092449576086;3358.6641335866707;3363.9663603364143;3376.7636265461183;3397.490376443504;625.9155014073133;627.3914303125961;630.2909227119491;645.3030726815028;646.5021933111478;626.0859145647406;634.514596333805;733.8055415314946;735.3235023778137;739.9408047356198;9131.497767622845;9274.072592740671;9384.202342800938;9433.90566094344;9505.239580833517;571.6712890088132;615.7136931326954;621.1645337021698;692.3111504053498;732.6007326007339;4159.480064991876;4258.190943720745;4280.464941882265;4364.236258654722;4368.126374725068;59345.40654593485;60972.69513652403;61268.77462450726;61660.691696542126;62764.37235627585;55729.44270557242;56230;56628;57465.71267143638;58424.70787646034;50825.23762143571;50912;51362.48637513652;51686;51770;7963.522188668467;8113.797155071171;8230.859976406058;8258.42191046621;8300.958495207486;33852.153696157795;33915.49126763051;34170;34708.47937280993;34908.65091349054;41954.1609167821;43929.78035109804;45413.772931135136;46130.76934615306;46625.06749865052;10821.729456763644;11002.724931876766;11061.557537698724;11088.390138542458;11333.659990200307;11841.28952262867;11867.58463453775;11942.311631090299;12136.271823690608;12177.69555761113;11118;11180.608678696206;11311.660650180507;11392.715182120513;11468.655940321803;10516.68449946503;10915.727106822393;11132;11186.216964812711;11279.09767218604;11233.013091741619;11378.37418941933;11475.254108482923;11539.4807233673;11906.404679765803;9220.538973051454;9235.12266334697;9745.122938935247;9917.603295868084;9991.150752186146;9314.860277095713;9480.525973701426;9610.759731006781;9626.614935402506;9660.661876834278 14:28:28 INFO - PROCESS | 15303 | __end_tp_report 14:28:28 INFO - PROCESS | 15303 | __start_cc_report 14:28:28 INFO - PROCESS | 15303 | _x_x_mozilla_cycle_collect,343 14:28:28 INFO - PROCESS | 15303 | __end_cc_report 14:28:28 INFO - PROCESS | 15303 | __startTimestamp1462570107990__endTimestamp 14:28:28 INFO - PROCESS | 15303 | 14:28:28 INFO - PROCESS | 15303 | ------- Summary: start ------- 14:28:28 INFO - PROCESS | 15303 | Number of tests: 6 14:28:28 INFO - PROCESS | 15303 | 14:28:28 INFO - PROCESS | 15303 | [#0] dojo.html Cycles:165 Average:5391.70 Median:5579.72 stddev:600.03 (10.8%) stddev-sans-first:575.62 14:28:28 INFO - PROCESS | 15303 | Values: 3154.2 3167.6 3185.5 3195.7 3215.2 5335.4 5347.9 5357.4 5439.6 5481.4 5300.1 5410.5 5448.6 5467.0 5469.6 4894.8 4936.1 4989.1 5053.0 5108.7 4937.8 5093.5 5120.3 5128.4 5135.9 4888.8 4922.6 4944.1 4951.8 4959.7 4972.3 4972.7 4980.4 4987.1 5025.5 4947.6 4948.7 4955.0 4967.0 5002.0 5218.3 5264.9 5352.1 5405.6 5440.6 5865.8 5868.9 5876.8 5895.1 5897.7 5780.7 5905.0 5929.9 5934.8 5951.8 5357.5 5366.7 5406.3 5413.8 5419.9 5884.0 5890.7 5891.1 5897.1 5899.4 5558.3 5625.9 5629.0 5633.5 5635.0 5759.3 5766.0 5772.9 5776.3 5835.3 5679.7 5717.3 5718.6 5726.5 5726.7 5549.6 5734.5 5746.5 5775.4 5785.1 4382.7 4407.4 4412.6 4413.4 4428.9 3948.7 3964.7 3971.9 3977.4 3993.5 5451.4 5522.6 5554.6 5556.9 5587.2 5804.8 5817.5 5847.4 5855.4 5894.8 5552.2 5560.3 5562.9 5567.4 5575.9 4887.7 4972.9 4973.9 5011.2 5022.1 6047.2 6056.8 6066.6 6074.9 6085.5 5876.3 5881.3 5885.3 5895.6 5918.9 5879.5 5892.2 5937.5 5961.9 5985.0 5678.3 5691.3 5693.7 5705.5 5714.2 5690.6 5770.8 5789.0 5793.6 5795.6 5579.7 5626.7 5663.9 5683.9 5684.5 5520.8 5577.6 5653.1 5663.9 5715.9 5614.1 5622.4 5623.7 5627.0 5653.0 5603.1 5621.4 5623.9 5633.3 5654.2 5534.7 5542.1 5548.4 5556.4 5590.5 14:28:28 INFO - PROCESS | 15303 | 14:28:28 INFO - PROCESS | 15303 | [#1] ext.html Cycles:180 Average:55183.47 Median:40448.89 stddev:107506.83 (265.8%) stddev-sans-first:107730.28 14:28:28 INFO - PROCESS | 15303 | Values: 590.6 653.5 666.6 666.6 686.5 37078.0 41917.4 42092.6 42174.0 42434.0 41493.4 41985.8 42036.8 42170.8 42186.8 8730.5 8796.0 8862.9 8887.6 8889.4 8642.7 8757.8 8768.5 8805.6 8826.5 8772.5 8801.4 8822.0 8823.9 8869.3 8743.3 8778.8 8797.7 8803.3 8816.0 8718.6 8722.2 8763.1 8764.8 8796.8 39827.4 39832.0 39966.2 39992.8 40012.0 3510.5 3755.6 4009.3 4088.6 4297.9 31407.5 31620.0 31996.2 32055.8 33988.8 4298.4 4330.2 4371.1 4475.3 4509.5 317669.0 319531.0 320121.0 320399.0 322763.0 34605.7 35170.6 35318.0 37497.0 55947.0 37352.6 37396.3 37431.4 37465.0 37634.8 15491.6 15606.6 15606.7 15631.6 15692.5 12205.0 12224.1 12248.9 12315.0 12319.8 8500.9 8535.0 8548.7 8556.1 8684.3 3388.4 3399.9 3407.5 3430.8 3461.2 1057.0 1071.0 1083.1 1112.4 1272.0 29109.7 30737.5 30788.3 31044.4 31795.8 1158.6 1167.4 1169.5 1174.7 1224.7 16227.9 16284.9 16328.7 16621.7 16720.2 451965.0 455344.0 458937.0 459182.0 460066.0 57777.4 58355.0 58674.0 58814.0 58829.0 1338.2 1394.6 1423.2 1429.2 1436.4 29868.4 30011.1 30483.3 30509.4 30826.4 48556.5 48774.0 49302.3 49309.8 49358.5 422277.0 428028.0 428048.0 429842.0 433285.0 27372.2 27754.4 28063.9 28148.6 28308.2 47514.8 47762.0 47888.3 48456.3 48983.3 40214.6 40995.8 41872.2 41923.0 42218.4 39910.8 40308.4 40589.4 40702.6 41096.6 40622.0 41785.2 43334.6 43452.6 45427.5 35833.8 36787.6 37170.3 37444.0 37593.8 28906.0 29135.6 29355.1 29463.4 29540.6 14:28:28 INFO - PROCESS | 15303 | 14:28:28 INFO - PROCESS | 15303 | [#2] jquery.html Cycles:180 Average:28926.11 Median:12378.64 stddev:83055.62 (671.0%) stddev-sans-first:83260.96 14:28:28 INFO - PROCESS | 15303 | Values: 379.8 383.9 386.1 393.2 407.5 17285.9 19247.2 19723.6 19736.1 19899.5 18571.8 18621.7 18815.3 18850.4 19103.5 5495.6 5664.2 5774.6 5822.4 5824.6 5705.8 5710.9 5745.8 5749.7 5751.0 5333.7 5560.4 5663.8 5688.7 5727.1 5630.3 5677.8 5714.7 5768.3 5977.0 5745.0 5765.3 5769.7 5784.1 5806.0 13285.7 13544.1 21801.1 22392.8 22485.7 2271.6 2279.4 2392.5 2451.4 2933.5 9828.2 10098.2 10100.1 10104.9 10410.6 1998.3 2009.1 2020.7 2070.5 2100.8 62549.0 74811.0 82041.6 84137.6 85624.6 10437.7 10739.8 10905.1 10922.7 10936.6 15084.7 15109.8 15159.2 15321.8 15382.5 7821.7 8034.5 8105.8 8349.5 8383.1 7931.8 8063.2 8194.7 8237.4 8341.0 4557.9 4609.2 4609.8 4667.8 4708.1 1885.5 1893.2 1935.2 1937.1 1964.5 901.7 995.8 1092.5 1094.1 1138.1 18626.8 18802.3 19301.8 19413.7 19476.3 1015.6 1049.8 1051.0 1074.4 1100.1 10176.7 10608.0 10725.2 10747.3 10764.7 489068.0 497520.1 499777.0 517639.0 518673.0 86956.6 92277.0 92358.5 92411.5 92715.0 1034.3 1047.6 1101.4 1120.7 1121.3 16595.9 16957.7 16976.2 17057.2 17193.6 37261.8 38475.2 39077.0 39932.2 40274.2 52002.7 53654.7 54333.0 54576.7 54717.5 8376.8 8477.4 8568.8 8589.4 8630.0 9761.9 13161.7 13177.3 13408.8 13587.3 11439.5 11576.8 11602.7 11684.8 11984.6 11468.8 11497.7 11514.5 11515.2 11765.2 11592.4 11621.5 12010.9 12197.6 12256.5 7145.5 7599.0 8501.0 8615.9 8692.7 10939.2 11235.7 11481.3 11617.2 11704.8 14:28:28 INFO - PROCESS | 15303 | 14:28:28 INFO - PROCESS | 15303 | [#3] mootools.html Cycles:180 Average:5845.45 Median:2443.63 stddev:3332.93 (136.4%) stddev-sans-first:3324.91 14:28:28 INFO - PROCESS | 15303 | Values: 1318.3 1355.9 1423.2 1511.1 1512.8 7871.2 8438.5 8561.2 8975.5 9088.1 8654.1 8927.8 8932.3 8968.0 8980.8 2299.0 2327.3 2332.9 2334.5 2335.4 2346.8 2360.2 2376.0 2376.2 2385.3 2353.1 2354.4 2374.1 2388.9 2398.4 2243.0 2246.1 2249.8 2259.6 2308.2 2255.7 2256.9 2262.4 2262.5 2262.6 8642.6 8810.3 8810.7 8817.8 8824.2 5191.8 5352.5 5353.8 5353.9 5356.5 3452.9 3498.2 3632.2 3634.4 3678.2 1170.4 1195.4 1201.5 1208.0 1225.5 12201.1 12211.6 12216.3 12271.3 12298.4 4690.2 4690.7 4812.9 4827.3 4833.9 10317.1 10338.7 10342.5 10356.2 10373.9 5293.8 5331.7 5333.0 5356.9 5394.4 4364.1 4733.5 4867.8 4904.7 4972.3 3922.1 3950.6 3961.7 4034.6 4071.0 1244.7 1251.7 1269.0 1280.7 1282.5 1013.4 1017.6 1017.7 1039.2 1048.4 5971.7 5982.9 6065.6 6159.3 6229.0 439.5 456.8 465.5 471.1 1031.8 4189.5 4299.5 4329.5 4329.8 4447.7 10900.5 11237.4 11271.4 11329.7 11352.5 11143.0 11145.8 11173.4 11223.2 11226.5 7917.6 8001.8 8291.3 8292.4 8350.2 6086.8 6173.2 6184.7 6233.8 6351.8 9900.8 10053.0 10178.7 10213.5 10290.1 10257.1 10331.6 10562.5 10577.1 10697.6 7002.3 7536.8 7736.5 7816.4 7912.3 8448.0 8458.1 8500.4 8554.3 8600.8 7404.5 7718.1 7752.0 7763.5 7830.4 7143.4 7362.7 7507.2 7593.2 7619.0 7105.1 7119.1 7169.0 7203.0 7211.3 5225.3 5253.2 5356.1 5369.5 5437.2 5116.6 5121.7 5188.5 5219.1 5389.9 14:28:28 INFO - PROCESS | 15303 | 14:28:28 INFO - PROCESS | 15303 | [#4] prototype.html Cycles:180 Average:4819.84 Median:5540.43 stddev:1417.82 (25.6%) stddev-sans-first:1381.23 14:28:28 INFO - PROCESS | 15303 | Values: 333.5 340.1 343.8 343.9 344.1 5459.3 5583.5 5588.7 5617.7 5619.0 5449.1 5496.5 5518.7 5562.2 5576.5 4096.9 4168.5 4287.9 4296.6 4301.5 4221.3 4251.1 4267.6 4286.5 4320.9 4302.6 4303.9 4309.8 4319.7 4328.8 4024.6 4225.8 4270.5 4283.1 4304.5 3714.8 3720.9 3724.3 3726.9 3745.3 5309.2 5328.4 5353.4 5371.4 5377.5 4615.5 4871.2 4878.0 4911.5 4911.7 5724.6 5781.0 5783.6 5788.2 5792.5 4148.9 4163.4 4167.7 4172.1 4186.8 5885.8 6003.6 6033.8 6041.4 6122.0 4172.5 4174.7 4209.7 4235.7 4235.8 4271.3 4282.8 4286.2 4291.2 4300.9 4621.0 4866.8 4873.2 4939.0 4948.8 5767.7 5809.8 5867.5 5890.9 5935.2 1439.3 1440.7 1447.4 1449.7 1456.1 902.4 979.2 981.8 982.8 992.2 5406.4 5407.8 5416.6 5426.6 5432.4 5765.2 5770.9 5784.4 5812.6 5849.5 5158.2 5463.8 5472.4 5481.9 5487.4 3042.0 3059.8 3085.2 3101.2 3101.5 5678.3 5823.5 5945.6 6005.0 6060.9 5775.2 5870.2 5933.2 5965.0 6018.9 5935.9 5943.7 5954.9 5987.3 6010.9 5460.7 5747.6 5757.9 5776.8 5782.4 5610.4 5676.2 5701.2 5774.6 5775.1 5867.4 5895.7 5988.9 6073.0 6099.6 4057.9 4087.0 4094.4 4120.7 4135.6 5698.9 5770.2 5776.2 5805.4 5807.9 5450.5 5589.8 5611.5 5616.7 5842.6 5811.1 5819.5 5886.8 5918.6 5931.4 5563.4 5636.1 5657.9 5710.7 5728.6 5867.6 5881.4 5886.6 5898.2 5926.3 5745.9 5754.0 5757.7 5764.9 5781.8 14:28:28 INFO - PROCESS | 15303 | 14:28:28 INFO - PROCESS | 15303 | [#5] yui.html Cycles:180 Average:14522.47 Median:50868.62 stddev:17160.35 (33.7%) stddev-sans-first:17177.31 14:28:28 INFO - PROCESS | 15303 | Values: 747.9 750.4 765.2 783.4 802.7 13763.4 14000.1 14004.2 14048.6 14148.6 13111.8 13131.7 13260.1 13363.0 13411.1 685.1 796.3 807.1 823.5 831.1 812.1 812.9 815.6 819.6 824.5 879.2 879.7 880.2 884.9 886.9 874.8 875.7 877.6 881.0 881.7 639.1 640.7 643.8 644.0 644.2 13765.6 13799.3 13820.5 13850.3 13929.8 14027.4 14029.9 14068.5 14171.9 14208.1 11408.7 11447.3 11467.8 11519.8 11701.8 3737.3 3753.7 3835.3 3914.9 3921.8 52055.7 52357.5 53230.0 53989.0 54392.2 10223.5 10358.3 10524.8 10578.9 10641.4 19069.0 19134.7 19200.6 19359.0 19364.9 7914.5 8053.4 8083.2 8097.8 8210.3 4804.4 4817.0 4845.4 4886.0 4934.5 3239.1 3358.7 3364.0 3376.8 3397.5 625.9 627.4 630.3 645.3 646.5 626.1 634.5 733.8 735.3 739.9 9131.5 9274.1 9384.2 9433.9 9505.2 571.7 615.7 621.2 692.3 732.6 4159.5 4258.2 4280.5 4364.2 4368.1 59345.4 60972.7 61268.8 61660.7 62764.4 55729.4 56230.0 56628.0 57465.7 58424.7 50825.2 50912.0 51362.5 51686.0 51770.0 7963.5 8113.8 8230.9 8258.4 8301.0 33852.2 33915.5 34170.0 34708.5 34908.7 41954.2 43929.8 45413.8 46130.8 46625.1 10821.7 11002.7 11061.6 11088.4 11333.7 11841.3 11867.6 11942.3 12136.3 12177.7 11118.0 11180.6 11311.7 11392.7 11468.7 10516.7 10915.7 11132.0 11186.2 11279.1 11233.0 11378.4 11475.3 11539.5 11906.4 9220.5 9235.1 9745.1 9917.6 9991.2 9314.9 9480.5 9610.8 9626.6 9660.7 14:28:28 INFO - PROCESS | 15303 | -------- Summary: end -------- 14:28:28 INFO - PROCESS | 15303 | 14:28:28 INFO - TEST-INFO | 15303: exit 0 14:28:28 INFO - TEST-OK | dromaeo_css | took 1109846ms 14:28:28 INFO - TEST-START | kraken 14:28:28 INFO - operating with platform_type : linux_ 14:28:28 INFO - Initialising browser for kraken test... 14:28:28 INFO - TEST-INFO | started process 15539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPTqSJZ/profile http://localhost:45467/getInfo.html) 14:28:32 INFO - PROCESS | 15539 | 14:28:32 INFO - PROCESS | 15539 | (process:15605): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:28:32 INFO - PROCESS | 15539 | __metrics Screen width/height:1600/1200 14:28:32 INFO - PROCESS | 15539 | colorDepth:24 14:28:32 INFO - PROCESS | 15539 | Browser inner width/height: 1024/697 14:28:32 INFO - PROCESS | 15539 | __metrics 14:28:33 ERROR - PROCESS | 15539 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:28:34 INFO - TEST-INFO | 15539: exit 0 14:28:34 INFO - Browser initialized. 14:28:34 INFO - Running cycle 1/1 for kraken test... 14:28:34 INFO - TEST-INFO | started process 15657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPTqSJZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:36 INFO - PROCESS | 15657 | 14:28:36 INFO - PROCESS | 15657 | (process:15716): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:28:46 INFO - PROCESS | 15657 | RSS: Main: 163631104 14:28:46 INFO - PROCESS | 15657 | 14:28:48 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45467/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:49 INFO - PROCESS | 15657 | RSS: Main: 168419328 14:28:49 INFO - PROCESS | 15657 | 14:28:52 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45467/tests/kraken/driver.html?testName=audio-dft) 14:28:52 INFO - PROCESS | 15657 | RSS: Main: 168308736 14:28:52 INFO - PROCESS | 15657 | 14:28:55 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45467/tests/kraken/driver.html?testName=audio-fft) 14:28:56 INFO - PROCESS | 15657 | RSS: Main: 162861056 14:28:56 INFO - PROCESS | 15657 | 14:28:58 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45467/tests/kraken/driver.html?testName=audio-oscillator) 14:28:59 INFO - PROCESS | 15657 | RSS: Main: 163454976 14:28:59 INFO - PROCESS | 15657 | 14:29:01 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45467/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:29:01 INFO - PROCESS | 15657 | RSS: Main: 163704832 14:29:01 INFO - PROCESS | 15657 | 14:29:04 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45467/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:05 INFO - PROCESS | 15657 | RSS: Main: 163958784 14:29:05 INFO - PROCESS | 15657 | 14:29:08 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45467/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:09 INFO - PROCESS | 15657 | RSS: Main: 164261888 14:29:09 INFO - PROCESS | 15657 | 14:29:12 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45467/tests/kraken/driver.html?testName=json-parse-financial) 14:29:13 INFO - PROCESS | 15657 | RSS: Main: 164388864 14:29:13 INFO - PROCESS | 15657 | 14:29:14 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45467/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:15 INFO - PROCESS | 15657 | RSS: Main: 164462592 14:29:15 INFO - PROCESS | 15657 | 14:29:16 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45467/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:17 INFO - PROCESS | 15657 | RSS: Main: 164147200 14:29:17 INFO - PROCESS | 15657 | 14:29:19 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45467/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:20 INFO - PROCESS | 15657 | RSS: Main: 164274176 14:29:20 INFO - PROCESS | 15657 | 14:29:22 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45467/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:29:23 INFO - PROCESS | 15657 | RSS: Main: 164712448 14:29:23 INFO - PROCESS | 15657 | 14:29:26 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45467/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:29:27 INFO - PROCESS | 15657 | RSS: Main: 164552704 14:29:27 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | Cycle 1(1): loaded http://localhost:45467/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45467/tests/kraken/driver.html?testName=ai-astar) 14:29:28 INFO - PROCESS | 15657 | RSS: Main: 166002688 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | __start_tp_report 14:29:28 INFO - PROCESS | 15657 | _x_x_mozilla_page_load 14:29:28 INFO - PROCESS | 15657 | _x_x_mozilla_page_load_details 14:29:28 INFO - PROCESS | 15657 | |i|pagename|runs| 14:29:28 INFO - PROCESS | 15657 | |0;ai-astar;107;110;104;110;111;110;105;113;108;111 14:29:28 INFO - PROCESS | 15657 | |1;audio-beat-detection;165;127;153;184;127;151;160;127;185;129 14:29:28 INFO - PROCESS | 15657 | |2;audio-dft;163;161;161;163;162;165;174;163;162;163 14:29:28 INFO - PROCESS | 15657 | |3;audio-fft;75;77;75;167;79;76;75;77;165;77 14:29:28 INFO - PROCESS | 15657 | |4;audio-oscillator;92;92;154;91;91;91;147;92;93;158 14:29:28 INFO - PROCESS | 15657 | |5;imaging-gaussian-blur;117;118;118;117;117;118;116;117;117;117 14:29:28 INFO - PROCESS | 15657 | |6;imaging-darkroom;146;147;147;147;147;147;146;147;147;147 14:29:28 INFO - PROCESS | 15657 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 14:29:28 INFO - PROCESS | 15657 | |8;json-parse-financial;60;58;57;57;59;58;57;89;55;56 14:29:28 INFO - PROCESS | 15657 | |9;json-stringify-tinderbox;58;59;58;59;59;58;58;58;59;58 14:29:28 INFO - PROCESS | 15657 | |10;stanford-crypto-aes;84;80;81;80;82;81;82;81;82;85 14:29:28 INFO - PROCESS | 15657 | |11;stanford-crypto-ccm;129;129;139;127;123;134;127;124;205;129 14:29:28 INFO - PROCESS | 15657 | |12;stanford-crypto-pbkdf2;185;169;172;166;167;169;169;171;166;167 14:29:28 INFO - PROCESS | 15657 | |13;stanford-crypto-sha256-iterative;66;67;66;65;65;65;64;65;64;73 14:29:28 INFO - PROCESS | 15657 | __end_tp_report 14:29:28 INFO - PROCESS | 15657 | __start_cc_report 14:29:28 INFO - PROCESS | 15657 | _x_x_mozilla_cycle_collect,830 14:29:28 INFO - PROCESS | 15657 | __end_cc_report 14:29:28 INFO - PROCESS | 15657 | __startTimestamp1462570168973__endTimestamp 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | ------- Summary: start ------- 14:29:28 INFO - PROCESS | 15657 | Number of tests: 14 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.85 (2.6%) stddev-sans-first:2.93 14:29:28 INFO - PROCESS | 15657 | Values: 107.0 110.0 104.0 110.0 111.0 110.0 105.0 113.0 108.0 111.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:156.50 stddev:22.94 (14.7%) stddev-sans-first:23.75 14:29:28 INFO - PROCESS | 15657 | Values: 165.0 127.0 153.0 184.0 127.0 151.0 160.0 127.0 185.0 129.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.80 (2.3%) stddev-sans-first:4.02 14:29:28 INFO - PROCESS | 15657 | Values: 163.0 161.0 161.0 163.0 162.0 165.0 174.0 163.0 162.0 163.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.50 stddev:37.81 (49.4%) stddev-sans-first:39.46 14:29:28 INFO - PROCESS | 15657 | Values: 75.0 77.0 75.0 167.0 79.0 76.0 75.0 77.0 165.0 77.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:91.50 stddev:29.73 (32.5%) stddev-sans-first:30.80 14:29:28 INFO - PROCESS | 15657 | Values: 92.0 92.0 154.0 91.0 91.0 91.0 147.0 92.0 93.0 158.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 14:29:28 INFO - PROCESS | 15657 | Values: 117.0 118.0 118.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 14:29:28 INFO - PROCESS | 15657 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:29:28 INFO - PROCESS | 15657 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:58.00 stddev:10.08 (17.4%) stddev-sans-first:10.69 14:29:28 INFO - PROCESS | 15657 | Values: 60.0 58.0 57.0 57.0 59.0 58.0 57.0 89.0 55.0 56.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 14:29:28 INFO - PROCESS | 15657 | Values: 58.0 59.0 58.0 59.0 59.0 58.0 58.0 58.0 59.0 58.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.62 (2.0%) stddev-sans-first:1.51 14:29:28 INFO - PROCESS | 15657 | Values: 84.0 80.0 81.0 80.0 82.0 81.0 82.0 81.0 82.0 85.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:129.00 stddev:24.48 (19.0%) stddev-sans-first:25.81 14:29:28 INFO - PROCESS | 15657 | Values: 129.0 129.0 139.0 127.0 123.0 134.0 127.0 124.0 205.0 129.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:169.00 stddev:5.61 (3.3%) stddev-sans-first:2.13 14:29:28 INFO - PROCESS | 15657 | Values: 185.0 169.0 172.0 166.0 167.0 169.0 169.0 171.0 166.0 167.0 14:29:28 INFO - PROCESS | 15657 | 14:29:28 INFO - PROCESS | 15657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.50 stddev:2.62 (4.0%) stddev-sans-first:2.78 14:29:28 INFO - PROCESS | 15657 | Values: 66.0 67.0 66.0 65.0 65.0 65.0 64.0 65.0 64.0 73.0 14:29:28 INFO - PROCESS | 15657 | -------- Summary: end -------- 14:29:28 INFO - PROCESS | 15657 | 14:29:29 INFO - TEST-INFO | 15657: exit 0 14:29:29 INFO - TEST-OK | kraken | took 61294ms 14:29:29 INFO - SUITE-END | took 1171s 14:29:30 INFO - Completed test suite (00:19:31) 14:29:30 INFO - javascript benchmark 14:29:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.1641465011776, 3167.5565420841085, 3185.490321548552, 3195.680431956806, 3215.2122729931157, 5335.386430560482, 5347.919781203285, 5357.383900851399, 5439.5920305977115, 5481.369642491115, 5300.072487314724, 5410.5401040911565, 5448.618596698233, 5466.972665136679, 5469.644473109245, 4894.804207831691, 4936.086823937565, 4989.052080104787, 5052.9747351263195, 5108.744562771846, 4937.753112344369, 5093.516115968995, 5120.257562653413, 5128.4102328232175, 5135.897282054357, 4888.804447822083, 4922.556969872693, 4944.134776414113, 4951.752412379366, 4959.727215003173, 4972.328735620681, 4972.676776009584, 4980.377452818398, 4987.102321582114, 5025.497450254945, 4947.579455746266, 4948.703077815343, 4954.950450495485, 4967.0, 5002.049610574016, 5218.2955301034635, 5264.894372181808, 5352.090144675414, 5405.567554595662, 5440.619156659035, 5865.824025279248, 5868.882622347572, 5876.823695289148, 5895.056790913433, 5897.734601942923, 5780.739866706008, 5904.9704751475965, 5929.851753706149, 5934.792282270143, 5951.761929522814, 5357.491038351351, 5366.6511676741275, 5406.270153529302, 5413.783448662049, 5419.945800542023, 5884.0, 5890.676012819336, 5891.116332550066, 5897.056470964625, 5899.380565040609, 5558.277423934944, 5625.887482250332, 5629.0, 5633.492985631313, 5634.97182514093, 5759.308882933991, 5765.971170144207, 5772.94227057724, 5776.335721392094, 5835.328937172279, 5679.716014199274, 5717.256756621613, 5718.628289161191, 5726.541876649858, 5726.685032323262, 5549.5837812164245, 5734.541236701054, 5746.540276777848, 5775.364709881909, 5785.1322301654245, 4382.69321147523, 4407.449068866392, 4412.624926881187, 4413.3821265022925, 4428.911421771547, 3948.7433316834313, 3964.7224694271126, 3971.860984865516, 3977.423273625308, 3993.4608827808456, 5451.400345961941, 5522.5581953443625, 5554.583406244547, 5556.91664625031, 5587.161925711176, 5804.767809287666, 5817.534597232211, 5847.356790753014, 5855.443732845373, 5894.764209431574, 5552.222688823568, 5560.277163968658, 5562.888742225133, 5567.415421380778, 5575.860603484864, 4887.682300650446, 4972.90054198914, 4973.925391119136, 5011.173156429221, 5022.121128802445, 6047.244094488189, 6056.818295451144, 6066.575339726177, 6074.939250607437, 6085.5435842312, 5876.294844618673, 5881.32364778056, 5885.264341957255, 5895.64626122434, 5918.911216331672, 5879.5002424792665, 5892.234009578728, 5937.5249980000635, 5961.91057134152, 5985.042393217064, 5678.346990096026, 5691.3170419549915, 5693.658380497183, 5705.4579814917515, 5714.171445140349, 5690.630109042899, 5770.798022069207, 5789.0, 5793.594448388572, 5795.565332599987, 5579.721013949205, 5626.662400255997, 5663.886722265449, 5683.943160568341, 5684.516816070681, 5520.834374968757, 5577.637453565505, 5653.123765816305, 5663.886722265449, 5715.857103572278, 5614.101743720985, 5622.3815380307315, 5623.746931388016, 5627.0434026214825, 5653.0, 5603.131514615078, 5621.409751976147, 5623.8875222496135, 5633.267675202197, 5654.236678048411, 5534.723263836872, 5542.0855558832345, 5548.445155484419, 5556.416576259435, 5590.468905453975], "value": 5352.026083433171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.5688847141587, 653.483747839207, 666.5700623098098, 666.5733930284619, 686.5091459606381, 37078.0, 41917.371239431435, 42092.57907420929, 42174.0, 42434.0, 41493.37759933603, 41985.790071049676, 42036.78981605088, 42170.7891460543, 42186.789066054705, 8730.476171429718, 8795.95602021989, 8862.911370886306, 8887.644494220223, 8889.422187557788, 8642.697505587306, 8757.7810554736, 8768.517731524764, 8805.559722013906, 8826.514541700204, 8772.473651580925, 8801.427907186044, 8822.0, 8823.867641985375, 8869.290456763443, 8743.30053595714, 8778.824423511558, 8797.692080777206, 8803.251723603502, 8816.0, 8718.607662655133, 8722.215000649972, 8763.12368763125, 8764.780880477976, 8796.780080497974, 39827.40258896119, 39832.0, 39966.200675986314, 39992.80003599964, 40012.0, 3510.5260789793306, 3755.605661405568, 4009.3384591542363, 4088.632023117934, 4297.871063868089, 31407.528887066714, 31620.0, 31996.200094997577, 32055.83972080148, 33988.83005584981, 4298.355246712987, 4330.198913201068, 4371.0820727646915, 4475.306327519207, 4509.458864936196, 317669.0, 319531.0, 320121.0, 320398.9800509965, 322763.0, 34605.65394346075, 35170.648293517246, 35318.0, 37497.0, 55947.0, 37352.62647373546, 37396.252074958895, 37431.4385284221, 37465.0, 37634.8118259407, 15491.612709682122, 15606.609834754221, 15606.687866242612, 15631.609209769847, 15692.529224123295, 12205.0, 12224.083193760503, 12248.938755306166, 12315.014798816073, 12319.815202771966, 8500.914990850137, 8534.957325213458, 8548.700795472128, 8556.058833528306, 8684.348673849487, 3388.423967925459, 3399.9320013600086, 3407.539982102434, 3430.794152350867, 3461.2039230977016, 1056.9735756606146, 1070.9571617135384, 1083.0847933496184, 1112.393745408738, 1271.968200794969, 29109.708902911123, 30737.538936915964, 30788.30540335174, 31044.379112417624, 31795.84102079475, 1158.6292386436428, 1167.4046236419488, 1169.5497233565138, 1174.7121955120879, 1224.675461002835, 16227.918860405622, 16284.918575407048, 16328.673426531403, 16621.66756664884, 16720.16399180036, 451965.0, 455344.0, 458937.0, 459182.0, 460066.0, 57777.42222577804, 58355.0, 58674.0, 58814.0, 58829.0, 1338.1837079381569, 1394.6164804678592, 1423.2172305232082, 1429.1996481969923, 1436.3608194353621, 29868.402631947672, 30011.099667010025, 30483.2639433824, 30509.389812204077, 30826.383472330876, 48556.5144348552, 48774.0, 49302.26046609232, 49309.753451232515, 49358.50641493539, 422277.0, 428028.0, 428048.0, 429842.0, 433285.0, 27372.178834634993, 27754.44491110207, 28063.859680701466, 28148.577771333858, 28308.150755477367, 47514.76242618765, 47762.0, 47888.2816757742, 48456.27315590198, 48983.26525102055, 40214.597854021085, 40995.79502102471, 41872.1625567493, 41923.0, 42218.36672449854, 39910.80044599874, 40308.39537406882, 40589.39115913323, 40702.59297406988, 41096.589034109275, 40622.0, 41785.16429671329, 43334.56665433432, 43452.565474344854, 45427.54572454233, 35833.82083089568, 36787.63212367842, 37170.25659486849, 37444.0, 37593.81203093967, 28906.0, 29135.562966555943, 29355.11934641964, 29463.410731785672, 29540.556891646214], "value": 18680.343233532545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.8214839025659, 383.9347310957138, 386.11386867139913, 393.21553500765975, 407.4947065638609, 17285.913570432145, 19247.23011079555, 19723.605527889435, 19736.111874965623, 19899.502512437197, 18571.814281857176, 18621.720674189863, 18815.30662240398, 18850.43448696538, 19103.52241193971, 5495.560355171597, 5664.178694089365, 5774.624649397776, 5822.417758224186, 5824.563157763164, 5705.828825135252, 5710.885782284352, 5745.798897038604, 5749.741261643236, 5750.993576124182, 5333.70664613448, 5560.36055853578, 5663.773449062032, 5688.744006519696, 5727.083666613343, 5630.324361076677, 5677.772889084432, 5714.657120572758, 5768.278965129359, 5977.0, 5744.971275143639, 5765.250517432749, 5769.740361683693, 5784.1034639630925, 5806.0, 13285.73428531424, 13544.119407750246, 21801.127954881787, 22392.77607223923, 22485.662715059123, 2271.6251818449937, 2279.3845661671257, 2392.485615592656, 2451.4361696809833, 2933.5013047781927, 9828.21374290055, 10098.192144628412, 10100.090991810699, 10104.94947525265, 10410.635627753069, 1998.2506560039985, 2009.0557438004114, 2020.7474065741783, 2070.5444802143506, 2100.8004239597367, 62549.0, 74811.0, 82041.58979205065, 84137.57931210365, 85624.57187714084, 10437.739056523496, 10739.785204296026, 10905.127589792797, 10922.72693182661, 10936.617218397318, 15084.698306033817, 15109.848901510844, 15159.24203789806, 15321.846781532042, 15382.461613843461, 7821.687132514636, 8034.517928924283, 8105.797355066171, 8349.45728527656, 8383.077861435237, 7931.801704957422, 8063.193680632007, 8194.67221311141, 8237.423380363436, 8340.958295208606, 4557.886052848706, 4609.1703493371515, 4609.769511524478, 4667.8366257181515, 4708.058388322349, 1885.4720678210124, 1893.1764682363216, 1935.167877812526, 1937.0798870536382, 1964.4695932098252, 901.693424235763, 995.785906030207, 1092.5138313450598, 1094.1192340166242, 1138.0781566930812, 18626.813731862778, 18802.34191803308, 19301.80698193028, 19413.708794368096, 19476.254504921082, 1015.5531566110888, 1049.8057859295902, 1050.9947450262853, 1074.4305518075432, 1100.0979197058334, 10176.745581360525, 10608.0, 10725.195610329256, 10747.301425407324, 10764.677059688222, 489068.0, 497520.07439776865, 499777.0, 517639.0, 518673.0, 86956.56521717478, 92277.0, 92358.53820730853, 92411.53794230986, 92715.0, 1034.3225187502198, 1047.617619568852, 1101.366714139373, 1120.7030137013699, 1121.3384103379046, 16595.91702041482, 16957.74563381575, 16976.23606937666, 17057.232424541173, 17193.57016074608, 37261.81369093137, 38475.230495389376, 39077.0, 39932.20135597214, 40274.194516108924, 52002.73998629983, 53654.73172634112, 54333.0, 54576.72711636575, 54717.45282547283, 8376.83246335082, 8477.364197685074, 8568.828623427622, 8589.398742087993, 8629.95685021596, 9761.85357219628, 13161.736765264832, 13177.27524986135, 13408.798868016793, 13587.32063396846, 11439.485223164811, 11576.768464630492, 11602.70993225176, 11684.824727629262, 11984.64046078619, 11468.770624587629, 11497.712557185803, 11514.53941842317, 11515.19393642437, 11765.235259708092, 11592.420378980849, 11621.477033533341, 12010.879891201326, 12197.573084941985, 12256.509739610672, 7145.535540190079, 7598.96200519016, 8501.0, 8615.913840861762, 8692.695755648521, 10939.234253602172, 11235.71910702239, 11481.253718508271, 11617.186796924134, 11704.824427633763], "value": 9141.179581711587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.3276528970225, 1355.8711922367372, 1423.1603354021127, 1511.13109961772, 1512.8033355663763, 7871.2128787121255, 8438.451500652462, 8561.186687264715, 8975.506347150904, 9088.13662702044, 8654.134586541342, 8927.776805579864, 8932.285417166628, 8967.95516022419, 8980.775480612989, 2298.977010229901, 2327.325075728037, 2332.918347857825, 2334.4514039200776, 2335.3577766114286, 2346.7887890089887, 2360.209329874494, 2375.9881200593973, 2376.192094687806, 2385.320183747632, 2353.0705371378294, 2354.446705024318, 2374.097842819726, 2388.868612226327, 2398.4483568779106, 2243.0130742473343, 2246.05665620439, 2249.8312626553075, 2259.6271615183473, 2308.1690591387087, 2255.729312482496, 2256.8533045352, 2262.3552287597954, 2262.4570103175283, 2262.5814224368546, 8642.567871606458, 8810.251128654072, 8810.735677929672, 8817.823643527094, 8824.205821476098, 5191.818286359997, 5352.4915133062295, 5353.839384818461, 5353.946460535422, 5356.54469370104, 3452.879149229765, 3498.2303893143467, 3632.237230181665, 3634.400323946572, 3678.2091850252054, 1170.3504554971987, 1195.4261954262004, 1201.5133870782347, 1207.963761087169, 1225.462045133352, 12201.145919785618, 12211.572594959223, 12216.2670239785, 12271.263724176579, 12298.385080745928, 4690.179218636725, 4690.695104818176, 4812.903741925142, 4827.275908613736, 4833.879153021132, 10317.071463568314, 10338.689839304832, 10342.534585943651, 10356.17150627948, 10373.896261037293, 5293.788248470018, 5331.653442526223, 5332.973335133377, 5356.91964620531, 5394.433584473652, 4364.083542456056, 4733.479317275097, 4867.780949857265, 4904.705717656952, 4972.303877457159, 3922.0783115967724, 3950.6444420001762, 3961.7028722845903, 4034.5561988181275, 4071.0, 1244.6701624069628, 1251.6808213905397, 1269.0355329949305, 1280.667026573079, 1282.4805953588625, 1013.4476710192963, 1017.6336518853354, 1017.7048655889857, 1039.158281791736, 1048.4128887822692, 5971.724412584662, 5982.910256346158, 6065.636061836304, 6159.291681456601, 6228.968855155786, 439.52970321756055, 456.8127067902144, 465.54376710823584, 471.08609297961846, 1031.7575369788094, 4189.476315460567, 4299.462567179103, 4329.480462344539, 4329.800560736483, 4447.733136011785, 10900.50947707355, 11237.381943992996, 11271.380074096003, 11329.660110196708, 11352.545898164146, 11143.0, 11145.777084458265, 11173.441327933571, 11223.158263130297, 11226.494807733672, 7917.643706033243, 8001.8399632008195, 8291.253787159185, 8292.419530632798, 8350.24847763692, 6086.756529738761, 6173.228346456693, 6184.659843708459, 6233.781817636361, 6351.841203969938, 9900.752481188028, 10053.0, 10178.694639160836, 10213.540390682585, 10290.073893349336, 10257.128144107834, 10331.638392656221, 10562.524686388977, 10577.100946419641, 10697.572097116028, 7002.2647622000995, 7536.773896783106, 7736.535807851547, 7816.374690024671, 7912.28789408933, 8448.0, 8458.111898250596, 8500.404971651926, 8554.31565474773, 8600.827983440171, 7404.481686282124, 7718.112417071884, 7752.0, 7763.534187948741, 7830.412719046209, 7143.392811610864, 7362.7423040193335, 7507.249275072668, 7593.240675932362, 7618.96190519066, 7105.147382313949, 7119.074520312326, 7169.0, 7202.96398518004, 7211.278872112747, 5225.320708307896, 5253.212018197301, 5356.089464791073, 5369.48989845964, 5437.157240627709, 5116.6418350716585, 5121.718305493234, 5188.481151884781, 5219.138842091164, 5389.919151212814], "value": 4624.3437313858085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.5413806016727, 340.1309653834452, 343.7610860451985, 343.85214357826135, 344.0589986387232, 5459.317585301837, 5583.469570390816, 5588.720563971806, 5617.691026993513, 5618.9604923089255, 5449.139201918984, 5496.4503549645015, 5518.696471694056, 5562.16567514873, 5576.525995290405, 4096.85661001865, 4168.520620128678, 4287.871363859089, 4296.64655633476, 4301.505326887417, 4221.282381995053, 4251.107267473834, 4267.573242675739, 4286.485621725382, 4320.935185972213, 4302.612764851163, 4303.870883873473, 4309.806058727349, 4319.69762116652, 4328.826846926135, 4024.5975402459667, 4225.767582782945, 4270.466191726035, 4283.121959998193, 4304.483461984566, 3714.758540694846, 3720.8697695580527, 3724.348239058154, 3726.9440958385644, 3745.250949810049, 5309.150535914235, 5328.387235467932, 5353.357597088336, 5371.409144994048, 5377.516023557899, 4615.492295847454, 4871.196252618313, 4877.951220487821, 4911.533404326583, 4911.705297682151, 5724.627899186539, 5780.9710951445395, 5783.624064435799, 5788.160716696056, 5792.507636850873, 4148.896277593054, 4163.417121602978, 4167.708260421772, 4172.059992103656, 4186.790660466964, 5885.823425297248, 6003.6397816131175, 6033.788817391414, 6041.426064523863, 6121.969390153065, 4172.4993000840095, 4174.666026717855, 4209.663226941837, 4235.7035007549175, 4235.830566777356, 4271.252530807096, 4282.807273672693, 4286.164197981364, 4291.163223171452, 4300.892477688083, 4620.976895115503, 4866.78099485524, 4873.1959226727195, 4939.0, 4948.802047918043, 5767.682777447197, 5809.796657116981, 5867.471927526458, 5890.911636325459, 5935.231128233603, 1439.2947455746819, 1440.7334643091062, 1447.3848614338865, 1449.7173051254904, 1456.0535651826397, 902.444996327254, 979.1823827104448, 981.8429051351892, 982.8132654795565, 992.2161492421051, 5406.432324605859, 5407.810726624628, 5416.593755468356, 5426.620136590401, 5432.402435732066, 5765.1928729977835, 5770.913436298459, 5784.3926387729525, 5812.564057695689, 5849.548766227861, 5158.226266060121, 5463.836084917459, 5472.425395333512, 5481.890362192734, 5487.38122253936, 3042.034016833614, 3059.7705172112182, 3085.182426656938, 3101.17818778024, 3101.5037593984853, 5678.261825962681, 5823.475887170091, 5945.632504523897, 6005.0, 6060.909086363708, 5775.220345253421, 5870.236869207061, 5933.199018132497, 5965.0, 6018.879622407528, 5935.910961335583, 5943.673097979567, 5954.910676339859, 5987.251593550806, 6010.879782404328, 5460.672359658433, 5747.597668163188, 5757.884842303214, 5776.797812076557, 5782.3639399666845, 5610.410906854721, 5676.2337084493065, 5701.230333904869, 5774.595778295479, 5775.075987841925, 5867.386468721136, 5895.734691938959, 5988.940110598838, 6073.0, 6099.634021958696, 4057.91884162321, 4086.959130408658, 4094.385842123705, 4120.711550191458, 4135.635240370731, 5698.914516282176, 5770.221020162225, 5776.162456443708, 5805.41945805433, 5807.8548036299435, 5450.454954504517, 5589.832305030855, 5611.5230205433, 5616.708157123966, 5842.649441033552, 5811.099279611667, 5819.476247137609, 5886.764529418775, 5918.644881307136, 5931.436513531207, 5563.442236173878, 5636.126400407943, 5657.858553536194, 5710.657995371168, 5728.570357223308, 5867.647941123546, 5881.441263080001, 5886.58793884424, 5898.203742494708, 5926.348101708722, 5745.856353591026, 5753.971230143822, 5757.683327417032, 5764.913526297193, 5781.797637082682], "value": 4365.907891268456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.8915557244203, 750.3509464313368, 765.2232983521723, 783.385042741448, 802.6909639788681, 13763.44946202152, 14000.089994150374, 14004.22976736279, 14048.578542643725, 14148.646283842883, 13111.80332295014, 13131.6717082073, 13260.1380910241, 13363.0, 13411.128276662035, 685.0819901332214, 796.2753893956515, 807.0678366486688, 823.5017814222399, 831.0775039705952, 812.1310198088048, 812.9065157506874, 815.64927081355, 819.6188772220916, 824.5052968219051, 879.1604018162672, 879.705298724928, 880.190224993008, 884.9026607073217, 886.8758373827669, 874.8075423406872, 875.6847534887436, 877.6050777150276, 880.9912650015729, 881.7310720230328, 639.0605809460086, 640.7244884699577, 643.7714611313011, 644.0371644391664, 644.1625886347776, 13765.587032388945, 13799.310034498336, 13820.516281930184, 13850.307484625728, 13929.791053134211, 14027.43890244389, 14029.929850350683, 14068.507602233873, 14171.929140354232, 14208.147511149364, 11408.657740267723, 11447.313161210272, 11467.77064458706, 11519.827202591969, 11701.824472632918, 3737.2712321097397, 3753.71847111465, 3835.271298453285, 3914.862979795722, 3921.803909804527, 52055.73972130115, 52357.476425236026, 53230.0, 53989.0, 54392.18411723788, 10223.496610161152, 10358.26824569532, 10524.789504210026, 10578.947105264424, 10641.361518308926, 19069.0, 19134.71297930532, 19200.61598768017, 19359.0, 19364.903175484033, 7914.485558438683, 8053.395995300376, 8083.151269116775, 8097.838043239102, 8210.30212431938, 4804.42346918372, 4817.0, 4845.370101886732, 4885.95114048855, 4934.506549345037, 3239.1092449576086, 3358.6641335866707, 3363.9663603364143, 3376.7636265461183, 3397.490376443504, 625.9155014073133, 627.3914303125961, 630.2909227119491, 645.3030726815028, 646.5021933111478, 626.0859145647406, 634.514596333805, 733.8055415314946, 735.3235023778137, 739.9408047356198, 9131.497767622845, 9274.072592740671, 9384.202342800938, 9433.90566094344, 9505.239580833517, 571.6712890088132, 615.7136931326954, 621.1645337021698, 692.3111504053498, 732.6007326007339, 4159.480064991876, 4258.190943720745, 4280.464941882265, 4364.236258654722, 4368.126374725068, 59345.40654593485, 60972.69513652403, 61268.77462450726, 61660.691696542126, 62764.37235627585, 55729.44270557242, 56230.0, 56628.0, 57465.71267143638, 58424.70787646034, 50825.23762143571, 50912.0, 51362.48637513652, 51686.0, 51770.0, 7963.522188668467, 8113.797155071171, 8230.859976406058, 8258.42191046621, 8300.958495207486, 33852.153696157795, 33915.49126763051, 34170.0, 34708.47937280993, 34908.65091349054, 41954.1609167821, 43929.78035109804, 45413.772931135136, 46130.76934615306, 46625.06749865052, 10821.729456763644, 11002.724931876766, 11061.557537698724, 11088.390138542458, 11333.659990200307, 11841.28952262867, 11867.58463453775, 11942.311631090299, 12136.271823690608, 12177.69555761113, 11118.0, 11180.608678696206, 11311.660650180507, 11392.715182120513, 11468.655940321803, 10516.68449946503, 10915.727106822393, 11132.0, 11186.216964812711, 11279.09767218604, 11233.013091741619, 11378.37418941933, 11475.254108482923, 11539.4807233673, 11906.404679765803, 9220.538973051454, 9235.12266334697, 9745.122938935247, 9917.603295868084, 9991.150752186146, 9314.860277095713, 9480.525973701426, 9610.759731006781, 9626.614935402506, 9660.661876834278], "value": 6555.096851801763, "unit": "score"}], "name": "dromaeo_css", "value": 7032.477493359864, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 104.0, 110.0, 111.0, 110.0, 105.0, 113.0, 108.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 127.0, 153.0, 184.0, 127.0, 151.0, 160.0, 127.0, 185.0, 129.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 163.0, 162.0, 165.0, 174.0, 163.0, 162.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 167.0, 79.0, 76.0, 75.0, 77.0, 165.0, 77.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 154.0, 91.0, 91.0, 91.0, 147.0, 92.0, 93.0, 158.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 57.0, 57.0, 59.0, 58.0, 57.0, 89.0, 55.0, 56.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 81.0, 80.0, 82.0, 81.0, 82.0, 81.0, 82.0, 85.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 139.0, 127.0, 123.0, 134.0, 127.0, 124.0, 205.0, 129.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 169.0, 172.0, 166.0, 167.0, 169.0, 169.0, 171.0, 166.0, 167.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 73.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1560.3, "alertThreshold": 2.0}]} 14:29:30 INFO - Return code: 0 14:29:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:29:30 ERROR - # TBPL SUCCESS # 14:29:30 INFO - Running post-action listener: _resource_record_post_action 14:29:30 INFO - ##### 14:29:30 INFO - ##### Finished run-tests step (success) 14:29:30 INFO - ##### 14:29:30 INFO - Running post-run listener: _resource_record_post_run 14:29:31 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546832384; Read time: 16; Write time: 708848 14:29:31 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 251326464; Read time: 0; Write time: 420028 14:29:31 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293056512; Read time: 16; Write time: 288464 14:29:31 INFO - Running post-run listener: _upload_blobber_files 14:29:31 INFO - Blob upload gear active. 14:29:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:29:31 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 14:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:29:31 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:29:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:29:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:32 INFO - (blobuploader) - INFO - Done attempting. 14:29:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:29:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:29:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:33 INFO - (blobuploader) - INFO - Done attempting. 14:29:33 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:33 INFO - Return code: 0 14:29:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c5a73691711d91c1b88d1ff750ea7edf749d9dac3593d3ef8d2b9df77b232f7e560b6a4ca680dd75675acf9600167aa60087ae620268f2fd52eac7478722865", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90e8a13c909d1b46e66401befdf4abcec50d776be550187272ffe94600aaa25f5ebc00e1c6fb9f2f0b2453176893920194fbe9adfb1e16762d46cb7153d96f91"} 14:29:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:33 INFO - Contents: 14:29:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c5a73691711d91c1b88d1ff750ea7edf749d9dac3593d3ef8d2b9df77b232f7e560b6a4ca680dd75675acf9600167aa60087ae620268f2fd52eac7478722865", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90e8a13c909d1b46e66401befdf4abcec50d776be550187272ffe94600aaa25f5ebc00e1c6fb9f2f0b2453176893920194fbe9adfb1e16762d46cb7153d96f91"} 14:29:33 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:33 INFO - Copying logs to upload dir... 14:29:33 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.269193 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-06 14:29:33.146185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 14:29:33.150070) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c5a73691711d91c1b88d1ff750ea7edf749d9dac3593d3ef8d2b9df77b232f7e560b6a4ca680dd75675acf9600167aa60087ae620268f2fd52eac7478722865", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90e8a13c909d1b46e66401befdf4abcec50d776be550187272ffe94600aaa25f5ebc00e1c6fb9f2f0b2453176893920194fbe9adfb1e16762d46cb7153d96f91"} build_url:https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/JrBgEnbSQke_vviYri8d0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c5a73691711d91c1b88d1ff750ea7edf749d9dac3593d3ef8d2b9df77b232f7e560b6a4ca680dd75675acf9600167aa60087ae620268f2fd52eac7478722865", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90e8a13c909d1b46e66401befdf4abcec50d776be550187272ffe94600aaa25f5ebc00e1c6fb9f2f0b2453176893920194fbe9adfb1e16762d46cb7153d96f91"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 14:29:33.174322) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 14:29:33.174625) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1462568943.549937-128757831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004302 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 14:29:33.257773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 14:29:33.258079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 14:29:33.258349) ========= ========= Total master_lag: 0.27 =========