builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1467743063.9 results: success (0) buildid: 20160705080924 builduid: 63293650764c4d18860755eb5f87d551 revision: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:23.904826) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:23.905295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:23.905592) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:24.015074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:24.015449) ========= 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=923d835db2ba3686ebe126b700000192-1467743062.426934-246075726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 11:24:24-- 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% 224M=0s 2016-07-05 11:24:24 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074345 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:24.104418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:24.107912) ========= 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=923d835db2ba3686ebe126b700000192-1467743062.426934-246075726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013809 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:24.157464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 11:24:24.161053) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 274a291aa2c85528ffeb988f0b1b0b61c12136b8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 274a291aa2c85528ffeb988f0b1b0b61c12136b8 --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=923d835db2ba3686ebe126b700000192-1467743062.426934-246075726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 11:24:24,879 truncating revision to first 12 chars 2016-07-05 11:24:24,879 Setting DEBUG logging. 2016-07-05 11:24:24,879 attempt 1/10 2016-07-05 11:24:24,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/274a291aa2c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 11:24:26,172 unpacking tar archive at: mozilla-beta-274a291aa2c8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.612669 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 11:24:25.787418) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:25.787775) ========= script_repo_revision: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:25.788170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:25.788433) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 11:24:25.797421) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-05 11:24:25.797984) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=923d835db2ba3686ebe126b700000192-1467743062.426934-246075726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:26 INFO - MultiFileLogger online at 20160705 11:24:26 in /builds/slave/test 11:24:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:24:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:26 INFO - {'append_to_log': False, 11:24:26 INFO - 'base_work_dir': '/builds/slave/test', 11:24:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:24:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:26 INFO - 'branch': 'Mozilla-Beta', 11:24:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:26 INFO - 'config_files': ('talos/linux_config.py',), 11:24:26 INFO - 'default_actions': ('clobber', 11:24:26 INFO - 'read-buildbot-config', 11:24:26 INFO - 'download-and-extract', 11:24:26 INFO - 'populate-webroot', 11:24:26 INFO - 'create-virtualenv', 11:24:26 INFO - 'install', 11:24:26 INFO - 'run-tests'), 11:24:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:26 INFO - 'download_minidump_stackwalk': True, 11:24:26 INFO - 'download_symbols': 'ondemand', 11:24:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:26 INFO - 'installer_path': 'installer.exe', 11:24:26 INFO - 'log_level': 'info', 11:24:26 INFO - 'log_name': 'talos', 11:24:26 INFO - 'log_to_console': True, 11:24:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:26 INFO - 'opt_config_files': (), 11:24:26 INFO - 'pip_index': False, 11:24:26 INFO - 'sps_profile': False, 11:24:26 INFO - 'sps_profile_interval': 0, 11:24:26 INFO - 'suite': 'dromaeojs', 11:24:26 INFO - 'system_bits': '32', 11:24:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:26 INFO - 'title': 'talos-linux64-ix-007', 11:24:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:26 INFO - 'use_talos_json': True, 11:24:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:26 INFO - 'work_dir': 'build'} 11:24:26 INFO - ##### 11:24:26 INFO - ##### Running clobber step. 11:24:26 INFO - ##### 11:24:26 INFO - Running pre-action listener: _resource_record_pre_action 11:24:26 INFO - Running main action method: clobber 11:24:26 INFO - rmtree: /builds/slave/test/build 11:24:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:27 INFO - Running post-action listener: _resource_record_post_action 11:24:27 INFO - ##### 11:24:27 INFO - ##### Running read-buildbot-config step. 11:24:27 INFO - ##### 11:24:27 INFO - Running pre-action listener: _resource_record_pre_action 11:24:27 INFO - Running main action method: read_buildbot_config 11:24:27 INFO - Using buildbot properties: 11:24:27 INFO - { 11:24:27 INFO - "project": "", 11:24:27 INFO - "product": "firefox", 11:24:27 INFO - "script_repo_revision": "production", 11:24:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:24:27 INFO - "repository": "", 11:24:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:24:27 INFO - "buildid": "20160705080924", 11:24:27 INFO - "pgo_build": "True", 11:24:27 INFO - "basedir": "/builds/slave/test", 11:24:27 INFO - "buildnumber": 90, 11:24:27 INFO - "slavename": "talos-linux64-ix-007", 11:24:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:24:27 INFO - "platform": "ubuntu64_hw", 11:24:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:24:27 INFO - "branch": "mozilla-beta", 11:24:27 INFO - "repo_path": "releases/mozilla-beta", 11:24:27 INFO - "revision": "274a291aa2c85528ffeb988f0b1b0b61c12136b8", 11:24:27 INFO - "stage_platform": "linux64-pgo", 11:24:27 INFO - "builduid": "63293650764c4d18860755eb5f87d551", 11:24:27 INFO - "slavebuilddir": "test" 11:24:27 INFO - } 11:24:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 11:24:27 INFO - Running post-action listener: _resource_record_post_action 11:24:27 INFO - ##### 11:24:27 INFO - ##### Running download-and-extract step. 11:24:27 INFO - ##### 11:24:27 INFO - Running pre-action listener: _resource_record_pre_action 11:24:27 INFO - Running main action method: download_and_extract 11:24:27 INFO - mkdir: /builds/slave/test/build/tests 11:24: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')]} 11:24:27 INFO - https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:24:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:24:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:24:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:24:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:24:27 INFO - Downloaded 1327 bytes. 11:24:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:24:27 INFO - Using the following test package requirements: 11:24:27 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 11:24:27 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:24:27 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:24:27 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:24:27 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 11:24:27 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:24:27 INFO - u'jsshell-linux-x86_64.zip'], 11:24:27 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:24:27 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:24:27 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 11:24:27 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:24:27 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 11:24:27 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:24:27 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 11:24:27 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:24:27 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:24:27 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:24:27 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:24:27 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:24: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')]} 11:24:27 INFO - https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:24:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:24:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:24:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:28 INFO - Downloaded 24236718 bytes. 11:24:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:30 INFO - Return code: 0 11:24:30 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:30 INFO - https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:24:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:24:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:31 INFO - Downloaded 24236718 bytes. 11:24:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:32 INFO - Return code: 0 11:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:32 INFO - https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:24:33 INFO - Downloaded 10840145 bytes. 11:24:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:24:33 INFO - Return code: 0 11:24:33 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')]} 11:24:33 INFO - https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:24:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:24:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:24:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:24:34 INFO - Downloaded 56019332 bytes. 11:24:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:24:34 INFO - mkdir: /builds/slave/test/properties 11:24:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:34 INFO - Contents: 11:24:34 INFO - build_url:https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:24:35 INFO - Running post-action listener: _resource_record_post_action 11:24:35 INFO - Running post-action listener: set_extra_try_arguments 11:24:35 INFO - ##### 11:24:35 INFO - ##### Running populate-webroot step. 11:24:35 INFO - ##### 11:24:35 INFO - Running pre-action listener: _resource_record_pre_action 11:24:35 INFO - Running main action method: populate_webroot 11:24:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:35 INFO - '--tppagecycles', 11:24:35 INFO - '7'], 11:24:35 INFO - 'tests': ['tsvgm']}}, 11:24:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'talos_options': ['--disable-e10s'], 11:24:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'talos_options': ['--disable-e10s'], 11:24:35 INFO - 'tests': ['damp', 'tps']}, 11:24:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'tests': ['damp', 'tps']}, 11:24:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:35 INFO - 'tests': ['dromaeo_dom']}, 11:24:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:35 INFO - 'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:35 INFO - 'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:35 INFO - 'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:35 INFO - 'tests': ['tsvgx', 11:24:35 INFO - 'tsvgr_opacity', 11:24:35 INFO - 'tart', 11:24:35 INFO - 'tscrollx', 11:24:35 INFO - 'cart']}, 11:24:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:35 INFO - 'tsvgr_opacity', 11:24:35 INFO - 'tart', 11:24:35 INFO - 'tscrollx', 11:24:35 INFO - 'cart']}, 11:24:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'talos_options': ['--disable-e10s'], 11:24:35 INFO - 'tests': ['tp5o']}, 11:24:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'tests': ['tp5o']}, 11:24:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'talos_options': ['--disable-e10s', 11:24:35 INFO - '--xperf_path', 11:24:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:35 INFO - 'tests': ['tp5n']}, 11:24:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'talos_options': ['--xperf_path', 11:24:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:35 INFO - 'tests': ['tp5n']}}, 11:24:35 INFO - 'talos.zip': {'path': '', 11:24:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:35 INFO - Running post-action listener: _resource_record_post_action 11:24:35 INFO - ##### 11:24:35 INFO - ##### Running create-virtualenv step. 11:24:35 INFO - ##### 11:24:35 INFO - Running pre-action listener: _resource_record_pre_action 11:24:35 INFO - Running main action method: create_virtualenv 11:24:35 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:35 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 11:24:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:35 INFO - Using real prefix '/usr' 11:24:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:36 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:38 INFO - Installing pip.................done. 11:24:38 INFO - Return code: 0 11:24:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:38 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')]} 11:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:38 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')]} 11:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:38 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 0x7f9c42129f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', '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 11:24:38 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 11:24:38 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 11:24:38 INFO - Using env: {'DISPLAY': ':0', 11:24:38 INFO - 'HOME': '/home/cltbld', 11:24:38 INFO - 'LANG': 'en_US.UTF-8', 11:24:38 INFO - 'LANGUAGE': 'en_US:en', 11:24:38 INFO - 'LOGNAME': 'cltbld', 11:24:38 INFO - 'MAIL': '/var/mail/cltbld', 11:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:38 INFO - 'MOZ_NO_REMOTE': '1', 11:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:38 INFO - 'NO_EM_RESTART': '1', 11:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:38 INFO - 'PWD': '/builds/slave/test', 11:24:38 INFO - 'SHELL': '/bin/bash', 11:24:38 INFO - 'SHLVL': '1', 11:24:38 INFO - 'TERM': 'linux', 11:24:38 INFO - 'TMOUT': '86400', 11:24:38 INFO - 'USER': 'cltbld', 11:24:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', 11:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:38 INFO - '_': '/tools/buildbot/bin/python'} 11:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:38 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 11:24:38 INFO - Cleaning up... 11:24:38 INFO - Return code: 0 11:24:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:24:38 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')]} 11:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:38 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')]} 11:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:38 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 0x7f9c42129f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', '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 11:24:38 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 11:24:38 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 11:24:38 INFO - Using env: {'DISPLAY': ':0', 11:24:38 INFO - 'HOME': '/home/cltbld', 11:24:38 INFO - 'LANG': 'en_US.UTF-8', 11:24:38 INFO - 'LANGUAGE': 'en_US:en', 11:24:38 INFO - 'LOGNAME': 'cltbld', 11:24:38 INFO - 'MAIL': '/var/mail/cltbld', 11:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:38 INFO - 'MOZ_NO_REMOTE': '1', 11:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:38 INFO - 'NO_EM_RESTART': '1', 11:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:38 INFO - 'PWD': '/builds/slave/test', 11:24:38 INFO - 'SHELL': '/bin/bash', 11:24:38 INFO - 'SHLVL': '1', 11:24:38 INFO - 'TERM': 'linux', 11:24:38 INFO - 'TMOUT': '86400', 11:24:38 INFO - 'USER': 'cltbld', 11:24:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', 11:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:38 INFO - '_': '/tools/buildbot/bin/python'} 11:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:38 INFO - Downloading/unpacking psutil>=0.7.1 11:24:38 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 11:24:38 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 11:24:38 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 11:24:38 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 11:24:38 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 11:24:38 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 11:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:40 INFO - Installing collected packages: psutil 11:24:40 INFO - Running setup.py install for psutil 11:24:40 INFO - building 'psutil._psutil_linux' extension 11:24:40 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 11:24:40 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 11:24:40 INFO - building 'psutil._psutil_posix' extension 11:24:40 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 11:24:41 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 11:24:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:41 INFO - Successfully installed psutil 11:24:41 INFO - Cleaning up... 11:24:41 INFO - Return code: 0 11:24:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:41 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 0x7f9c42129f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', '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 11:24:41 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 11:24:41 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 11:24:41 INFO - Using env: {'DISPLAY': ':0', 11:24:41 INFO - 'HOME': '/home/cltbld', 11:24:41 INFO - 'LANG': 'en_US.UTF-8', 11:24:41 INFO - 'LANGUAGE': 'en_US:en', 11:24:41 INFO - 'LOGNAME': 'cltbld', 11:24:41 INFO - 'MAIL': '/var/mail/cltbld', 11:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:41 INFO - 'MOZ_NO_REMOTE': '1', 11:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:41 INFO - 'NO_EM_RESTART': '1', 11:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:41 INFO - 'PWD': '/builds/slave/test', 11:24:41 INFO - 'SHELL': '/bin/bash', 11:24:41 INFO - 'SHLVL': '1', 11:24:41 INFO - 'TERM': 'linux', 11:24:41 INFO - 'TMOUT': '86400', 11:24:41 INFO - 'USER': 'cltbld', 11:24:41 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', 11:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:41 INFO - '_': '/tools/buildbot/bin/python'} 11:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:24:43 INFO - Installing collected packages: mozsystemmonitor 11:24:43 INFO - Running setup.py install for mozsystemmonitor 11:24:43 INFO - Successfully installed mozsystemmonitor 11:24:43 INFO - Cleaning up... 11:24:43 INFO - Return code: 0 11:24:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:43 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')]} 11:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:43 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')]} 11:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:43 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 0x7f9c42129f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', '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 11:24:43 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 11:24:43 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 11:24:43 INFO - Using env: {'DISPLAY': ':0', 11:24:43 INFO - 'HOME': '/home/cltbld', 11:24:43 INFO - 'LANG': 'en_US.UTF-8', 11:24:43 INFO - 'LANGUAGE': 'en_US:en', 11:24:43 INFO - 'LOGNAME': 'cltbld', 11:24:43 INFO - 'MAIL': '/var/mail/cltbld', 11:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:43 INFO - 'MOZ_NO_REMOTE': '1', 11:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:43 INFO - 'NO_EM_RESTART': '1', 11:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:43 INFO - 'PWD': '/builds/slave/test', 11:24:43 INFO - 'SHELL': '/bin/bash', 11:24:43 INFO - 'SHLVL': '1', 11:24:43 INFO - 'TERM': 'linux', 11:24:43 INFO - 'TMOUT': '86400', 11:24:43 INFO - 'USER': 'cltbld', 11:24:43 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', 11:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:43 INFO - '_': '/tools/buildbot/bin/python'} 11:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:43 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 11:24:43 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 11:24:43 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 11:24:43 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 11:24:43 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 11:24:43 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 11:24:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:45 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 11:24:45 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 11:24:45 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 11:24:45 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 11:24:45 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 11:24:45 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 11:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:46 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 11:24:46 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 11:24:46 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 11:24:46 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 11:24:46 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 11:24:46 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 11:24:46 INFO - Downloading docopt-0.6.1.tar.gz 11:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:46 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:46 INFO - Running setup.py install for blobuploader 11:24:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:46 INFO - Running setup.py install for requests 11:24:46 INFO - Running setup.py install for docopt 11:24:46 INFO - Successfully installed blobuploader requests docopt 11:24:46 INFO - Cleaning up... 11:24:47 INFO - Return code: 0 11:24:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:47 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 0x7f9c42129f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', '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 11:24:47 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 11:24:47 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 11:24:47 INFO - Using env: {'DISPLAY': ':0', 11:24:47 INFO - 'HOME': '/home/cltbld', 11:24:47 INFO - 'LANG': 'en_US.UTF-8', 11:24:47 INFO - 'LANGUAGE': 'en_US:en', 11:24:47 INFO - 'LOGNAME': 'cltbld', 11:24:47 INFO - 'MAIL': '/var/mail/cltbld', 11:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:47 INFO - 'MOZ_NO_REMOTE': '1', 11:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:47 INFO - 'NO_EM_RESTART': '1', 11:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:47 INFO - 'PWD': '/builds/slave/test', 11:24:47 INFO - 'SHELL': '/bin/bash', 11:24:47 INFO - 'SHLVL': '1', 11:24:47 INFO - 'TERM': 'linux', 11:24:47 INFO - 'TMOUT': '86400', 11:24:47 INFO - 'USER': 'cltbld', 11:24:47 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', 11:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:47 INFO - '_': '/tools/buildbot/bin/python'} 11:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:47 INFO - Running setup.py (path:/tmp/pip-krYu0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:47 INFO - Running setup.py (path:/tmp/pip-sL8XFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:47 INFO - Running setup.py (path:/tmp/pip-GJhiym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:47 INFO - Running setup.py (path:/tmp/pip-VvzNMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:47 INFO - Running setup.py (path:/tmp/pip-EzuFgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:47 INFO - Running setup.py (path:/tmp/pip-wjh5oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:47 INFO - Running setup.py (path:/tmp/pip-zQ3Lks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:47 INFO - Running setup.py (path:/tmp/pip-TemvZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:47 INFO - Running setup.py (path:/tmp/pip-CL4QFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:47 INFO - Running setup.py (path:/tmp/pip-yiBLz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:47 INFO - Running setup.py (path:/tmp/pip-uXqb8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:48 INFO - Running setup.py (path:/tmp/pip-PcjyBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:48 INFO - Running setup.py (path:/tmp/pip-8Umcf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:48 INFO - Running setup.py (path:/tmp/pip-cikWgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:48 INFO - Running setup.py (path:/tmp/pip-z2X2fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:48 INFO - Running setup.py (path:/tmp/pip-53giVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:48 INFO - Running setup.py (path:/tmp/pip-lR9HNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:48 INFO - Running setup.py install for manifestparser 11:24:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Running setup.py install for mozcrash 11:24:48 INFO - Running setup.py install for mozdebug 11:24:48 INFO - Running setup.py install for mozdevice 11:24:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Running setup.py install for mozfile 11:24:48 INFO - Running setup.py install for mozhttpd 11:24:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Running setup.py install for mozinfo 11:24:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Running setup.py install for mozInstall 11:24:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Running setup.py install for mozleak 11:24:49 INFO - Running setup.py install for mozlog 11:24:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Running setup.py install for moznetwork 11:24:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Running setup.py install for mozprocess 11:24:49 INFO - Running setup.py install for mozprofile 11:24:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Running setup.py install for mozrunner 11:24:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:49 INFO - Running setup.py install for mozscreenshot 11:24:49 INFO - Running setup.py install for moztest 11:24:50 INFO - Running setup.py install for mozversion 11:24:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:50 INFO - Cleaning up... 11:24:50 INFO - Return code: 0 11:24:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:50 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')]} 11:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:50 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')]} 11:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:50 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 0x7f9c42129f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', '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 11:24:50 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 11:24:50 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 11:24:50 INFO - Using env: {'DISPLAY': ':0', 11:24:50 INFO - 'HOME': '/home/cltbld', 11:24:50 INFO - 'LANG': 'en_US.UTF-8', 11:24:50 INFO - 'LANGUAGE': 'en_US:en', 11:24:50 INFO - 'LOGNAME': 'cltbld', 11:24:50 INFO - 'MAIL': '/var/mail/cltbld', 11:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:50 INFO - 'MOZ_NO_REMOTE': '1', 11:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:50 INFO - 'NO_EM_RESTART': '1', 11:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:50 INFO - 'PWD': '/builds/slave/test', 11:24:50 INFO - 'SHELL': '/bin/bash', 11:24:50 INFO - 'SHLVL': '1', 11:24:50 INFO - 'TERM': 'linux', 11:24:50 INFO - 'TMOUT': '86400', 11:24:50 INFO - 'USER': 'cltbld', 11:24:50 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', 11:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:50 INFO - '_': '/tools/buildbot/bin/python'} 11:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:50 INFO - Running setup.py (path:/tmp/pip-QYFSmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:50 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)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:50 INFO - Running setup.py (path:/tmp/pip-C2EOfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:50 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)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:50 INFO - Running setup.py (path:/tmp/pip-ZjiF3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:50 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)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:50 INFO - Running setup.py (path:/tmp/pip-RTr2Zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:50 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)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:50 INFO - Running setup.py (path:/tmp/pip-l8YejU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:50 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)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:50 INFO - Running setup.py (path:/tmp/pip-Fhabv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:50 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)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:50 INFO - Running setup.py (path:/tmp/pip-8C0Ux8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:50 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)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:50 INFO - Running setup.py (path:/tmp/pip-3qwAGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:51 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)) 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:51 INFO - Running setup.py (path:/tmp/pip-1Evx7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:51 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)) 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:51 INFO - Running setup.py (path:/tmp/pip-3qVW9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:51 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)) 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:51 INFO - Running setup.py (path:/tmp/pip-60xhuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:51 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)) 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:51 INFO - Running setup.py (path:/tmp/pip-k6dRJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:51 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)) 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:51 INFO - Running setup.py (path:/tmp/pip-MzlDsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:51 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)) 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:51 INFO - Running setup.py (path:/tmp/pip-lS09NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:51 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)) 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:51 INFO - Running setup.py (path:/tmp/pip-c7dAiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:51 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)) 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:51 INFO - Running setup.py (path:/tmp/pip-UTxa2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:51 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)) 11:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:51 INFO - Running setup.py (path:/tmp/pip-OfIlwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:51 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)) 11:24:51 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)) 11:24:51 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)) 11:24:51 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)) 11:24:51 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)) 11:24:51 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)) 11:24:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:51 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 11:24:51 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 11:24:51 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 11:24:51 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 11:24:51 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 11:24:51 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 11:24:53 INFO - Downloading blessings-1.6.tar.gz 11:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:53 INFO - Installing collected packages: blessings 11:24:53 INFO - Running setup.py install for blessings 11:24:53 INFO - Successfully installed blessings 11:24:53 INFO - Cleaning up... 11:24:53 INFO - Return code: 0 11:24:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:54 INFO - Reading from file tmpfile_stdout 11:24:54 INFO - Current package versions: 11:24:54 INFO - argparse == 1.2.1 11:24:54 INFO - blessings == 1.6 11:24:54 INFO - blobuploader == 1.2.4 11:24:54 INFO - docopt == 0.6.1 11:24:54 INFO - manifestparser == 1.1 11:24:54 INFO - mozInstall == 1.12 11:24:54 INFO - mozcrash == 0.17 11:24:54 INFO - mozdebug == 0.1 11:24:54 INFO - mozdevice == 0.48 11:24:54 INFO - mozfile == 1.2 11:24:54 INFO - mozhttpd == 0.7 11:24:54 INFO - mozinfo == 0.9 11:24:54 INFO - mozleak == 0.1 11:24:54 INFO - mozlog == 3.1 11:24:54 INFO - moznetwork == 0.27 11:24:54 INFO - mozprocess == 0.22 11:24:54 INFO - mozprofile == 0.28 11:24:54 INFO - mozrunner == 6.11 11:24:54 INFO - mozscreenshot == 0.1 11:24:54 INFO - mozsystemmonitor == 0.0 11:24:54 INFO - moztest == 0.7 11:24:54 INFO - mozversion == 1.4 11:24:54 INFO - psutil == 3.1.1 11:24:54 INFO - requests == 1.2.3 11:24:54 INFO - wsgiref == 0.1.2 11:24:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:54 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 0x7f9c42129f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', '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 11:24:54 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 11:24:54 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 11:24:54 INFO - Using env: {'DISPLAY': ':0', 11:24:54 INFO - 'HOME': '/home/cltbld', 11:24:54 INFO - 'LANG': 'en_US.UTF-8', 11:24:54 INFO - 'LANGUAGE': 'en_US:en', 11:24:54 INFO - 'LOGNAME': 'cltbld', 11:24:54 INFO - 'MAIL': '/var/mail/cltbld', 11:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:54 INFO - 'MOZ_NO_REMOTE': '1', 11:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:54 INFO - 'NO_EM_RESTART': '1', 11:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:54 INFO - 'PWD': '/builds/slave/test', 11:24:54 INFO - 'SHELL': '/bin/bash', 11:24:54 INFO - 'SHLVL': '1', 11:24:54 INFO - 'TERM': 'linux', 11:24:54 INFO - 'TMOUT': '86400', 11:24:54 INFO - 'USER': 'cltbld', 11:24:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', 11:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:54 INFO - '_': '/tools/buildbot/bin/python'} 11:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:54 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)) 11:24:54 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)) 11:24:54 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)) 11:24:54 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)) 11:24:54 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)) 11:24:54 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)) 11:24:54 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)) 11:24:54 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)) 11:24:54 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)) 11:24:54 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)) 11:24:54 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)) 11:24:54 INFO - Cleaning up... 11:24:54 INFO - Return code: 0 11:24:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c42129f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', '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 11:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:24:54 INFO - Using env: {'DISPLAY': ':0', 11:24:54 INFO - 'HOME': '/home/cltbld', 11:24:54 INFO - 'LANG': 'en_US.UTF-8', 11:24:54 INFO - 'LANGUAGE': 'en_US:en', 11:24:54 INFO - 'LOGNAME': 'cltbld', 11:24:54 INFO - 'MAIL': '/var/mail/cltbld', 11:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:54 INFO - 'MOZ_NO_REMOTE': '1', 11:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:54 INFO - 'NO_EM_RESTART': '1', 11:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:54 INFO - 'PWD': '/builds/slave/test', 11:24:54 INFO - 'SHELL': '/bin/bash', 11:24:54 INFO - 'SHLVL': '1', 11:24:54 INFO - 'TERM': 'linux', 11:24:54 INFO - 'TMOUT': '86400', 11:24:54 INFO - 'USER': 'cltbld', 11:24:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', 11:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:54 INFO - '_': '/tools/buildbot/bin/python'} 11:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:54 INFO - Downloading/unpacking jsonschema 11:24:54 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 11:24:54 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 11:24:54 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 11:24:54 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 11:24:54 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 11:24:54 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 11:24:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:56 INFO - Downloading/unpacking functools32 (from jsonschema) 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:56 INFO - warning: no files found matching '*.txt' 11:24:56 INFO - no previously-included directories found matching 'build' 11:24:56 INFO - no previously-included directories found matching 'dist' 11:24:56 INFO - no previously-included directories found matching '.git*' 11:24:56 INFO - Installing collected packages: jsonschema, functools32 11:24:56 INFO - Running setup.py install for functools32 11:24:56 INFO - warning: no files found matching '*.txt' 11:24:56 INFO - no previously-included directories found matching 'build' 11:24:56 INFO - no previously-included directories found matching 'dist' 11:24:56 INFO - no previously-included directories found matching '.git*' 11:24:56 INFO - Successfully installed jsonschema functools32 11:24:56 INFO - Cleaning up... 11:24:56 INFO - Return code: 0 11:24:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:56 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 0x7f9c42129f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', '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 11:24:56 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 11:24:56 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 11:24:56 INFO - Using env: {'DISPLAY': ':0', 11:24:56 INFO - 'HOME': '/home/cltbld', 11:24:56 INFO - 'LANG': 'en_US.UTF-8', 11:24:56 INFO - 'LANGUAGE': 'en_US:en', 11:24:56 INFO - 'LOGNAME': 'cltbld', 11:24:56 INFO - 'MAIL': '/var/mail/cltbld', 11:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:56 INFO - 'MOZ_NO_REMOTE': '1', 11:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:56 INFO - 'NO_EM_RESTART': '1', 11:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:56 INFO - 'PWD': '/builds/slave/test', 11:24:56 INFO - 'SHELL': '/bin/bash', 11:24:56 INFO - 'SHLVL': '1', 11:24:56 INFO - 'TERM': 'linux', 11:24:56 INFO - 'TMOUT': '86400', 11:24:56 INFO - 'USER': 'cltbld', 11:24:56 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', 11:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:56 INFO - '_': '/tools/buildbot/bin/python'} 11:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:57 INFO - Downloading/unpacking flake8 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:24:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:24:58 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 11:24:58 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 11:24:58 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 11:24:58 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 11:24:58 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 11:24:58 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 11:24:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:24:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:24:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:59 INFO - no previously-included directories found matching 'docs/_build' 11:24:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:24:59 INFO - Running setup.py install for pep8 11:24:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:59 INFO - no previously-included directories found matching 'docs/_build' 11:24:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:24:59 INFO - Cleaning up... 11:24:59 INFO - Return code: 0 11:24:59 INFO - Running post-action listener: _resource_record_post_action 11:24:59 INFO - Running post-action listener: _start_resource_monitoring 11:24:59 INFO - Starting resource monitoring. 11:24:59 INFO - ##### 11:24:59 INFO - ##### Running install step. 11:24:59 INFO - ##### 11:24:59 INFO - Running pre-action listener: _resource_record_pre_action 11:24:59 INFO - Running main action method: install 11:24:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:00 INFO - Reading from file tmpfile_stdout 11:25:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:00 INFO - Reading from file tmpfile_stdout 11:25:00 INFO - Output received: 11:25:00 INFO - Usage: mozinstall [options] installer 11:25:00 INFO - Options: 11:25:00 INFO - -h, --help show this help message and exit 11:25:00 INFO - -d DEST, --destination=DEST 11:25:00 INFO - Directory to install application into. [default: 11:25:00 INFO - "/builds/slave/test"] 11:25:00 INFO - --app=APP Application being installed. [default: firefox] 11:25:00 INFO - mkdir: /builds/slave/test/build/application 11:25:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:25:13 INFO - Reading from file tmpfile_stdout 11:25:13 INFO - Output received: 11:25:13 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:13 INFO - Running post-action listener: _resource_record_post_action 11:25:13 INFO - ##### 11:25:13 INFO - ##### Running run-tests step. 11:25:13 INFO - ##### 11:25:13 INFO - Running pre-action listener: _resource_record_pre_action 11:25:13 INFO - Running main action method: run_tests 11:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:13 INFO - Python 2.7.3 11:25:13 INFO - Return code: 0 11:25:13 INFO - grabbing minidump binary from tooltool 11:25: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')]} 11:25:13 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 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:13 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 11:25:13 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 11:25:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:13 INFO - Return code: 0 11:25:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:25:14 INFO - Return code: 0 11:25:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:25:14 INFO - Using env: {'DISPLAY': ':0', 11:25:14 INFO - 'HOME': '/home/cltbld', 11:25:14 INFO - 'LANG': 'en_US.UTF-8', 11:25:14 INFO - 'LANGUAGE': 'en_US:en', 11:25:14 INFO - 'LOGNAME': 'cltbld', 11:25:14 INFO - 'MAIL': '/var/mail/cltbld', 11:25:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:14 INFO - 'MOZ_NO_REMOTE': '1', 11:25:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:14 INFO - 'NO_EM_RESTART': '1', 11:25:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:14 INFO - 'PWD': '/builds/slave/test', 11:25:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:14 INFO - 'SHELL': '/bin/bash', 11:25:14 INFO - 'SHLVL': '1', 11:25:14 INFO - 'TERM': 'linux', 11:25:14 INFO - 'TMOUT': '86400', 11:25:14 INFO - 'USER': 'cltbld', 11:25:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467743062.426934-246075726', 11:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:14 INFO - '_': '/tools/buildbot/bin/python'} 11:25:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:25:14 INFO - mozversion application_buildid: 20160705080924 11:25:14 INFO - mozversion application_changeset: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 11:25:14 INFO - mozversion application_display_name: Firefox 11:25:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:14 INFO - mozversion application_name: Firefox 11:25:14 INFO - mozversion application_remotingname: firefox 11:25:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:14 INFO - mozversion application_vendor: Mozilla 11:25:14 INFO - mozversion application_version: 48.0 11:25:14 INFO - mozversion platform_buildid: 20160705080924 11:25:14 INFO - mozversion platform_changeset: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 11:25:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:14 INFO - mozversion platform_version: 48.0 11:25:14 INFO - using testdate: 1467743114 11:25:14 INFO - actual date: 1467743114 11:25:14 INFO - starting webserver on 'localhost:58164' 11:25:14 INFO - SUITE-START | Running 2 tests 11:25:14 INFO - TEST-START | dromaeo_css 11:25:14 INFO - operating with platform_type : linux_ 11:25:14 INFO - Initialising browser for dromaeo_css test... 11:25:14 INFO - TEST-INFO | started process 15166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFEIvfB/profile http://localhost:58164/getInfo.html) 11:25:18 INFO - PROCESS | 15166 | __metrics Screen width/height:1600/1200 11:25:18 INFO - PROCESS | 15166 | colorDepth:24 11:25:18 INFO - PROCESS | 15166 | Browser inner width/height: 1024/697 11:25:18 INFO - PROCESS | 15166 | __metrics 11:25:19 ERROR - PROCESS | 15166 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:25:20 INFO - TEST-INFO | 15166: exit 0 11:25:20 INFO - Browser initialized. 11:25:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:20 INFO - TEST-INFO | started process 15257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFEIvfB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:31 INFO - PROCESS | 15257 | RSS: Main: 139784192 11:25:31 INFO - PROCESS | 15257 | 11:26:22 INFO - PROCESS | 15257 | 1467743182841 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] 11:28:30 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:58164/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58164/tests/dromaeo/cssquery-ext.html) 11:28:31 INFO - PROCESS | 15257 | RSS: Main: 249962496 11:28:31 INFO - PROCESS | 15257 | 11:31:33 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:58164/tests/dromaeo/cssquery-ext.html (next: http://localhost:58164/tests/dromaeo/cssquery-jquery.html) 11:31:33 INFO - PROCESS | 15257 | RSS: Main: 231014400 11:31:33 INFO - PROCESS | 15257 | 11:34:35 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:58164/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58164/tests/dromaeo/cssquery-mootools.html) 11:34:36 INFO - PROCESS | 15257 | RSS: Main: 224309248 11:34:36 INFO - PROCESS | 15257 | 11:37:37 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:58164/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58164/tests/dromaeo/cssquery-prototype.html) 11:37:38 INFO - PROCESS | 15257 | RSS: Main: 220221440 11:37:38 INFO - PROCESS | 15257 | 11:40:41 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:58164/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58164/tests/dromaeo/cssquery-yui.html) 11:40:41 INFO - PROCESS | 15257 | RSS: Main: 210575360 11:40:41 INFO - PROCESS | 15257 | 11:43:44 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:58164/tests/dromaeo/cssquery-yui.html (next: http://localhost:58164/tests/dromaeo/cssquery-dojo.html) 11:43:44 INFO - PROCESS | 15257 | RSS: Main: 256999424 11:43:44 INFO - PROCESS | 15257 | 11:43:44 INFO - PROCESS | 15257 | __start_tp_report 11:43:44 INFO - PROCESS | 15257 | _x_x_mozilla_page_load 11:43:44 INFO - PROCESS | 15257 | _x_x_mozilla_page_load_details 11:43:44 INFO - PROCESS | 15257 | |i|pagename|runs| 11:43:44 INFO - PROCESS | 15257 | |0;dojo.html;3280.885169019084;3343.6656334366567;3352.1452029732422;3368.9326213475747;3391.270876761496;5526.253955715977;5546.805861794838;5549.056660367737;5563.972180139093;5578;5595.272614560112;5631.746571404286;5647.548196144309;5647.661140331573;5686.857828554288;4892.755362231874;5039.319691841601;5134.9229761553415;5187.325647665798;5213.165893457048;5045.445001049881;5104.744762761866;5135.332406787113;5137.434882162959;5147.948520514784;5079.390473143209;5093.490650934896;5161.767720452589;5173.637845350808;5176.327077479941;5185.922211166836;5193.143131383317;5201.323827902367;5201.869953251161;5231.895362092737;5017.322661440695;5026.673266237683;5071.695698258116;5082.288479612857;5101.872453188663;5449.373322067973;5460.262864513319;5479.643823151482;5495.038368285574;5497;5972.134040564138;5993.850153746148;5995.61028533144;5999.730012149464;6001.279846418414;6056.303525094627;6058.333583305833;6131.84670383244;6140.201773769426;6159.952808022647;5630.859228519279;5676.205331253628;5677.091665333568;5679.6876171810945;5683.147527870852;5952.047672372486;6195.101710252078;6207.286162091327;6211.844703882439;6216.7824126155365;5802.448767367094;5895.7052147393315;5901.1148327750325;5904.970475147683;5915.290165180206;5961.940380596226;5965.970170149121;5966.224390829251;5970.13433052205;5987.072003839412;5780.364159942487;5886.6173698709445;5956.910646340309;5959.314678811992;5963.314218864799;6040.395960403925;6056;6068.4538391544975;6072.848178795565;6132.41742034506;4593.494715581283;4617.653675974316;4618.35343051973;4618.861434156981;4649.604783593365;4011.438398624195;4016.5380981186954;4064.4309796628495;4086.1214838809206;4121.278776214151;5587.636803607753;5607.495325420732;5608.383077861432;5615.241942337814;5615.438456154434;5940.584159108907;5978.521718262528;5989.0716938873675;5991.221141251609;5996.220491336186;5520.696361700145;5596.244506991586;5617.9438205618235;5652.0674088774895;5658.7170641467765;5122.078025955289;5223.13818219997;5223.190405487156;5226.817061402832;5228.08508511009;6144.692765361714;6145.477634401126;6153.169322141453;6156.045812899008;6161.137440758297;5886.617369870859;6039.728212230548;6110.012029148408;6115.362036198588;6144.723487442986;6157.538184636081;6212.099245609452;6227.657478838707;6228.56400051992;6231.9688401557705;5721.942780572307;5948.10778383246;5976.3127240366175;5982.20860116613;6020.247469066367;5996.760129594767;6047.304559975483;6067.059605761114;6072.089186622042;6112.449879510866;5728.3985181557;5746.913796292975;5765.625234359753;5766.192733017465;5781.884362312814;5599.804006859903;5698.914516282342;5774.971125144348;5780.0173970424285;5798.188253644577;5725.341585717696;5735.225744524436;5739.540836732968;5749.683767392834;5784.50831679312;5862.912056319244;5869.911951320648;5873.4126587342635;5873.471387575139;5873.647581145145;5613.803516876889;5740.483356497935;5746.885062298814;5778.364379918122;5896.55775816824 11:43:44 INFO - PROCESS | 15257 | |1;ext.html;665.36790049453;686.4988558352402;695.9965200173998;748.9588072656004;768.2087449926578;32957.83521082394;33508.83245583772;33534.83232583834;33566.66433335663;40171.397429038516;41944.37083443743;42165.15669686604;42405.57594424055;42466;42524.787376063075;8706.869396959051;8879.200871921526;8882.378233523656;8884.511351875644;8885.289176865836;8762.824743505125;8918.464892106495;8921.10788921106;8929.374943753908;8931.50876701781;8878.334124940622;8943.686970956018;8948.06045365237;9108.089191080871;9146.496942668151;8996.235319997808;9092.454452732858;9101.180893719564;9105.817883642356;9107.681231156877;8952.462852228888;9055.728328150166;9065.320100992452;9067.81864362709;9070.27437804974;43599.56400435987;44125.117497650186;44187.77906110481;44353;44362.33456498155;3766.303233901737;3838.251540949516;3891.0855948851995;4015.97992010041;4147.419361289422;33402.49896251558;33821;33858;33918.83040584806;34114.82942585296;4612.976935115336;4666.206744853349;4684.578387945067;4744.335792988984;4836.274558816171;232459.9999999983;232474;232534;233608;233864;61841.690791545756;61933;62331;62366.0645090324;62389;69622.30377696158;70669.29330706627;70694.64652676704;70759;70796.64601676959;18707.15817788203;18716.064196790107;18796.060196990096;18890.716639250422;18974.715379269044;14242.643933901736;14467.92766036163;14552.199629020506;14572.708545829024;14575;19866.70199947002;19960.20159193616;19975.900120499304;20017.499562510762;20914.89542552308;7573;7589.203133670995;7668.731594394169;7679.539227646359;7754.573498457639;1045.9790804183874;1117.5082963496036;1180.7048237940514;1253.7680529101963;1278.878506541877;33125.33749325;33411.3317733644;33452.3309533808;33483.49774753381;33876.83061584676;1222.6209874938797;1249.5314257153568;1264.8229247905301;1273.8216649669055;1361.2921280933858;17454.214560344815;17503.64992700139;17693.380731674588;17818.287268509113;17832.286708531774;470181;470960;474496;480814;482266;63243.36756632467;63878.6806065976;63882;63935.68032159809;63938;1474.1670955909876;1516.2418790604697;1525.9542213733605;1567.6472793621572;1585.7462805950993;29628.703712962593;30945.845270774404;33498.33003339968;33707.15732106717;34952.475712863816;54895.45104548903;55688.44311556833;55692.44307556873;55705;55780;425122;430302;431272;432260;434138;39571.40642890416;46258.768706156254;47021.76489117533;47857.52142478531;48323.75838120787;45371;45905.31142032939;46443.30335045045;46929;47148.292775607704;38055;38707.225855483295;39160.21679566336;39813.60186398215;40284.194316112924;38936.41595376128;38943.41584876286;39199.216015678954;42031.1593768129;42892.35661465018;37205.81397092997;37458.62541374551;37573.81213093917;37600.059998500255;40970.59029409787;35918.461223082195;37115;37260;37272.81363593165;38260.23479530338;28814.279643009093;28876.27809304784;29032.564511532768;29033;29113.85443072856 11:43:44 INFO - PROCESS | 15257 | |2;jquery.html;422.72945314998395;425.62757587111275;428.69348415882655;431.2969859129618;439.39363678124187;18404.723929141055;19069.904650476747;19076.23695052198;19466.61066778667;20415.795842041574;12502.374881255946;12875.871241287585;14027;20226.29207977721;20439.897800511015;5177.378714554259;5177.948220517794;5391.406945236021;5399.568034557226;5417.702026388547;5348.732563371836;5357.732113394334;5358.035553600351;5363.061464243761;5430.728463576826;5352.625316227865;5361.865953351158;5368.32895888014;5375.0593646111965;5378.596605254622;5085.745712714368;5313.946860531384;5333.306670132877;5341.1988201769855;5344.5724342052545;5170.870728231825;5185.714785686786;5201.40183878855;5203.661761985459;5203.947960520384;13423.530176443875;17282;22273.55452890949;23279;23290.767092329028;2394.724606670238;2434.707835059804;2477.913273035435;2494.6881639795024;2981.925451863699;10156.085952264331;10298.3820970742;10396.948015259952;10500.842487362695;10656.627018054409;2017.6872584749387;2045.1921491010967;2060.9072591733257;2082.2087606709506;2085.5620319732875;72541.63729181373;73794;74872.99999999946;75872.62063689702;77134.22865771326;11614.303141811519;11615.477303521362;11617.709557261136;11775.52897884075;11793.233439826385;16287.267072981744;16314.428994985356;16433.424830130887;16440.342386304652;16454.177291135395;8644.135586441305;8746.737597872074;8754.168354006359;8813.911860881437;8877.289816814638;8418.536980466133;8551.486910785372;8586;8636;8666.393352465268;4916.410030796327;4929.06347793918;4950.752462376867;5043.445221025684;5078.21287700407;2005.4485016620547;2076.53278012446;2113.3026101386504;2138.706392156062;2147.8186997151506;945.5933948402253;1097.155190503308;1130.3387518301886;1134.8808375120493;1141.2467771270922;18500;19388.12753426099;19417;19613.32867062985;19714.802851971297;1046.4349251404308;1049.4280617063719;1085.5115198160859;1092.268180319188;1133.8525991621036;10580.735481613021;10978.725531861768;11037.779244415067;11121.721956951142;11179.217454778087;520196;534805;535957;542508;544430;90688.54655726679;91376.54311728399;92460;93533.5323323379;93949;1104.2987702808775;1115.4088333183427;1116.7096554895622;1123.269874581512;1148.0815347721789;16893.32426702918;17220.827791721924;17282.567935801704;17286.74069888978;17314.134293285537;37058.25883482369;37821.43267851039;38076.809615951744;38268;38647.42028869513;55187.44812551823;55396.44603554074;55416;55432.72283638556;55552.72223638856;7993.080795708568;8348.66605335804;8886.777830554287;8911.73264802031;9076.682316119168;12024.639260822189;12965.515863501852;13009.674758131123;13163.53927612529;13839.654008649462;11328;11459.31244125355;11479.827802583135;11637.53449861996;11925.165238433226;11705.707357316136;11775.882241177478;11782;11930.463129159036;12149.57476488354;11847.881521184678;11994.76010479803;12031.699207519881;12067.275963442222;12363.196392234477;8799.692010779592;8804.735857924272;8884.422512536665;9077.364584479023;9281.535923203948;11618.186726929034;11980.460879260629;12022.27866328023;12070.939645302069;12216 11:43:44 INFO - PROCESS | 15257 | |3;mootools.html;1414.2009764483073;1566.5535322433104;1577.0380068158422;1811.7735283089614;1912.9426117216487;7476.925230747691;8044.5977701114925;8218.465799723013;8239.340852731782;8253.1334209908;8024.23769741875;8215.630296636651;8216.630251638675;8225.6298466569;8234.053083895355;2403.267003563912;2413.3122060212845;2414.360194548446;2418.3470462974988;2420.0319872051145;2362.2204672458133;2386.8925898334614;2410.674558934548;2417.492326611414;2419.661247425362;2401.939951501209;2409.313345696477;2418.093215044358;2434.45224824414;2441.121196369306;2412.8069754419603;2437.6709144265474;2441.59713647248;2444.1567659157563;2460.5078984203233;2313.097891822191;2367.7277113132036;2373.121944880388;2378;2378.4648454097864;7327.2306407826945;7916.0896496903015;8287.709930152476;8505.319574434092;8514.872276915852;5080.77136528857;5141.717205553693;5176.767045482925;5178;5179.378474583036;3391.8134502602347;3398.218409765768;3468.549088618489;3527.3121741260466;3530.1704099536587;1132.162199972023;1157.69899826045;1159.1654009113424;1163.191581850614;1181.7577396633756;11690.473928673146;11707.76584468306;11767.058635309155;11785.351805650685;11791.941040294743;4564.42944631921;4566.474855391606;4674.766261686902;4706.317583950308;4715.363425937455;10219.284650074424;10253.84619230712;10258.28192026551;10279.229057820694;10285.43430111351;5245.396779370421;5255.658382205144;5283.762230699628;5284.81503147388;5287.339082614673;4819.228923372244;4829.1790395632825;4832.033593281358;4832.106060378841;4835.637327200474;3823.3118038752737;4047.3321901886447;4062.3500239961463;4069.8575549856205;4075.735077219971;1285.8199852020725;1300.336828217616;1307.6469353274563;1315.9934200328937;1329.3648811961148;1043.7181960870523;1050.1179009631946;1057.672121642278;1060.740118670915;1067.7917806027906;5791.739371728282;5819.359870414251;5924.4667979882015;6021.729022194012;6182.041783523561;1100.7303210713426;1112.360392774158;1136.2046567402851;1140.6016599562806;1143.3368646185193;3888.7083468739393;4029.174019326031;4049.615286547832;4076.510818701775;4113.218488487178;10101.797964040677;10329.896701033043;10339.4313312767;10441.634542791118;10492.055714985689;10291.279610427348;10302.793944121226;10305.690829275134;10350.068493835592;10363.430011349448;7785.871048697907;8052.677892884336;8162.551059691774;8192.18078192188;8224.712135075244;5659.26429564154;5720.11338242573;5756.165356023437;5800.59395842287;5825.650460972355;9107.681231156877;9168.266538676757;9192.95403522978;9229.538523073954;9426.670066547913;9413;9487.098725621056;9506.191973682315;9515.714528564155;9525;7325.890111648436;7416.7774966751085;7449.255074492724;7549.622518874145;7610.429217808797;8095.23095305945;8136.67453301885;8156.592170391338;8185.590720464072;8199.303059240032;7149.785506434815;7275.8181045472165;7295.671694773854;7374.594397308199;7439.665215065227;7270.163931147986;7311;7324.560526368435;7343.963280183565;7482.850342993001;6977.860442791217;7013.509054366145;7045.401140903081;7068.68190931399;7073.1865835427525;4256.723312984646;4825.3485779419325;4825.806967721252;4876.21980483121;4918.2376731606655;4954.653174277766;4959.355283813081;4967.503249675148;5034.421041580265;5058.721770302522 11:43:44 INFO - PROCESS | 15257 | |4;prototype.html;349.52290123980765;353.13658105930995;353.9380608393531;358.8941262327613;361.16030229715915;6057.273127224728;6092.482139018183;6103.694815259241;6106.755729770815;6167.074938759189;6077.3922607739205;6078.604890682102;6089.5128389728825;6090.45185933267;6099.268087829456;4447.332900064992;4580.083983203356;4726.0547890421885;4728.739919304437;4735.928961065587;4696.412948381452;4698.060387922412;4720.55154760299;4734.289856521515;4738.2892566115015;4433.445819272591;4662.51043640418;4671.392718946532;4687.789049492781;4690.319903613991;4529.501754806968;4559;4587.243104887706;4661.743604101773;4697.67116301859;4115.218108559364;4116.238495878242;4118.402831589403;4126.09225970286;4129.793510324502;5857.799151173999;5867.677277749722;5875.794347197871;5887.528997680175;5891.882162356729;5407.540359069484;5409.2967914171295;5411.972940135313;5429.837104886859;5443.537299329561;6413.679316034226;6420.582662126947;6431.196100487439;6431.967840160816;6439.259485159219;4294.849680261176;4400.251957167257;4405.118976204772;4454.5990860822685;4460.241758900995;6608.405243528057;6712.731490740364;6725.192976842761;6725.529212955095;6727.495437842182;4544.454665440168;4561.794719237576;4562.794674239667;4576.222042252825;4585.174668559691;4634.026854360622;4636.582707556337;4652.209124448852;4653.162430762428;4657.67396282257;5358.517733404013;5364.088105022156;5372.462753724596;5377.220303056113;5385.542228910508;6212.47193988516;6388;6403.391677790602;6488.7728929488185;6509.153810004764;1661.9584510387338;1674.0792564089945;1678.5803549112723;1681.7645529625863;1688.3837399349395;1070.5557193764657;1122.7529943412437;1125.3416751200639;1142.6744975828165;1150.1546363422879;6053.273607167168;6167.105769663373;6249.531285153632;6280.309165991737;6284.780032698925;6724.562903411263;6725.6973436195485;6725.8654826903185;6744.730210791611;6749;6236.469900058546;6242.1261023456755;6246.875062498815;6248.656323902138;6260.655663938527;3570.5715314162467;3601.135727425399;3604.981975090108;3606.026372879308;3609.2601016791496;6611.702473388709;6753.3921947025;6765.492588055916;6777.1189745332795;6783.118194634764;6825.044493770876;6862.897056544156;6867.656617169122;6877.1747390313485;6880.208775990725;6772.627505487246;6774.72901083961;6779.93220067793;6780.796576102724;6780.966095169492;6709.161354830646;6711.899321510279;6713.765018224339;6720.361565651256;6728.158980127484;6475.902861456988;6638.269790323157;6643.2360278568585;6643.501737369813;6644.10304608891;6744.190697116377;6749.42629876466;6763.323667633197;6764.2221144569;6764.391204791593;4722.197226471577;4728.078024785272;4729.479757226771;4735.573798358164;4746.406699162605;6671.26616072222;6694.230163531061;6695.363940425652;6702.36327548882;6707.128073350628;6265.185525881606;6480.319566445455;6483.481321494363;6484.513661475503;6504.9674751625935;6499.992501162327;6508.251551071688;6513.218413790375;6519.543631945908;6520.543561950618;6404.551681382259;6406.487481001602;6408.391202835724;6422.325655806073;6429.8714025720155;6558.376954189344;6559.245686745894;6562.081308616702;6571.145751052332;6573.244076931214;5978.730957106854;6060.727267272895;6370.789549985488;6412.871742565216;6418.19772528434 11:43:44 INFO - PROCESS | 15257 | |5;yui.html;899.6266549382007;907.7276816954916;908.1508789282021;914.9954250228752;931.2410385535787;15045.849541504582;15115;15203.315850786714;15265.542033738979;15274.465393711209;14408.495702650409;14437.350319235633;14489.565313040599;14496.275186240671;14510.637234069154;898.3127907151019;903.737916004358;911.5351170902854;911.8267529169469;912.4798864647154;743.6839343279112;896.3322324867983;900.7883147460342;903.7695387676133;904.0146240597747;937.840567103594;966.5312323523086;966.8163049020699;967.5114067395955;969.0890562870878;952.8856537215544;959.2421986630553;959.3140904253457;960.5437417226831;960.8654788329675;579.3742757821543;692.7783109404993;711.5090587494664;714.0360513307046;716.8494616130619;13905.513307034205;13951.883849292133;13972.231527265996;13989.580312590639;14021.929890350482;13662.385192666354;14089.436422543085;14800.185989770558;14835.851641483556;14922.552323430315;11219.551217951272;11419.657410277621;11580.536778528849;11666.475008624548;11802.527898884035;3967.7619342839234;4041.595840415935;4079.8980025499304;4110.568390319003;4192.622663960258;52991.20513192305;53410.73294633502;53493.197602036;53574.46425535695;53578;11531.942340288246;11566.363849988331;11629.127815413878;11777.587784427675;11835.28988260707;20696.745738467183;21102.366928991847;21109.050092745863;21113.577728445653;21113.78886211149;8909.331800115016;8912.153345432174;9062.36563440566;9101.362904596746;9185.265178785681;5006.799728010911;5083.796648134107;5102.515261050268;5160.870978225575;5165.974170129125;3559.9110022249133;3601.099725068733;3610.855565777392;3615.7468977171347;3618.6743193112748;634.6350848262267;644.7034364192431;651.9869602607921;652.8988006858945;653.6764301670703;790.1426951757408;798.3094623150932;807.2494163270179;829.4940086547201;831.0899564976341;9072.54637268134;9331.860022099674;9401.90598094024;9455.385399948982;9486.715398538056;633.2590868683651;708.890122031086;755.7430473638989;777.8560966221268;786.6106277392613;4275.3800698898485;4352.978235108804;4355.978220108943;4445;4534.727916325031;57596.136057959164;57980.71009644925;60855.695721521995;62148.06777898335;62267;53530;53834;54751.178732319044;54971.625709357584;54994;49420.258696119585;49863.75068124636;49948.750256249215;50455.49544504582;51479.99999999925;8551.102134275812;8690.217880390795;8783.604737786687;8805.69180078694;8884.555772211494;37698.43452348272;37786.62213377831;37878.2424351517;39227.803860980515;39274.03629818555;45465.31802022906;48569.5143048565;48628.27057594209;48647.27029094496;48872.75563622159;12630.810537841757;12714.936425317814;12750.426230819821;13050.15174013686;13199.604011879659;13770.311484425538;13893.374798134311;13958.511452099128;14121.929390352983;14167.858321417067;12565.560205392767;13197.352155361656;13383.19700817954;13675.863241367857;13763.587092387244;13595.45618175262;13618.114822536503;13701.657458563217;13792.586222413343;14068.577942661737;12941.417636206581;13263.270520121487;13271.270080145685;13596.456141754219;13696.794548081985;11185.488880606286;11301.321920684784;11402.771944560896;11721.941390292994;12041.939790300992;10201.723103172886;10592.311499752492;10871.891281087088;10962;10994.175436842428 11:43:44 INFO - PROCESS | 15257 | __end_tp_report 11:43:44 INFO - PROCESS | 15257 | __start_cc_report 11:43:44 INFO - PROCESS | 15257 | _x_x_mozilla_cycle_collect,848 11:43:44 INFO - PROCESS | 15257 | __end_cc_report 11:43:44 INFO - PROCESS | 15257 | __startTimestamp1467744224386__endTimestamp 11:43:44 INFO - PROCESS | 15257 | 11:43:44 INFO - PROCESS | 15257 | ------- Summary: start ------- 11:43:44 INFO - PROCESS | 15257 | Number of tests: 6 11:43:44 INFO - PROCESS | 15257 | 11:43:44 INFO - PROCESS | 15257 | [#0] dojo.html Cycles:165 Average:5567.97 Median:5739.54 stddev:619.07 (10.8%) stddev-sans-first:594.40 11:43:44 INFO - PROCESS | 15257 | Values: 3280.9 3343.7 3352.1 3368.9 3391.3 5526.3 5546.8 5549.1 5564.0 5578.0 5595.3 5631.7 5647.5 5647.7 5686.9 4892.8 5039.3 5134.9 5187.3 5213.2 5045.4 5104.7 5135.3 5137.4 5147.9 5079.4 5093.5 5161.8 5173.6 5176.3 5185.9 5193.1 5201.3 5201.9 5231.9 5017.3 5026.7 5071.7 5082.3 5101.9 5449.4 5460.3 5479.6 5495.0 5497.0 5972.1 5993.9 5995.6 5999.7 6001.3 6056.3 6058.3 6131.8 6140.2 6160.0 5630.9 5676.2 5677.1 5679.7 5683.1 5952.0 6195.1 6207.3 6211.8 6216.8 5802.4 5895.7 5901.1 5905.0 5915.3 5961.9 5966.0 5966.2 5970.1 5987.1 5780.4 5886.6 5956.9 5959.3 5963.3 6040.4 6056.0 6068.5 6072.8 6132.4 4593.5 4617.7 4618.4 4618.9 4649.6 4011.4 4016.5 4064.4 4086.1 4121.3 5587.6 5607.5 5608.4 5615.2 5615.4 5940.6 5978.5 5989.1 5991.2 5996.2 5520.7 5596.2 5617.9 5652.1 5658.7 5122.1 5223.1 5223.2 5226.8 5228.1 6144.7 6145.5 6153.2 6156.0 6161.1 5886.6 6039.7 6110.0 6115.4 6144.7 6157.5 6212.1 6227.7 6228.6 6232.0 5721.9 5948.1 5976.3 5982.2 6020.2 5996.8 6047.3 6067.1 6072.1 6112.4 5728.4 5746.9 5765.6 5766.2 5781.9 5599.8 5698.9 5775.0 5780.0 5798.2 5725.3 5735.2 5739.5 5749.7 5784.5 5862.9 5869.9 5873.4 5873.5 5873.6 5613.8 5740.5 5746.9 5778.4 5896.6 11:43:44 INFO - PROCESS | 15257 | 11:43:44 INFO - PROCESS | 15257 | [#1] ext.html Cycles:180 Average:56261.37 Median:42098.16 stddev:104279.41 (247.7%) stddev-sans-first:104488.39 11:43:44 INFO - PROCESS | 15257 | Values: 665.4 686.5 696.0 749.0 768.2 32957.8 33508.8 33534.8 33566.7 40171.4 41944.4 42165.2 42405.6 42466.0 42524.8 8706.9 8879.2 8882.4 8884.5 8885.3 8762.8 8918.5 8921.1 8929.4 8931.5 8878.3 8943.7 8948.1 9108.1 9146.5 8996.2 9092.5 9101.2 9105.8 9107.7 8952.5 9055.7 9065.3 9067.8 9070.3 43599.6 44125.1 44187.8 44353.0 44362.3 3766.3 3838.3 3891.1 4016.0 4147.4 33402.5 33821.0 33858.0 33918.8 34114.8 4613.0 4666.2 4684.6 4744.3 4836.3 232460.0 232474.0 232534.0 233608.0 233864.0 61841.7 61933.0 62331.0 62366.1 62389.0 69622.3 70669.3 70694.6 70759.0 70796.6 18707.2 18716.1 18796.1 18890.7 18974.7 14242.6 14467.9 14552.2 14572.7 14575.0 19866.7 19960.2 19975.9 20017.5 20914.9 7573.0 7589.2 7668.7 7679.5 7754.6 1046.0 1117.5 1180.7 1253.8 1278.9 33125.3 33411.3 33452.3 33483.5 33876.8 1222.6 1249.5 1264.8 1273.8 1361.3 17454.2 17503.6 17693.4 17818.3 17832.3 470181.0 470960.0 474496.0 480814.0 482266.0 63243.4 63878.7 63882.0 63935.7 63938.0 1474.2 1516.2 1526.0 1567.6 1585.7 29628.7 30945.8 33498.3 33707.2 34952.5 54895.5 55688.4 55692.4 55705.0 55780.0 425122.0 430302.0 431272.0 432260.0 434138.0 39571.4 46258.8 47021.8 47857.5 48323.8 45371.0 45905.3 46443.3 46929.0 47148.3 38055.0 38707.2 39160.2 39813.6 40284.2 38936.4 38943.4 39199.2 42031.2 42892.4 37205.8 37458.6 37573.8 37600.1 40970.6 35918.5 37115.0 37260.0 37272.8 38260.2 28814.3 28876.3 29032.6 29033.0 29113.9 11:43:44 INFO - PROCESS | 15257 | 11:43:44 INFO - PROCESS | 15257 | [#2] jquery.html Cycles:180 Average:29854.40 Median:12210.69 stddev:87973.25 (720.5%) stddev-sans-first:88192.28 11:43:44 INFO - PROCESS | 15257 | Values: 422.7 425.6 428.7 431.3 439.4 18404.7 19069.9 19076.2 19466.6 20415.8 12502.4 12875.9 14027.0 20226.3 20439.9 5177.4 5177.9 5391.4 5399.6 5417.7 5348.7 5357.7 5358.0 5363.1 5430.7 5352.6 5361.9 5368.3 5375.1 5378.6 5085.7 5313.9 5333.3 5341.2 5344.6 5170.9 5185.7 5201.4 5203.7 5203.9 13423.5 17282.0 22273.6 23279.0 23290.8 2394.7 2434.7 2477.9 2494.7 2981.9 10156.1 10298.4 10396.9 10500.8 10656.6 2017.7 2045.2 2060.9 2082.2 2085.6 72541.6 73794.0 74873.0 75872.6 77134.2 11614.3 11615.5 11617.7 11775.5 11793.2 16287.3 16314.4 16433.4 16440.3 16454.2 8644.1 8746.7 8754.2 8813.9 8877.3 8418.5 8551.5 8586.0 8636.0 8666.4 4916.4 4929.1 4950.8 5043.4 5078.2 2005.4 2076.5 2113.3 2138.7 2147.8 945.6 1097.2 1130.3 1134.9 1141.2 18500.0 19388.1 19417.0 19613.3 19714.8 1046.4 1049.4 1085.5 1092.3 1133.9 10580.7 10978.7 11037.8 11121.7 11179.2 520196.0 534805.0 535957.0 542508.0 544430.0 90688.5 91376.5 92460.0 93533.5 93949.0 1104.3 1115.4 1116.7 1123.3 1148.1 16893.3 17220.8 17282.6 17286.7 17314.1 37058.3 37821.4 38076.8 38268.0 38647.4 55187.4 55396.4 55416.0 55432.7 55552.7 7993.1 8348.7 8886.8 8911.7 9076.7 12024.6 12965.5 13009.7 13163.5 13839.7 11328.0 11459.3 11479.8 11637.5 11925.2 11705.7 11775.9 11782.0 11930.5 12149.6 11847.9 11994.8 12031.7 12067.3 12363.2 8799.7 8804.7 8884.4 9077.4 9281.5 11618.2 11980.5 12022.3 12070.9 12216.0 11:43:44 INFO - PROCESS | 15257 | 11:43:44 INFO - PROCESS | 15257 | [#3] mootools.html Cycles:180 Average:5619.70 Median:4767.30 stddev:3055.28 (64.1%) stddev-sans-first:3047.50 11:43:44 INFO - PROCESS | 15257 | Values: 1414.2 1566.6 1577.0 1811.8 1912.9 7476.9 8044.6 8218.5 8239.3 8253.1 8024.2 8215.6 8216.6 8225.6 8234.1 2403.3 2413.3 2414.4 2418.3 2420.0 2362.2 2386.9 2410.7 2417.5 2419.7 2401.9 2409.3 2418.1 2434.5 2441.1 2412.8 2437.7 2441.6 2444.2 2460.5 2313.1 2367.7 2373.1 2378.0 2378.5 7327.2 7916.1 8287.7 8505.3 8514.9 5080.8 5141.7 5176.8 5178.0 5179.4 3391.8 3398.2 3468.5 3527.3 3530.2 1132.2 1157.7 1159.2 1163.2 1181.8 11690.5 11707.8 11767.1 11785.4 11791.9 4564.4 4566.5 4674.8 4706.3 4715.4 10219.3 10253.8 10258.3 10279.2 10285.4 5245.4 5255.7 5283.8 5284.8 5287.3 4819.2 4829.2 4832.0 4832.1 4835.6 3823.3 4047.3 4062.4 4069.9 4075.7 1285.8 1300.3 1307.6 1316.0 1329.4 1043.7 1050.1 1057.7 1060.7 1067.8 5791.7 5819.4 5924.5 6021.7 6182.0 1100.7 1112.4 1136.2 1140.6 1143.3 3888.7 4029.2 4049.6 4076.5 4113.2 10101.8 10329.9 10339.4 10441.6 10492.1 10291.3 10302.8 10305.7 10350.1 10363.4 7785.9 8052.7 8162.6 8192.2 8224.7 5659.3 5720.1 5756.2 5800.6 5825.7 9107.7 9168.3 9193.0 9229.5 9426.7 9413.0 9487.1 9506.2 9515.7 9525.0 7325.9 7416.8 7449.3 7549.6 7610.4 8095.2 8136.7 8156.6 8185.6 8199.3 7149.8 7275.8 7295.7 7374.6 7439.7 7270.2 7311.0 7324.6 7344.0 7482.9 6977.9 7013.5 7045.4 7068.7 7073.2 4256.7 4825.3 4825.8 4876.2 4918.2 4954.7 4959.4 4967.5 5034.4 5058.7 11:43:44 INFO - PROCESS | 15257 | 11:43:44 INFO - PROCESS | 15257 | [#4] prototype.html Cycles:180 Average:5409.29 Median:6105.23 stddev:1617.13 (26.5%) stddev-sans-first:1576.45 11:43:44 INFO - PROCESS | 15257 | Values: 349.5 353.1 353.9 358.9 361.2 6057.3 6092.5 6103.7 6106.8 6167.1 6077.4 6078.6 6089.5 6090.5 6099.3 4447.3 4580.1 4726.1 4728.7 4735.9 4696.4 4698.1 4720.6 4734.3 4738.3 4433.4 4662.5 4671.4 4687.8 4690.3 4529.5 4559.0 4587.2 4661.7 4697.7 4115.2 4116.2 4118.4 4126.1 4129.8 5857.8 5867.7 5875.8 5887.5 5891.9 5407.5 5409.3 5412.0 5429.8 5443.5 6413.7 6420.6 6431.2 6432.0 6439.3 4294.8 4400.3 4405.1 4454.6 4460.2 6608.4 6712.7 6725.2 6725.5 6727.5 4544.5 4561.8 4562.8 4576.2 4585.2 4634.0 4636.6 4652.2 4653.2 4657.7 5358.5 5364.1 5372.5 5377.2 5385.5 6212.5 6388.0 6403.4 6488.8 6509.2 1662.0 1674.1 1678.6 1681.8 1688.4 1070.6 1122.8 1125.3 1142.7 1150.2 6053.3 6167.1 6249.5 6280.3 6284.8 6724.6 6725.7 6725.9 6744.7 6749.0 6236.5 6242.1 6246.9 6248.7 6260.7 3570.6 3601.1 3605.0 3606.0 3609.3 6611.7 6753.4 6765.5 6777.1 6783.1 6825.0 6862.9 6867.7 6877.2 6880.2 6772.6 6774.7 6779.9 6780.8 6781.0 6709.2 6711.9 6713.8 6720.4 6728.2 6475.9 6638.3 6643.2 6643.5 6644.1 6744.2 6749.4 6763.3 6764.2 6764.4 4722.2 4728.1 4729.5 4735.6 4746.4 6671.3 6694.2 6695.4 6702.4 6707.1 6265.2 6480.3 6483.5 6484.5 6505.0 6500.0 6508.3 6513.2 6519.5 6520.5 6404.6 6406.5 6408.4 6422.3 6429.9 6558.4 6559.2 6562.1 6571.1 6573.2 5978.7 6060.7 6370.8 6412.9 6418.2 11:43:44 INFO - PROCESS | 15257 | 11:43:44 INFO - PROCESS | 15257 | [#5] yui.html Cycles:180 Average:15229.76 Median:47017.42 stddev:17070.13 (36.3%) stddev-sans-first:17084.09 11:43:44 INFO - PROCESS | 15257 | Values: 899.6 907.7 908.2 915.0 931.2 15045.8 15115.0 15203.3 15265.5 15274.5 14408.5 14437.4 14489.6 14496.3 14510.6 898.3 903.7 911.5 911.8 912.5 743.7 896.3 900.8 903.8 904.0 937.8 966.5 966.8 967.5 969.1 952.9 959.2 959.3 960.5 960.9 579.4 692.8 711.5 714.0 716.8 13905.5 13951.9 13972.2 13989.6 14021.9 13662.4 14089.4 14800.2 14835.9 14922.6 11219.6 11419.7 11580.5 11666.5 11802.5 3967.8 4041.6 4079.9 4110.6 4192.6 52991.2 53410.7 53493.2 53574.5 53578.0 11531.9 11566.4 11629.1 11777.6 11835.3 20696.7 21102.4 21109.1 21113.6 21113.8 8909.3 8912.2 9062.4 9101.4 9185.3 5006.8 5083.8 5102.5 5160.9 5166.0 3559.9 3601.1 3610.9 3615.7 3618.7 634.6 644.7 652.0 652.9 653.7 790.1 798.3 807.2 829.5 831.1 9072.5 9331.9 9401.9 9455.4 9486.7 633.3 708.9 755.7 777.9 786.6 4275.4 4353.0 4356.0 4445.0 4534.7 57596.1 57980.7 60855.7 62148.1 62267.0 53530.0 53834.0 54751.2 54971.6 54994.0 49420.3 49863.8 49948.8 50455.5 51480.0 8551.1 8690.2 8783.6 8805.7 8884.6 37698.4 37786.6 37878.2 39227.8 39274.0 45465.3 48569.5 48628.3 48647.3 48872.8 12630.8 12714.9 12750.4 13050.2 13199.6 13770.3 13893.4 13958.5 14121.9 14167.9 12565.6 13197.4 13383.2 13675.9 13763.6 13595.5 13618.1 13701.7 13792.6 14068.6 12941.4 13263.3 13271.3 13596.5 13696.8 11185.5 11301.3 11402.8 11721.9 12041.9 10201.7 10592.3 10871.9 10962.0 10994.2 11:43:44 INFO - PROCESS | 15257 | -------- Summary: end -------- 11:43:44 INFO - PROCESS | 15257 | 11:43:45 INFO - TEST-INFO | 15257: exit 0 11:43:45 INFO - TEST-OK | dromaeo_css | took 1110388ms 11:43:45 INFO - TEST-START | kraken 11:43:45 INFO - operating with platform_type : linux_ 11:43:45 INFO - Initialising browser for kraken test... 11:43:45 INFO - TEST-INFO | started process 15450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeDKLVm/profile http://localhost:58164/getInfo.html) 11:43:48 INFO - PROCESS | 15450 | __metrics Screen width/height:1600/1200 11:43:48 INFO - PROCESS | 15450 | colorDepth:24 11:43:48 INFO - PROCESS | 15450 | Browser inner width/height: 1024/697 11:43:48 INFO - PROCESS | 15450 | __metrics 11:43:49 ERROR - PROCESS | 15450 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:43:50 INFO - TEST-INFO | 15450: exit 0 11:43:50 INFO - Browser initialized. 11:43:50 INFO - Running cycle 1/1 for kraken test... 11:43:50 INFO - TEST-INFO | started process 15542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeDKLVm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:02 INFO - PROCESS | 15542 | RSS: Main: 139845632 11:44:02 INFO - PROCESS | 15542 | 11:44:04 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58164/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:05 INFO - PROCESS | 15542 | RSS: Main: 198082560 11:44:05 INFO - PROCESS | 15542 | 11:44:08 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58164/tests/kraken/driver.html?testName=audio-dft) 11:44:08 INFO - PROCESS | 15542 | RSS: Main: 183881728 11:44:08 INFO - PROCESS | 15542 | 11:44:11 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58164/tests/kraken/driver.html?testName=audio-fft) 11:44:12 INFO - PROCESS | 15542 | RSS: Main: 272797696 11:44:12 INFO - PROCESS | 15542 | 11:44:14 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58164/tests/kraken/driver.html?testName=audio-oscillator) 11:44:14 INFO - PROCESS | 15542 | RSS: Main: 180101120 11:44:14 INFO - PROCESS | 15542 | 11:44:16 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58164/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:17 INFO - PROCESS | 15542 | RSS: Main: 177922048 11:44:17 INFO - PROCESS | 15542 | 11:44:20 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58164/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:21 INFO - PROCESS | 15542 | RSS: Main: 212766720 11:44:21 INFO - PROCESS | 15542 | 11:44:24 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58164/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:25 INFO - PROCESS | 15542 | RSS: Main: 212533248 11:44:25 INFO - PROCESS | 15542 | 11:44:27 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58164/tests/kraken/driver.html?testName=json-parse-financial) 11:44:28 INFO - PROCESS | 15542 | RSS: Main: 212271104 11:44:28 INFO - PROCESS | 15542 | 11:44:29 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58164/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:30 INFO - PROCESS | 15542 | RSS: Main: 193064960 11:44:30 INFO - PROCESS | 15542 | 11:44:32 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58164/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:32 INFO - PROCESS | 15542 | RSS: Main: 195764224 11:44:32 INFO - PROCESS | 15542 | 11:44:34 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58164/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:35 INFO - PROCESS | 15542 | RSS: Main: 209281024 11:44:35 INFO - PROCESS | 15542 | 11:44:37 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:38 INFO - PROCESS | 15542 | RSS: Main: 220078080 11:44:38 INFO - PROCESS | 15542 | 11:44:41 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:41 INFO - PROCESS | 15542 | RSS: Main: 215171072 11:44:41 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | Cycle 1(1): loaded http://localhost:58164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58164/tests/kraken/driver.html?testName=ai-astar) 11:44:43 INFO - PROCESS | 15542 | RSS: Main: 276168704 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | __start_tp_report 11:44:43 INFO - PROCESS | 15542 | _x_x_mozilla_page_load 11:44:43 INFO - PROCESS | 15542 | _x_x_mozilla_page_load_details 11:44:43 INFO - PROCESS | 15542 | |i|pagename|runs| 11:44:43 INFO - PROCESS | 15542 | |0;ai-astar;114;113;113;112;113;113;107;110;110;110 11:44:43 INFO - PROCESS | 15542 | |1;audio-beat-detection;154;125;152;180;130;154;157;127;175;126 11:44:43 INFO - PROCESS | 15542 | |2;audio-dft;165;162;163;165;162;161;162;160;161;159 11:44:43 INFO - PROCESS | 15542 | |3;audio-fft;76;77;73;173;77;76;77;76;173;76 11:44:43 INFO - PROCESS | 15542 | |4;audio-oscillator;92;92;149;93;92;91;150;93;92;155 11:44:43 INFO - PROCESS | 15542 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;116;117 11:44:43 INFO - PROCESS | 15542 | |6;imaging-darkroom;145;146;145;153;145;146;146;145;145;144 11:44:43 INFO - PROCESS | 15542 | |7;imaging-desaturate;95;94;95;94;94;95;95;95;94;94 11:44:43 INFO - PROCESS | 15542 | |8;json-parse-financial;58;57;56;55;56;55;55;77;53;53 11:44:43 INFO - PROCESS | 15542 | |9;json-stringify-tinderbox;57;57;58;57;58;57;57;58;58;58 11:44:43 INFO - PROCESS | 15542 | |10;stanford-crypto-aes;72;72;73;79;73;73;73;74;73;74 11:44:43 INFO - PROCESS | 15542 | |11;stanford-crypto-ccm;118;112;110;110;114;111;112;114;128;138 11:44:43 INFO - PROCESS | 15542 | |12;stanford-crypto-pbkdf2;163;168;160;166;162;162;169;160;164;163 11:44:43 INFO - PROCESS | 15542 | |13;stanford-crypto-sha256-iterative;69;67;67;67;65;68;67;66;66;65 11:44:43 INFO - PROCESS | 15542 | __end_tp_report 11:44:43 INFO - PROCESS | 15542 | __start_cc_report 11:44:43 INFO - PROCESS | 15542 | _x_x_mozilla_cycle_collect,1604 11:44:43 INFO - PROCESS | 15542 | __end_cc_report 11:44:43 INFO - PROCESS | 15542 | __startTimestamp1467744283563__endTimestamp 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | ------- Summary: start ------- 11:44:43 INFO - PROCESS | 15542 | Number of tests: 14 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:2.17 (1.9%) stddev-sans-first:2.11 11:44:43 INFO - PROCESS | 15542 | Values: 114.0 113.0 113.0 112.0 113.0 113.0 107.0 110.0 110.0 110.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:154.00 stddev:20.28 (13.2%) stddev-sans-first:21.39 11:44:43 INFO - PROCESS | 15542 | Values: 154.0 125.0 152.0 180.0 130.0 154.0 157.0 127.0 175.0 126.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.94 (1.2%) stddev-sans-first:1.73 11:44:43 INFO - PROCESS | 15542 | Values: 165.0 162.0 163.0 165.0 162.0 161.0 162.0 160.0 161.0 159.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:40.92 (53.8%) stddev-sans-first:42.79 11:44:43 INFO - PROCESS | 15542 | Values: 76.0 77.0 73.0 173.0 77.0 76.0 77.0 76.0 173.0 76.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.00 stddev:28.64 (31.1%) stddev-sans-first:29.63 11:44:43 INFO - PROCESS | 15542 | Values: 92.0 92.0 149.0 93.0 92.0 91.0 150.0 93.0 92.0 155.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 11:44:43 INFO - PROCESS | 15542 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:145.50 stddev:2.54 (1.7%) stddev-sans-first:2.67 11:44:43 INFO - PROCESS | 15542 | Values: 145.0 146.0 145.0 153.0 145.0 146.0 146.0 145.0 145.0 144.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 11:44:43 INFO - PROCESS | 15542 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.00 stddev:7.03 (12.5%) stddev-sans-first:7.45 11:44:43 INFO - PROCESS | 15542 | Values: 58.0 57.0 56.0 55.0 56.0 55.0 55.0 77.0 53.0 53.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:58.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 11:44:43 INFO - PROCESS | 15542 | Values: 57.0 57.0 58.0 57.0 58.0 57.0 57.0 58.0 58.0 58.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.00 stddev:2.01 (2.8%) stddev-sans-first:2.05 11:44:43 INFO - PROCESS | 15542 | Values: 72.0 72.0 73.0 79.0 73.0 73.0 73.0 74.0 73.0 74.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:114.00 stddev:9.21 (8.1%) stddev-sans-first:9.76 11:44:43 INFO - PROCESS | 15542 | Values: 118.0 112.0 110.0 110.0 114.0 111.0 112.0 114.0 128.0 138.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:163.50 stddev:3.09 (1.9%) stddev-sans-first:3.27 11:44:43 INFO - PROCESS | 15542 | Values: 163.0 168.0 160.0 166.0 162.0 162.0 169.0 160.0 164.0 163.0 11:44:43 INFO - PROCESS | 15542 | 11:44:43 INFO - PROCESS | 15542 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.01 11:44:43 INFO - PROCESS | 15542 | Values: 69.0 67.0 67.0 67.0 65.0 68.0 67.0 66.0 66.0 65.0 11:44:43 INFO - PROCESS | 15542 | -------- Summary: end -------- 11:44:43 INFO - PROCESS | 15542 | 11:44:44 INFO - TEST-INFO | 15542: exit 0 11:44:44 INFO - TEST-OK | kraken | took 59436ms 11:44:44 INFO - SUITE-END | took 1169s 11:44:44 INFO - Completed test suite (00:19:30) 11:44:44 INFO - javascript benchmark 11:44:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3280.885169019084, 3343.6656334366567, 3352.1452029732422, 3368.9326213475747, 3391.270876761496, 5526.253955715977, 5546.805861794838, 5549.056660367737, 5563.972180139093, 5578.0, 5595.272614560112, 5631.746571404286, 5647.548196144309, 5647.661140331573, 5686.857828554288, 4892.755362231874, 5039.319691841601, 5134.9229761553415, 5187.325647665798, 5213.165893457048, 5045.445001049881, 5104.744762761866, 5135.332406787113, 5137.434882162959, 5147.948520514784, 5079.390473143209, 5093.490650934896, 5161.767720452589, 5173.637845350808, 5176.327077479941, 5185.922211166836, 5193.143131383317, 5201.323827902367, 5201.869953251161, 5231.895362092737, 5017.322661440695, 5026.673266237683, 5071.695698258116, 5082.288479612857, 5101.872453188663, 5449.373322067973, 5460.262864513319, 5479.643823151482, 5495.038368285574, 5497.0, 5972.134040564138, 5993.850153746148, 5995.61028533144, 5999.730012149464, 6001.279846418414, 6056.303525094627, 6058.333583305833, 6131.84670383244, 6140.201773769426, 6159.952808022647, 5630.859228519279, 5676.205331253628, 5677.091665333568, 5679.6876171810945, 5683.147527870852, 5952.047672372486, 6195.101710252078, 6207.286162091327, 6211.844703882439, 6216.7824126155365, 5802.448767367094, 5895.7052147393315, 5901.1148327750325, 5904.970475147683, 5915.290165180206, 5961.940380596226, 5965.970170149121, 5966.224390829251, 5970.13433052205, 5987.072003839412, 5780.364159942487, 5886.6173698709445, 5956.910646340309, 5959.314678811992, 5963.314218864799, 6040.395960403925, 6056.0, 6068.4538391544975, 6072.848178795565, 6132.41742034506, 4593.494715581283, 4617.653675974316, 4618.35343051973, 4618.861434156981, 4649.604783593365, 4011.438398624195, 4016.5380981186954, 4064.4309796628495, 4086.1214838809206, 4121.278776214151, 5587.636803607753, 5607.495325420732, 5608.383077861432, 5615.241942337814, 5615.438456154434, 5940.584159108907, 5978.521718262528, 5989.0716938873675, 5991.221141251609, 5996.220491336186, 5520.696361700145, 5596.244506991586, 5617.9438205618235, 5652.0674088774895, 5658.7170641467765, 5122.078025955289, 5223.13818219997, 5223.190405487156, 5226.817061402832, 5228.08508511009, 6144.692765361714, 6145.477634401126, 6153.169322141453, 6156.045812899008, 6161.137440758297, 5886.617369870859, 6039.728212230548, 6110.012029148408, 6115.362036198588, 6144.723487442986, 6157.538184636081, 6212.099245609452, 6227.657478838707, 6228.56400051992, 6231.9688401557705, 5721.942780572307, 5948.10778383246, 5976.3127240366175, 5982.20860116613, 6020.247469066367, 5996.760129594767, 6047.304559975483, 6067.059605761114, 6072.089186622042, 6112.449879510866, 5728.3985181557, 5746.913796292975, 5765.625234359753, 5766.192733017465, 5781.884362312814, 5599.804006859903, 5698.914516282342, 5774.971125144348, 5780.0173970424285, 5798.188253644577, 5725.341585717696, 5735.225744524436, 5739.540836732968, 5749.683767392834, 5784.50831679312, 5862.912056319244, 5869.911951320648, 5873.4126587342635, 5873.471387575139, 5873.647581145145, 5613.803516876889, 5740.483356497935, 5746.885062298814, 5778.364379918122, 5896.55775816824], "value": 5527.583842490393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.36790049453, 686.4988558352402, 695.9965200173998, 748.9588072656004, 768.2087449926578, 32957.83521082394, 33508.83245583772, 33534.83232583834, 33566.66433335663, 40171.397429038516, 41944.37083443743, 42165.15669686604, 42405.57594424055, 42466.0, 42524.787376063075, 8706.869396959051, 8879.200871921526, 8882.378233523656, 8884.511351875644, 8885.289176865836, 8762.824743505125, 8918.464892106495, 8921.10788921106, 8929.374943753908, 8931.50876701781, 8878.334124940622, 8943.686970956018, 8948.06045365237, 9108.089191080871, 9146.496942668151, 8996.235319997808, 9092.454452732858, 9101.180893719564, 9105.817883642356, 9107.681231156877, 8952.462852228888, 9055.728328150166, 9065.320100992452, 9067.81864362709, 9070.27437804974, 43599.56400435987, 44125.117497650186, 44187.77906110481, 44353.0, 44362.33456498155, 3766.303233901737, 3838.251540949516, 3891.0855948851995, 4015.97992010041, 4147.419361289422, 33402.49896251558, 33821.0, 33858.0, 33918.83040584806, 34114.82942585296, 4612.976935115336, 4666.206744853349, 4684.578387945067, 4744.335792988984, 4836.274558816171, 232459.9999999983, 232474.0, 232534.0, 233608.0, 233864.0, 61841.690791545756, 61933.0, 62331.0, 62366.0645090324, 62389.0, 69622.30377696158, 70669.29330706627, 70694.64652676704, 70759.0, 70796.64601676959, 18707.15817788203, 18716.064196790107, 18796.060196990096, 18890.716639250422, 18974.715379269044, 14242.643933901736, 14467.92766036163, 14552.199629020506, 14572.708545829024, 14575.0, 19866.70199947002, 19960.20159193616, 19975.900120499304, 20017.499562510762, 20914.89542552308, 7573.0, 7589.203133670995, 7668.731594394169, 7679.539227646359, 7754.573498457639, 1045.9790804183874, 1117.5082963496036, 1180.7048237940514, 1253.7680529101963, 1278.878506541877, 33125.33749325, 33411.3317733644, 33452.3309533808, 33483.49774753381, 33876.83061584676, 1222.6209874938797, 1249.5314257153568, 1264.8229247905301, 1273.8216649669055, 1361.2921280933858, 17454.214560344815, 17503.64992700139, 17693.380731674588, 17818.287268509113, 17832.286708531774, 470181.0, 470960.0, 474496.0, 480814.0, 482266.0, 63243.36756632467, 63878.6806065976, 63882.0, 63935.68032159809, 63938.0, 1474.1670955909876, 1516.2418790604697, 1525.9542213733605, 1567.6472793621572, 1585.7462805950993, 29628.703712962593, 30945.845270774404, 33498.33003339968, 33707.15732106717, 34952.475712863816, 54895.45104548903, 55688.44311556833, 55692.44307556873, 55705.0, 55780.0, 425122.0, 430302.0, 431272.0, 432260.0, 434138.0, 39571.40642890416, 46258.768706156254, 47021.76489117533, 47857.52142478531, 48323.75838120787, 45371.0, 45905.31142032939, 46443.30335045045, 46929.0, 47148.292775607704, 38055.0, 38707.225855483295, 39160.21679566336, 39813.60186398215, 40284.194316112924, 38936.41595376128, 38943.41584876286, 39199.216015678954, 42031.1593768129, 42892.35661465018, 37205.81397092997, 37458.62541374551, 37573.81213093917, 37600.059998500255, 40970.59029409787, 35918.461223082195, 37115.0, 37260.0, 37272.81363593165, 38260.23479530338, 28814.279643009093, 28876.27809304784, 29032.564511532768, 29033.0, 29113.85443072856], "value": 20876.38355006806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.72945314998395, 425.62757587111275, 428.69348415882655, 431.2969859129618, 439.39363678124187, 18404.723929141055, 19069.904650476747, 19076.23695052198, 19466.61066778667, 20415.795842041574, 12502.374881255946, 12875.871241287585, 14027.0, 20226.29207977721, 20439.897800511015, 5177.378714554259, 5177.948220517794, 5391.406945236021, 5399.568034557226, 5417.702026388547, 5348.732563371836, 5357.732113394334, 5358.035553600351, 5363.061464243761, 5430.728463576826, 5352.625316227865, 5361.865953351158, 5368.32895888014, 5375.0593646111965, 5378.596605254622, 5085.745712714368, 5313.946860531384, 5333.306670132877, 5341.1988201769855, 5344.5724342052545, 5170.870728231825, 5185.714785686786, 5201.40183878855, 5203.661761985459, 5203.947960520384, 13423.530176443875, 17282.0, 22273.55452890949, 23279.0, 23290.767092329028, 2394.724606670238, 2434.707835059804, 2477.913273035435, 2494.6881639795024, 2981.925451863699, 10156.085952264331, 10298.3820970742, 10396.948015259952, 10500.842487362695, 10656.627018054409, 2017.6872584749387, 2045.1921491010967, 2060.9072591733257, 2082.2087606709506, 2085.5620319732875, 72541.63729181373, 73794.0, 74872.99999999946, 75872.62063689702, 77134.22865771326, 11614.303141811519, 11615.477303521362, 11617.709557261136, 11775.52897884075, 11793.233439826385, 16287.267072981744, 16314.428994985356, 16433.424830130887, 16440.342386304652, 16454.177291135395, 8644.135586441305, 8746.737597872074, 8754.168354006359, 8813.911860881437, 8877.289816814638, 8418.536980466133, 8551.486910785372, 8586.0, 8636.0, 8666.393352465268, 4916.410030796327, 4929.06347793918, 4950.752462376867, 5043.445221025684, 5078.21287700407, 2005.4485016620547, 2076.53278012446, 2113.3026101386504, 2138.706392156062, 2147.8186997151506, 945.5933948402253, 1097.155190503308, 1130.3387518301886, 1134.8808375120493, 1141.2467771270922, 18500.0, 19388.12753426099, 19417.0, 19613.32867062985, 19714.802851971297, 1046.4349251404308, 1049.4280617063719, 1085.5115198160859, 1092.268180319188, 1133.8525991621036, 10580.735481613021, 10978.725531861768, 11037.779244415067, 11121.721956951142, 11179.217454778087, 520196.0, 534805.0, 535957.0, 542508.0, 544430.0, 90688.54655726679, 91376.54311728399, 92460.0, 93533.5323323379, 93949.0, 1104.2987702808775, 1115.4088333183427, 1116.7096554895622, 1123.269874581512, 1148.0815347721789, 16893.32426702918, 17220.827791721924, 17282.567935801704, 17286.74069888978, 17314.134293285537, 37058.25883482369, 37821.43267851039, 38076.809615951744, 38268.0, 38647.42028869513, 55187.44812551823, 55396.44603554074, 55416.0, 55432.72283638556, 55552.72223638856, 7993.080795708568, 8348.66605335804, 8886.777830554287, 8911.73264802031, 9076.682316119168, 12024.639260822189, 12965.515863501852, 13009.674758131123, 13163.53927612529, 13839.654008649462, 11328.0, 11459.31244125355, 11479.827802583135, 11637.53449861996, 11925.165238433226, 11705.707357316136, 11775.882241177478, 11782.0, 11930.463129159036, 12149.57476488354, 11847.881521184678, 11994.76010479803, 12031.699207519881, 12067.275963442222, 12363.196392234477, 8799.692010779592, 8804.735857924272, 8884.422512536665, 9077.364584479023, 9281.535923203948, 11618.186726929034, 11980.460879260629, 12022.27866328023, 12070.939645302069, 12216.0], "value": 9284.294236934562, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.2009764483073, 1566.5535322433104, 1577.0380068158422, 1811.7735283089614, 1912.9426117216487, 7476.925230747691, 8044.5977701114925, 8218.465799723013, 8239.340852731782, 8253.1334209908, 8024.23769741875, 8215.630296636651, 8216.630251638675, 8225.6298466569, 8234.053083895355, 2403.267003563912, 2413.3122060212845, 2414.360194548446, 2418.3470462974988, 2420.0319872051145, 2362.2204672458133, 2386.8925898334614, 2410.674558934548, 2417.492326611414, 2419.661247425362, 2401.939951501209, 2409.313345696477, 2418.093215044358, 2434.45224824414, 2441.121196369306, 2412.8069754419603, 2437.6709144265474, 2441.59713647248, 2444.1567659157563, 2460.5078984203233, 2313.097891822191, 2367.7277113132036, 2373.121944880388, 2378.0, 2378.4648454097864, 7327.2306407826945, 7916.0896496903015, 8287.709930152476, 8505.319574434092, 8514.872276915852, 5080.77136528857, 5141.717205553693, 5176.767045482925, 5178.0, 5179.378474583036, 3391.8134502602347, 3398.218409765768, 3468.549088618489, 3527.3121741260466, 3530.1704099536587, 1132.162199972023, 1157.69899826045, 1159.1654009113424, 1163.191581850614, 1181.7577396633756, 11690.473928673146, 11707.76584468306, 11767.058635309155, 11785.351805650685, 11791.941040294743, 4564.42944631921, 4566.474855391606, 4674.766261686902, 4706.317583950308, 4715.363425937455, 10219.284650074424, 10253.84619230712, 10258.28192026551, 10279.229057820694, 10285.43430111351, 5245.396779370421, 5255.658382205144, 5283.762230699628, 5284.81503147388, 5287.339082614673, 4819.228923372244, 4829.1790395632825, 4832.033593281358, 4832.106060378841, 4835.637327200474, 3823.3118038752737, 4047.3321901886447, 4062.3500239961463, 4069.8575549856205, 4075.735077219971, 1285.8199852020725, 1300.336828217616, 1307.6469353274563, 1315.9934200328937, 1329.3648811961148, 1043.7181960870523, 1050.1179009631946, 1057.672121642278, 1060.740118670915, 1067.7917806027906, 5791.739371728282, 5819.359870414251, 5924.4667979882015, 6021.729022194012, 6182.041783523561, 1100.7303210713426, 1112.360392774158, 1136.2046567402851, 1140.6016599562806, 1143.3368646185193, 3888.7083468739393, 4029.174019326031, 4049.615286547832, 4076.510818701775, 4113.218488487178, 10101.797964040677, 10329.896701033043, 10339.4313312767, 10441.634542791118, 10492.055714985689, 10291.279610427348, 10302.793944121226, 10305.690829275134, 10350.068493835592, 10363.430011349448, 7785.871048697907, 8052.677892884336, 8162.551059691774, 8192.18078192188, 8224.712135075244, 5659.26429564154, 5720.11338242573, 5756.165356023437, 5800.59395842287, 5825.650460972355, 9107.681231156877, 9168.266538676757, 9192.95403522978, 9229.538523073954, 9426.670066547913, 9413.0, 9487.098725621056, 9506.191973682315, 9515.714528564155, 9525.0, 7325.890111648436, 7416.7774966751085, 7449.255074492724, 7549.622518874145, 7610.429217808797, 8095.23095305945, 8136.67453301885, 8156.592170391338, 8185.590720464072, 8199.303059240032, 7149.785506434815, 7275.8181045472165, 7295.671694773854, 7374.594397308199, 7439.665215065227, 7270.163931147986, 7311.0, 7324.560526368435, 7343.963280183565, 7482.850342993001, 6977.860442791217, 7013.509054366145, 7045.401140903081, 7068.68190931399, 7073.1865835427525, 4256.723312984646, 4825.3485779419325, 4825.806967721252, 4876.21980483121, 4918.2376731606655, 4954.653174277766, 4959.355283813081, 4967.503249675148, 5034.421041580265, 5058.721770302522], "value": 4604.448305698945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.52290123980765, 353.13658105930995, 353.9380608393531, 358.8941262327613, 361.16030229715915, 6057.273127224728, 6092.482139018183, 6103.694815259241, 6106.755729770815, 6167.074938759189, 6077.3922607739205, 6078.604890682102, 6089.5128389728825, 6090.45185933267, 6099.268087829456, 4447.332900064992, 4580.083983203356, 4726.0547890421885, 4728.739919304437, 4735.928961065587, 4696.412948381452, 4698.060387922412, 4720.55154760299, 4734.289856521515, 4738.2892566115015, 4433.445819272591, 4662.51043640418, 4671.392718946532, 4687.789049492781, 4690.319903613991, 4529.501754806968, 4559.0, 4587.243104887706, 4661.743604101773, 4697.67116301859, 4115.218108559364, 4116.238495878242, 4118.402831589403, 4126.09225970286, 4129.793510324502, 5857.799151173999, 5867.677277749722, 5875.794347197871, 5887.528997680175, 5891.882162356729, 5407.540359069484, 5409.2967914171295, 5411.972940135313, 5429.837104886859, 5443.537299329561, 6413.679316034226, 6420.582662126947, 6431.196100487439, 6431.967840160816, 6439.259485159219, 4294.849680261176, 4400.251957167257, 4405.118976204772, 4454.5990860822685, 4460.241758900995, 6608.405243528057, 6712.731490740364, 6725.192976842761, 6725.529212955095, 6727.495437842182, 4544.454665440168, 4561.794719237576, 4562.794674239667, 4576.222042252825, 4585.174668559691, 4634.026854360622, 4636.582707556337, 4652.209124448852, 4653.162430762428, 4657.67396282257, 5358.517733404013, 5364.088105022156, 5372.462753724596, 5377.220303056113, 5385.542228910508, 6212.47193988516, 6388.0, 6403.391677790602, 6488.7728929488185, 6509.153810004764, 1661.9584510387338, 1674.0792564089945, 1678.5803549112723, 1681.7645529625863, 1688.3837399349395, 1070.5557193764657, 1122.7529943412437, 1125.3416751200639, 1142.6744975828165, 1150.1546363422879, 6053.273607167168, 6167.105769663373, 6249.531285153632, 6280.309165991737, 6284.780032698925, 6724.562903411263, 6725.6973436195485, 6725.8654826903185, 6744.730210791611, 6749.0, 6236.469900058546, 6242.1261023456755, 6246.875062498815, 6248.656323902138, 6260.655663938527, 3570.5715314162467, 3601.135727425399, 3604.981975090108, 3606.026372879308, 3609.2601016791496, 6611.702473388709, 6753.3921947025, 6765.492588055916, 6777.1189745332795, 6783.118194634764, 6825.044493770876, 6862.897056544156, 6867.656617169122, 6877.1747390313485, 6880.208775990725, 6772.627505487246, 6774.72901083961, 6779.93220067793, 6780.796576102724, 6780.966095169492, 6709.161354830646, 6711.899321510279, 6713.765018224339, 6720.361565651256, 6728.158980127484, 6475.902861456988, 6638.269790323157, 6643.2360278568585, 6643.501737369813, 6644.10304608891, 6744.190697116377, 6749.42629876466, 6763.323667633197, 6764.2221144569, 6764.391204791593, 4722.197226471577, 4728.078024785272, 4729.479757226771, 4735.573798358164, 4746.406699162605, 6671.26616072222, 6694.230163531061, 6695.363940425652, 6702.36327548882, 6707.128073350628, 6265.185525881606, 6480.319566445455, 6483.481321494363, 6484.513661475503, 6504.9674751625935, 6499.992501162327, 6508.251551071688, 6513.218413790375, 6519.543631945908, 6520.543561950618, 6404.551681382259, 6406.487481001602, 6408.391202835724, 6422.325655806073, 6429.8714025720155, 6558.376954189344, 6559.245686745894, 6562.081308616702, 6571.145751052332, 6573.244076931214, 5978.730957106854, 6060.727267272895, 6370.789549985488, 6412.871742565216, 6418.19772528434], "value": 4889.947574090101, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.6266549382007, 907.7276816954916, 908.1508789282021, 914.9954250228752, 931.2410385535787, 15045.849541504582, 15115.0, 15203.315850786714, 15265.542033738979, 15274.465393711209, 14408.495702650409, 14437.350319235633, 14489.565313040599, 14496.275186240671, 14510.637234069154, 898.3127907151019, 903.737916004358, 911.5351170902854, 911.8267529169469, 912.4798864647154, 743.6839343279112, 896.3322324867983, 900.7883147460342, 903.7695387676133, 904.0146240597747, 937.840567103594, 966.5312323523086, 966.8163049020699, 967.5114067395955, 969.0890562870878, 952.8856537215544, 959.2421986630553, 959.3140904253457, 960.5437417226831, 960.8654788329675, 579.3742757821543, 692.7783109404993, 711.5090587494664, 714.0360513307046, 716.8494616130619, 13905.513307034205, 13951.883849292133, 13972.231527265996, 13989.580312590639, 14021.929890350482, 13662.385192666354, 14089.436422543085, 14800.185989770558, 14835.851641483556, 14922.552323430315, 11219.551217951272, 11419.657410277621, 11580.536778528849, 11666.475008624548, 11802.527898884035, 3967.7619342839234, 4041.595840415935, 4079.8980025499304, 4110.568390319003, 4192.622663960258, 52991.20513192305, 53410.73294633502, 53493.197602036, 53574.46425535695, 53578.0, 11531.942340288246, 11566.363849988331, 11629.127815413878, 11777.587784427675, 11835.28988260707, 20696.745738467183, 21102.366928991847, 21109.050092745863, 21113.577728445653, 21113.78886211149, 8909.331800115016, 8912.153345432174, 9062.36563440566, 9101.362904596746, 9185.265178785681, 5006.799728010911, 5083.796648134107, 5102.515261050268, 5160.870978225575, 5165.974170129125, 3559.9110022249133, 3601.099725068733, 3610.855565777392, 3615.7468977171347, 3618.6743193112748, 634.6350848262267, 644.7034364192431, 651.9869602607921, 652.8988006858945, 653.6764301670703, 790.1426951757408, 798.3094623150932, 807.2494163270179, 829.4940086547201, 831.0899564976341, 9072.54637268134, 9331.860022099674, 9401.90598094024, 9455.385399948982, 9486.715398538056, 633.2590868683651, 708.890122031086, 755.7430473638989, 777.8560966221268, 786.6106277392613, 4275.3800698898485, 4352.978235108804, 4355.978220108943, 4445.0, 4534.727916325031, 57596.136057959164, 57980.71009644925, 60855.695721521995, 62148.06777898335, 62267.0, 53530.0, 53834.0, 54751.178732319044, 54971.625709357584, 54994.0, 49420.258696119585, 49863.75068124636, 49948.750256249215, 50455.49544504582, 51479.99999999925, 8551.102134275812, 8690.217880390795, 8783.604737786687, 8805.69180078694, 8884.555772211494, 37698.43452348272, 37786.62213377831, 37878.2424351517, 39227.803860980515, 39274.03629818555, 45465.31802022906, 48569.5143048565, 48628.27057594209, 48647.27029094496, 48872.75563622159, 12630.810537841757, 12714.936425317814, 12750.426230819821, 13050.15174013686, 13199.604011879659, 13770.311484425538, 13893.374798134311, 13958.511452099128, 14121.929390352983, 14167.858321417067, 12565.560205392767, 13197.352155361656, 13383.19700817954, 13675.863241367857, 13763.587092387244, 13595.45618175262, 13618.114822536503, 13701.657458563217, 13792.586222413343, 14068.577942661737, 12941.417636206581, 13263.270520121487, 13271.270080145685, 13596.456141754219, 13696.794548081985, 11185.488880606286, 11301.321920684784, 11402.771944560896, 11721.941390292994, 12041.939790300992, 10201.723103172886, 10592.311499752492, 10871.891281087088, 10962.0, 10994.175436842428], "value": 7113.676168503041, "unit": "score"}], "name": "dromaeo_css", "value": 7454.628897141811, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 112.0, 113.0, 113.0, 107.0, 110.0, 110.0, 110.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 152.0, 180.0, 130.0, 154.0, 157.0, 127.0, 175.0, 126.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 163.0, 165.0, 162.0, 161.0, 162.0, 160.0, 161.0, 159.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 73.0, 173.0, 77.0, 76.0, 77.0, 76.0, 173.0, 76.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 149.0, 93.0, 92.0, 91.0, 150.0, 93.0, 92.0, 155.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 153.0, 145.0, 146.0, 146.0, 145.0, 145.0, 144.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 55.0, 56.0, 55.0, 55.0, 77.0, 53.0, 53.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 58.0, 57.0, 57.0, 58.0, 58.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 79.0, 73.0, 73.0, 73.0, 74.0, 73.0, 74.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 112.0, 110.0, 110.0, 114.0, 111.0, 112.0, 114.0, 128.0, 138.0], "value": 116.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 160.0, 166.0, 162.0, 162.0, 169.0, 160.0, 164.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 65.0, 68.0, 67.0, 66.0, 66.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1519.7, "alertThreshold": 2.0}]} 11:44:44 INFO - Return code: 0 11:44:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:44:44 ERROR - # TBPL SUCCESS # 11:44:44 INFO - Running post-action listener: _resource_record_post_action 11:44:44 INFO - Running post-run listener: _resource_record_post_run 11:44:45 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 460558336; Read time: 0; Write time: 322724 11:44:45 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 249929728; Read time: 0; Write time: 212612 11:44:45 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 210030592; Read time: 0; Write time: 110112 11:44:45 INFO - Running post-run listener: _upload_blobber_files 11:44:45 INFO - Blob upload gear active. 11:44:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:45 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 11:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:46 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:47 INFO - (blobuploader) - INFO - Done attempting. 11:44:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:48 INFO - (blobuploader) - INFO - Done attempting. 11:44:48 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:48 INFO - Return code: 0 11:44:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2ceb3836b35532e02eb25b4d51617d57acff6138cc35ec0939ba20e7aaea9b060fddba9fcbbf235906e8cc45cdc5b576126ac8c77f17a89ef0ad6a93d7159fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/669bd46e26b84dd71a98e941005f73983499c32f7a6fdf48a0427fa0eaa7f5b18f5cb4808be923aff242995df8264cf8b23c602bffc968e79153b7b400e43450"} 11:44:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:48 INFO - Contents: 11:44:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2ceb3836b35532e02eb25b4d51617d57acff6138cc35ec0939ba20e7aaea9b060fddba9fcbbf235906e8cc45cdc5b576126ac8c77f17a89ef0ad6a93d7159fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/669bd46e26b84dd71a98e941005f73983499c32f7a6fdf48a0427fa0eaa7f5b18f5cb4808be923aff242995df8264cf8b23c602bffc968e79153b7b400e43450"} 11:44:48 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:48 INFO - Copying logs to upload dir... 11:44:48 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.680675 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-05 11:44:47.507297) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 11:44:47.511233) ========= 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=923d835db2ba3686ebe126b700000192-1467743062.426934-246075726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2ceb3836b35532e02eb25b4d51617d57acff6138cc35ec0939ba20e7aaea9b060fddba9fcbbf235906e8cc45cdc5b576126ac8c77f17a89ef0ad6a93d7159fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/669bd46e26b84dd71a98e941005f73983499c32f7a6fdf48a0427fa0eaa7f5b18f5cb4808be923aff242995df8264cf8b23c602bffc968e79153b7b400e43450"} build_url:https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/ZYCI7WzXQrq5RFnp5Ga3EQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2ceb3836b35532e02eb25b4d51617d57acff6138cc35ec0939ba20e7aaea9b060fddba9fcbbf235906e8cc45cdc5b576126ac8c77f17a89ef0ad6a93d7159fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/669bd46e26b84dd71a98e941005f73983499c32f7a6fdf48a0427fa0eaa7f5b18f5cb4808be923aff242995df8264cf8b23c602bffc968e79153b7b400e43450"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 11:44:47.543080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:44:47.543450) ========= 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=923d835db2ba3686ebe126b700000192-1467743062.426934-246075726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:44:47.625058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 11:44:47.625383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 11:44:47.625711) ========= ========= Total master_lag: 0.19 =========