builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1468844066.47 results: success (0) buildid: 20160718022251 builduid: 72fb3d9a169a470cb4d3b09ac56c5523 revision: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:26.466633) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:26.467065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:26.467338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:26.481557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:26.481820) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 05:14:26-- 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% 51.0M=0s 2016-07-18 05:14:26 (51.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092738 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:26.588429) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:26.588740) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020668 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:26.637424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:26.637742) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 --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 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 --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=4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 05:14:26,907 truncating revision to first 12 chars 2016-07-18 05:14:26,907 Setting DEBUG logging. 2016-07-18 05:14:26,907 attempt 1/10 2016-07-18 05:14:26,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2b7160a603f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 05:14:27,228 unpacking tar archive at: mozilla-beta-2b7160a603f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656781 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:27.309664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:27.310273) ========= script_repo_revision: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:27.310834) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:27.311254) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:14:27.322372) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-18 05:14:27.322829) ========= /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=4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:14:27 INFO - MultiFileLogger online at 20160718 05:14:27 in /builds/slave/test 05:14:27 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 05:14:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:14:27 INFO - {'append_to_log': False, 05:14:27 INFO - 'base_work_dir': '/builds/slave/test', 05:14:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:14:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:14:27 INFO - 'branch': 'Mozilla-Beta', 05:14:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:27 INFO - 'config_files': ('talos/linux_config.py',), 05:14:27 INFO - 'default_actions': ('clobber', 05:14:27 INFO - 'read-buildbot-config', 05:14:27 INFO - 'download-and-extract', 05:14:27 INFO - 'populate-webroot', 05:14:27 INFO - 'create-virtualenv', 05:14:27 INFO - 'install', 05:14:27 INFO - 'run-tests'), 05:14:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:27 INFO - 'download_minidump_stackwalk': True, 05:14:27 INFO - 'download_symbols': 'ondemand', 05:14:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:27 INFO - 'installer_path': 'installer.exe', 05:14:27 INFO - 'log_level': 'info', 05:14:27 INFO - 'log_name': 'talos', 05:14:27 INFO - 'log_to_console': True, 05:14:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:14:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:14:27 INFO - 'opt_config_files': (), 05:14:27 INFO - 'pip_index': False, 05:14:27 INFO - 'sps_profile': False, 05:14:27 INFO - 'sps_profile_interval': 0, 05:14:27 INFO - 'suite': 'dromaeojs', 05:14:27 INFO - 'system_bits': '32', 05:14:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:27 INFO - 'title': 'talos-linux64-ix-030', 05:14:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:27 INFO - 'use_talos_json': True, 05:14:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:14:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:27 INFO - 'work_dir': 'build'} 05:14:27 INFO - ##### 05:14:27 INFO - ##### Running clobber step. 05:14:27 INFO - ##### 05:14:27 INFO - Running pre-action listener: _resource_record_pre_action 05:14:27 INFO - Running main action method: clobber 05:14:27 INFO - rmtree: /builds/slave/test/build 05:14:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:14:28 INFO - Running post-action listener: _resource_record_post_action 05:14:28 INFO - ##### 05:14:28 INFO - ##### Running read-buildbot-config step. 05:14:28 INFO - ##### 05:14:28 INFO - Running pre-action listener: _resource_record_pre_action 05:14:28 INFO - Running main action method: read_buildbot_config 05:14:28 INFO - Using buildbot properties: 05:14:28 INFO - { 05:14:28 INFO - "project": "", 05:14:28 INFO - "product": "firefox", 05:14:28 INFO - "script_repo_revision": "production", 05:14:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:14:28 INFO - "repository": "", 05:14:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:14:28 INFO - "buildid": "20160718022251", 05:14:28 INFO - "pgo_build": "True", 05:14:28 INFO - "basedir": "/builds/slave/test", 05:14:28 INFO - "buildnumber": 176, 05:14:28 INFO - "slavename": "talos-linux64-ix-030", 05:14:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:14:28 INFO - "platform": "ubuntu64_hw", 05:14:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:14:28 INFO - "branch": "mozilla-beta", 05:14:28 INFO - "repo_path": "releases/mozilla-beta", 05:14:28 INFO - "revision": "2b7160a603f1f8f1fb5cef64dc73fb87c115bed7", 05:14:28 INFO - "stage_platform": "linux64-pgo", 05:14:28 INFO - "builduid": "72fb3d9a169a470cb4d3b09ac56c5523", 05:14:28 INFO - "slavebuilddir": "test" 05:14:28 INFO - } 05:14:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 05:14:28 INFO - Running post-action listener: _resource_record_post_action 05:14:28 INFO - ##### 05:14:28 INFO - ##### Running download-and-extract step. 05:14:28 INFO - ##### 05:14:28 INFO - Running pre-action listener: _resource_record_pre_action 05:14:28 INFO - Running main action method: download_and_extract 05:14:28 INFO - mkdir: /builds/slave/test/build/tests 05:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:28 INFO - https://queue.taskcluster.net/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:14:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:14:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:14:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/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 05:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/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 05:14:29 INFO - Downloaded 1327 bytes. 05:14:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:14:29 INFO - Using the following test package requirements: 05:14:29 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:14:29 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:14:29 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 05:14:29 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'jsshell-linux-x86_64.zip'], 05:14:29 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:14:29 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:14:29 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 05:14:29 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 05:14:29 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:14:29 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:14:29 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:29 INFO - https://queue.taskcluster.net/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/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 05:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/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 05:14:30 INFO - Downloaded 24200438 bytes. 05:14:30 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'] 05:14:30 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 05:14:31 INFO - Return code: 0 05:14:31 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 05:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:31 INFO - https://queue.taskcluster.net/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:14:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:14:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/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 05:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/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 05:14:32 INFO - Downloaded 24200438 bytes. 05:14:32 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'] 05:14:32 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 05:14:34 INFO - Return code: 0 05:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:34 INFO - https://queue.taskcluster.net/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/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 05:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/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 05:14:35 INFO - Downloaded 10840145 bytes. 05:14:35 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'] 05:14:35 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 05:14:35 INFO - Return code: 0 05:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:35 INFO - https://queue.taskcluster.net/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/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 05:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bM1dEaksR7GfLZOIWYwBqw/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 05:14:36 INFO - Downloaded 56022798 bytes. 05:14:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:14:36 INFO - mkdir: /builds/slave/test/properties 05:14:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:36 INFO - Contents: 05:14:36 INFO - build_url:https://queue.taskcluster.net/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:14:37 INFO - Running post-action listener: _resource_record_post_action 05:14:37 INFO - Running post-action listener: set_extra_try_arguments 05:14:37 INFO - ##### 05:14:37 INFO - ##### Running populate-webroot step. 05:14:37 INFO - ##### 05:14:37 INFO - Running pre-action listener: _resource_record_pre_action 05:14:37 INFO - Running main action method: populate_webroot 05:14:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:37 INFO - '--tppagecycles', 05:14:37 INFO - '7'], 05:14:37 INFO - 'tests': ['tsvgm']}}, 05:14:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:14:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:14:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['damp', 'tps']}, 05:14:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'tests': ['damp', 'tps']}, 05:14:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['dromaeo_dom']}, 05:14:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:14:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['tsvgx', 05:14:37 INFO - 'tsvgr_opacity', 05:14:37 INFO - 'tart', 05:14:37 INFO - 'tscrollx', 05:14:37 INFO - 'cart']}, 05:14:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:14:37 INFO - 'tsvgr_opacity', 05:14:37 INFO - 'tart', 05:14:37 INFO - 'tscrollx', 05:14:37 INFO - 'cart']}, 05:14:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['tp5o']}, 05:14:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'tests': ['tp5o']}, 05:14:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'talos_options': ['--disable-e10s', 05:14:37 INFO - '--xperf_path', 05:14:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:37 INFO - 'tests': ['tp5n']}, 05:14:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'talos_options': ['--xperf_path', 05:14:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:37 INFO - 'tests': ['tp5n']}}, 05:14:37 INFO - 'talos.zip': {'path': '', 05:14:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:37 INFO - Running post-action listener: _resource_record_post_action 05:14:37 INFO - ##### 05:14:37 INFO - ##### Running create-virtualenv step. 05:14:37 INFO - ##### 05:14:37 INFO - Running pre-action listener: _resource_record_pre_action 05:14:37 INFO - Running main action method: create_virtualenv 05:14:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:14:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:37 INFO - Using real prefix '/usr' 05:14:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:40 INFO - Installing pip.................done. 05:14:40 INFO - Return code: 0 05:14:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 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 0x7f1e622aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd410>, '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 0x20ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ce7a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:14:40 INFO - Using env: {'DISPLAY': ':0', 05:14:40 INFO - 'HOME': '/home/cltbld', 05:14:40 INFO - 'LANG': 'en_US.UTF-8', 05:14:40 INFO - 'LANGUAGE': 'en_US:en', 05:14:40 INFO - 'LOGNAME': 'cltbld', 05:14:40 INFO - 'MAIL': '/var/mail/cltbld', 05:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:40 INFO - 'MOZ_NO_REMOTE': '1', 05:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:40 INFO - 'NO_EM_RESTART': '1', 05:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:40 INFO - 'PWD': '/builds/slave/test', 05:14:40 INFO - 'SHELL': '/bin/bash', 05:14:40 INFO - 'SHLVL': '1', 05:14:40 INFO - 'TERM': 'linux', 05:14:40 INFO - 'TMOUT': '86400', 05:14:40 INFO - 'USER': 'cltbld', 05:14:40 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 05:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:40 INFO - '_': '/tools/buildbot/bin/python'} 05:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:14:40 INFO - Cleaning up... 05:14:40 INFO - Return code: 0 05:14:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 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 0x7f1e622aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd410>, '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 0x20ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ce7a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:14:40 INFO - Using env: {'DISPLAY': ':0', 05:14:40 INFO - 'HOME': '/home/cltbld', 05:14:40 INFO - 'LANG': 'en_US.UTF-8', 05:14:40 INFO - 'LANGUAGE': 'en_US:en', 05:14:40 INFO - 'LOGNAME': 'cltbld', 05:14:40 INFO - 'MAIL': '/var/mail/cltbld', 05:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:40 INFO - 'MOZ_NO_REMOTE': '1', 05:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:40 INFO - 'NO_EM_RESTART': '1', 05:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:40 INFO - 'PWD': '/builds/slave/test', 05:14:40 INFO - 'SHELL': '/bin/bash', 05:14:40 INFO - 'SHLVL': '1', 05:14:40 INFO - 'TERM': 'linux', 05:14:40 INFO - 'TMOUT': '86400', 05:14:40 INFO - 'USER': 'cltbld', 05:14:40 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 05:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:40 INFO - '_': '/tools/buildbot/bin/python'} 05:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:40 INFO - Downloading/unpacking psutil>=0.7.1 05:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:42 INFO - Installing collected packages: psutil 05:14:42 INFO - Running setup.py install for psutil 05:14:42 INFO - building 'psutil._psutil_linux' extension 05:14:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:14:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:14:42 INFO - building 'psutil._psutil_posix' extension 05:14:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:14:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:14:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:43 INFO - Successfully installed psutil 05:14:43 INFO - Cleaning up... 05:14:43 INFO - Return code: 0 05:14:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:14: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')]} 05:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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')]} 05:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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', '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 0x7f1e622aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd410>, '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 0x20ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ce7a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:14: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 mozsystemmonitor==0.0.0 05:14:43 INFO - Using env: {'DISPLAY': ':0', 05:14:43 INFO - 'HOME': '/home/cltbld', 05:14:43 INFO - 'LANG': 'en_US.UTF-8', 05:14:43 INFO - 'LANGUAGE': 'en_US:en', 05:14:43 INFO - 'LOGNAME': 'cltbld', 05:14:43 INFO - 'MAIL': '/var/mail/cltbld', 05:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:43 INFO - 'MOZ_NO_REMOTE': '1', 05:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:43 INFO - 'NO_EM_RESTART': '1', 05:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:43 INFO - 'PWD': '/builds/slave/test', 05:14:43 INFO - 'SHELL': '/bin/bash', 05:14:43 INFO - 'SHLVL': '1', 05:14:43 INFO - 'TERM': 'linux', 05:14:43 INFO - 'TMOUT': '86400', 05:14:43 INFO - 'USER': 'cltbld', 05:14:43 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 05:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:43 INFO - '_': '/tools/buildbot/bin/python'} 05:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:14:45 INFO - Installing collected packages: mozsystemmonitor 05:14:45 INFO - Running setup.py install for mozsystemmonitor 05:14:45 INFO - Successfully installed mozsystemmonitor 05:14:45 INFO - Cleaning up... 05:14:45 INFO - Return code: 0 05:14:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 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 0x7f1e622aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd410>, '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 0x20ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ce7a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:14:45 INFO - Using env: {'DISPLAY': ':0', 05:14:45 INFO - 'HOME': '/home/cltbld', 05:14:45 INFO - 'LANG': 'en_US.UTF-8', 05:14:45 INFO - 'LANGUAGE': 'en_US:en', 05:14:45 INFO - 'LOGNAME': 'cltbld', 05:14:45 INFO - 'MAIL': '/var/mail/cltbld', 05:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:45 INFO - 'MOZ_NO_REMOTE': '1', 05:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:45 INFO - 'NO_EM_RESTART': '1', 05:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:45 INFO - 'PWD': '/builds/slave/test', 05:14:45 INFO - 'SHELL': '/bin/bash', 05:14:45 INFO - 'SHLVL': '1', 05:14:45 INFO - 'TERM': 'linux', 05:14:45 INFO - 'TMOUT': '86400', 05:14:45 INFO - 'USER': 'cltbld', 05:14:45 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 05:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:45 INFO - '_': '/tools/buildbot/bin/python'} 05:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:14:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:14:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:48 INFO - Downloading docopt-0.6.1.tar.gz 05:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:14:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:14:48 INFO - Running setup.py install for blobuploader 05:14:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:14:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:14:48 INFO - Running setup.py install for requests 05:14:48 INFO - Running setup.py install for docopt 05:14:48 INFO - Successfully installed blobuploader requests docopt 05:14:48 INFO - Cleaning up... 05:14:48 INFO - Return code: 0 05:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:48 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 0x7f1e622aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd410>, '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 0x20ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ce7a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:14:48 INFO - Using env: {'DISPLAY': ':0', 05:14:48 INFO - 'HOME': '/home/cltbld', 05:14:48 INFO - 'LANG': 'en_US.UTF-8', 05:14:48 INFO - 'LANGUAGE': 'en_US:en', 05:14:48 INFO - 'LOGNAME': 'cltbld', 05:14:48 INFO - 'MAIL': '/var/mail/cltbld', 05:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:48 INFO - 'MOZ_NO_REMOTE': '1', 05:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:48 INFO - 'NO_EM_RESTART': '1', 05:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:48 INFO - 'PWD': '/builds/slave/test', 05:14:48 INFO - 'SHELL': '/bin/bash', 05:14:48 INFO - 'SHLVL': '1', 05:14:48 INFO - 'TERM': 'linux', 05:14:48 INFO - 'TMOUT': '86400', 05:14:48 INFO - 'USER': 'cltbld', 05:14:48 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 05:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:48 INFO - '_': '/tools/buildbot/bin/python'} 05:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:49 INFO - Running setup.py (path:/tmp/pip-TYzk6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:49 INFO - Running setup.py (path:/tmp/pip-s3bgl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:49 INFO - Running setup.py (path:/tmp/pip-VgMkUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:49 INFO - Running setup.py (path:/tmp/pip-kat0yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:49 INFO - Running setup.py (path:/tmp/pip-1T14z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:49 INFO - Running setup.py (path:/tmp/pip-uPwCWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:49 INFO - Running setup.py (path:/tmp/pip-hoZyz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:49 INFO - Running setup.py (path:/tmp/pip-PR4wrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:49 INFO - Running setup.py (path:/tmp/pip-6Plr74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:49 INFO - Running setup.py (path:/tmp/pip-AUYV0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:49 INFO - Running setup.py (path:/tmp/pip-6VV4DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:49 INFO - Running setup.py (path:/tmp/pip-P_HcVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:49 INFO - Running setup.py (path:/tmp/pip-FtY6GU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:50 INFO - Running setup.py (path:/tmp/pip-GmbAqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:50 INFO - Running setup.py (path:/tmp/pip-kPUR6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:50 INFO - Running setup.py (path:/tmp/pip-6278Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:50 INFO - Running setup.py (path:/tmp/pip-PeATt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:14:50 INFO - Running setup.py install for manifestparser 05:14:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:14:50 INFO - Running setup.py install for mozcrash 05:14:50 INFO - Running setup.py install for mozdebug 05:14:50 INFO - Running setup.py install for mozdevice 05:14:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:14:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:14:50 INFO - Running setup.py install for mozfile 05:14:50 INFO - Running setup.py install for mozhttpd 05:14:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:14:50 INFO - Running setup.py install for mozinfo 05:14:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for mozInstall 05:14:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for mozleak 05:14:51 INFO - Running setup.py install for mozlog 05:14:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for moznetwork 05:14:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for mozprocess 05:14:51 INFO - Running setup.py install for mozprofile 05:14:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for mozrunner 05:14:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for mozscreenshot 05:14:51 INFO - Running setup.py install for moztest 05:14:51 INFO - Running setup.py install for mozversion 05:14:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:14:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:14:52 INFO - Cleaning up... 05:14:52 INFO - Return code: 0 05:14:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 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 0x7f1e622aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd410>, '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 0x20ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ce7a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:14:52 INFO - Using env: {'DISPLAY': ':0', 05:14:52 INFO - 'HOME': '/home/cltbld', 05:14:52 INFO - 'LANG': 'en_US.UTF-8', 05:14:52 INFO - 'LANGUAGE': 'en_US:en', 05:14:52 INFO - 'LOGNAME': 'cltbld', 05:14:52 INFO - 'MAIL': '/var/mail/cltbld', 05:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:52 INFO - 'MOZ_NO_REMOTE': '1', 05:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:52 INFO - 'NO_EM_RESTART': '1', 05:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:52 INFO - 'PWD': '/builds/slave/test', 05:14:52 INFO - 'SHELL': '/bin/bash', 05:14:52 INFO - 'SHLVL': '1', 05:14:52 INFO - 'TERM': 'linux', 05:14:52 INFO - 'TMOUT': '86400', 05:14:52 INFO - 'USER': 'cltbld', 05:14:52 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 05:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:52 INFO - '_': '/tools/buildbot/bin/python'} 05:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:52 INFO - Running setup.py (path:/tmp/pip-B2yL2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:52 INFO - Running setup.py (path:/tmp/pip-OAnhLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:52 INFO - Running setup.py (path:/tmp/pip-H3KZ8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:52 INFO - Running setup.py (path:/tmp/pip-K17veB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:52 INFO - Running setup.py (path:/tmp/pip-LCvryJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:52 INFO - Running setup.py (path:/tmp/pip-lTby5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:52 INFO - Running setup.py (path:/tmp/pip-k6CWG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:52 INFO - Running setup.py (path:/tmp/pip-2iu4NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:52 INFO - Running setup.py (path:/tmp/pip-FunIPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:52 INFO - Running setup.py (path:/tmp/pip-4gU0hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:53 INFO - Running setup.py (path:/tmp/pip-u5KwuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:53 INFO - Running setup.py (path:/tmp/pip-g995Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:53 INFO - Running setup.py (path:/tmp/pip-q5vfYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:53 INFO - Running setup.py (path:/tmp/pip-OQM1l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:53 INFO - Running setup.py (path:/tmp/pip-tWdgIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:53 INFO - Running setup.py (path:/tmp/pip-KxX5z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:53 INFO - Running setup.py (path:/tmp/pip-qlk8QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:55 INFO - Downloading blessings-1.6.tar.gz 05:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:14:55 INFO - Installing collected packages: blessings 05:14:55 INFO - Running setup.py install for blessings 05:14:55 INFO - Successfully installed blessings 05:14:55 INFO - Cleaning up... 05:14:55 INFO - Return code: 0 05:14:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:14:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:55 INFO - Reading from file tmpfile_stdout 05:14:55 INFO - Current package versions: 05:14:55 INFO - argparse == 1.2.1 05:14:55 INFO - blessings == 1.6 05:14:55 INFO - blobuploader == 1.2.4 05:14:55 INFO - docopt == 0.6.1 05:14:55 INFO - manifestparser == 1.1 05:14:55 INFO - mozInstall == 1.12 05:14:55 INFO - mozcrash == 0.17 05:14:55 INFO - mozdebug == 0.1 05:14:55 INFO - mozdevice == 0.48 05:14:55 INFO - mozfile == 1.2 05:14:55 INFO - mozhttpd == 0.7 05:14:55 INFO - mozinfo == 0.9 05:14:55 INFO - mozleak == 0.1 05:14:55 INFO - mozlog == 3.1 05:14:55 INFO - moznetwork == 0.27 05:14:55 INFO - mozprocess == 0.22 05:14:55 INFO - mozprofile == 0.28 05:14:55 INFO - mozrunner == 6.11 05:14:55 INFO - mozscreenshot == 0.1 05:14:55 INFO - mozsystemmonitor == 0.0 05:14:55 INFO - moztest == 0.7 05:14:55 INFO - mozversion == 1.4 05:14:55 INFO - psutil == 3.1.1 05:14:55 INFO - requests == 1.2.3 05:14:55 INFO - wsgiref == 0.1.2 05:14:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:55 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 0x7f1e622aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd410>, '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 0x20ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ce7a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:14:55 INFO - Using env: {'DISPLAY': ':0', 05:14:55 INFO - 'HOME': '/home/cltbld', 05:14:55 INFO - 'LANG': 'en_US.UTF-8', 05:14:55 INFO - 'LANGUAGE': 'en_US:en', 05:14:55 INFO - 'LOGNAME': 'cltbld', 05:14:55 INFO - 'MAIL': '/var/mail/cltbld', 05:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:55 INFO - 'MOZ_NO_REMOTE': '1', 05:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:55 INFO - 'NO_EM_RESTART': '1', 05:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:55 INFO - 'PWD': '/builds/slave/test', 05:14:55 INFO - 'SHELL': '/bin/bash', 05:14:55 INFO - 'SHLVL': '1', 05:14:55 INFO - 'TERM': 'linux', 05:14:55 INFO - 'TMOUT': '86400', 05:14:55 INFO - 'USER': 'cltbld', 05:14:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 05:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:55 INFO - '_': '/tools/buildbot/bin/python'} 05:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:14:56 INFO - Cleaning up... 05:14:56 INFO - Return code: 0 05:14:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:14: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')]} 05:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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')]} 05:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e622aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd410>, '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 0x20ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ce7a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14: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', 'jsonschema'] in /builds/slave/test/build 05:14: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 jsonschema 05:14:56 INFO - Using env: {'DISPLAY': ':0', 05:14:56 INFO - 'HOME': '/home/cltbld', 05:14:56 INFO - 'LANG': 'en_US.UTF-8', 05:14:56 INFO - 'LANGUAGE': 'en_US:en', 05:14:56 INFO - 'LOGNAME': 'cltbld', 05:14:56 INFO - 'MAIL': '/var/mail/cltbld', 05:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:56 INFO - 'MOZ_NO_REMOTE': '1', 05:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:56 INFO - 'NO_EM_RESTART': '1', 05:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:56 INFO - 'PWD': '/builds/slave/test', 05:14:56 INFO - 'SHELL': '/bin/bash', 05:14:56 INFO - 'SHLVL': '1', 05:14:56 INFO - 'TERM': 'linux', 05:14:56 INFO - 'TMOUT': '86400', 05:14:56 INFO - 'USER': 'cltbld', 05:14:56 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 05:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:56 INFO - '_': '/tools/buildbot/bin/python'} 05:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:56 INFO - Downloading/unpacking jsonschema 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:14:58 INFO - Downloading/unpacking functools32 (from jsonschema) 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:14:58 INFO - warning: no files found matching '*.txt' 05:14:58 INFO - no previously-included directories found matching 'build' 05:14:58 INFO - no previously-included directories found matching 'dist' 05:14:58 INFO - no previously-included directories found matching '.git*' 05:14:58 INFO - Installing collected packages: jsonschema, functools32 05:14:58 INFO - Running setup.py install for functools32 05:14:58 INFO - warning: no files found matching '*.txt' 05:14:58 INFO - no previously-included directories found matching 'build' 05:14:58 INFO - no previously-included directories found matching 'dist' 05:14:58 INFO - no previously-included directories found matching '.git*' 05:14:58 INFO - Successfully installed jsonschema functools32 05:14:58 INFO - Cleaning up... 05:14:58 INFO - Return code: 0 05:14:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:58 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 0x7f1e622aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd410>, '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 0x20ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ce7a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:14:58 INFO - Using env: {'DISPLAY': ':0', 05:14:58 INFO - 'HOME': '/home/cltbld', 05:14:58 INFO - 'LANG': 'en_US.UTF-8', 05:14:58 INFO - 'LANGUAGE': 'en_US:en', 05:14:58 INFO - 'LOGNAME': 'cltbld', 05:14:58 INFO - 'MAIL': '/var/mail/cltbld', 05:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:58 INFO - 'MOZ_NO_REMOTE': '1', 05:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:58 INFO - 'NO_EM_RESTART': '1', 05:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:58 INFO - 'PWD': '/builds/slave/test', 05:14:58 INFO - 'SHELL': '/bin/bash', 05:14:58 INFO - 'SHLVL': '1', 05:14:58 INFO - 'TERM': 'linux', 05:14:58 INFO - 'TMOUT': '86400', 05:14:58 INFO - 'USER': 'cltbld', 05:14:58 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 05:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:58 INFO - '_': '/tools/buildbot/bin/python'} 05:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:58 INFO - Downloading/unpacking flake8 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:15:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:15:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:15:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:15:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:01 INFO - no previously-included directories found matching 'docs/_build' 05:15:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:15:01 INFO - Running setup.py install for pep8 05:15:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:01 INFO - no previously-included directories found matching 'docs/_build' 05:15:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:15:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:15:01 INFO - Cleaning up... 05:15:01 INFO - Return code: 0 05:15:01 INFO - Running post-action listener: _resource_record_post_action 05:15:01 INFO - Running post-action listener: _start_resource_monitoring 05:15:01 INFO - Starting resource monitoring. 05:15:01 INFO - ##### 05:15:01 INFO - ##### Running install step. 05:15:01 INFO - ##### 05:15:01 INFO - Running pre-action listener: _resource_record_pre_action 05:15:01 INFO - Running main action method: install 05:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:02 INFO - Reading from file tmpfile_stdout 05:15:02 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:02 INFO - Reading from file tmpfile_stdout 05:15:02 INFO - Output received: 05:15:02 INFO - Usage: mozinstall [options] installer 05:15:02 INFO - Options: 05:15:02 INFO - -h, --help show this help message and exit 05:15:02 INFO - -d DEST, --destination=DEST 05:15:02 INFO - Directory to install application into. [default: 05:15:02 INFO - "/builds/slave/test"] 05:15:02 INFO - --app=APP Application being installed. [default: firefox] 05:15:02 INFO - mkdir: /builds/slave/test/build/application 05:15:02 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'] 05:15:02 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 05:15:15 INFO - Reading from file tmpfile_stdout 05:15:15 INFO - Output received: 05:15:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:15:15 INFO - Running post-action listener: _resource_record_post_action 05:15:15 INFO - ##### 05:15:15 INFO - ##### Running run-tests step. 05:15:15 INFO - ##### 05:15:15 INFO - Running pre-action listener: _resource_record_pre_action 05:15:15 INFO - Running main action method: run_tests 05:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:15 INFO - Python 2.7.3 05:15:15 INFO - Return code: 0 05:15:15 INFO - grabbing minidump binary from tooltool 05:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:15 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 0x20cd410>, '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 0x20ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ce7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:15:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:15:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:15 INFO - Return code: 0 05:15:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:15:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:15:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:15:16 INFO - Return code: 0 05:15:16 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/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 05:15:16 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/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 05:15:16 INFO - Using env: {'DISPLAY': ':0', 05:15:16 INFO - 'HOME': '/home/cltbld', 05:15:16 INFO - 'LANG': 'en_US.UTF-8', 05:15:16 INFO - 'LANGUAGE': 'en_US:en', 05:15:16 INFO - 'LOGNAME': 'cltbld', 05:15:16 INFO - 'MAIL': '/var/mail/cltbld', 05:15:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:16 INFO - 'MOZ_NO_REMOTE': '1', 05:15:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:16 INFO - 'NO_EM_RESTART': '1', 05:15:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:16 INFO - 'PWD': '/builds/slave/test', 05:15:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:16 INFO - 'SHELL': '/bin/bash', 05:15:16 INFO - 'SHLVL': '1', 05:15:16 INFO - 'TERM': 'linux', 05:15:16 INFO - 'TMOUT': '86400', 05:15:16 INFO - 'USER': 'cltbld', 05:15:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131', 05:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:16 INFO - '_': '/tools/buildbot/bin/python'} 05:15:16 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/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 05:15:16 INFO - mozversion application_buildid: 20160718022251 05:15:16 INFO - mozversion application_changeset: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 05:15:16 INFO - mozversion application_display_name: Firefox 05:15:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:16 INFO - mozversion application_name: Firefox 05:15:16 INFO - mozversion application_remotingname: firefox 05:15:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:15:16 INFO - mozversion application_vendor: Mozilla 05:15:16 INFO - mozversion application_version: 48.0 05:15:16 INFO - mozversion platform_buildid: 20160718022251 05:15:16 INFO - mozversion platform_changeset: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 05:15:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:15:16 INFO - mozversion platform_version: 48.0 05:15:16 INFO - using testdate: 1468844116 05:15:16 INFO - actual date: 1468844116 05:15:16 INFO - starting webserver on 'localhost:35842' 05:15:16 INFO - SUITE-START | Running 2 tests 05:15:16 INFO - TEST-START | dromaeo_css 05:15:16 INFO - operating with platform_type : linux_ 05:15:16 INFO - Initialising browser for dromaeo_css test... 05:15:16 INFO - TEST-INFO | started process 21314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9j3eoK/profile http://localhost:35842/getInfo.html) 05:15:20 INFO - PROCESS | 21314 | __metrics Screen width/height:1600/1200 05:15:20 INFO - PROCESS | 21314 | colorDepth:24 05:15:20 INFO - PROCESS | 21314 | Browser inner width/height: 1024/697 05:15:20 INFO - PROCESS | 21314 | __metrics 05:15:21 INFO - PROCESS | 21314 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:15:21 ERROR - PROCESS | 21314 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:15:22 INFO - TEST-INFO | 21314: exit 0 05:15:22 INFO - Browser initialized. 05:15:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:22 INFO - TEST-INFO | started process 21403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9j3eoK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:33 INFO - PROCESS | 21403 | RSS: Main: 139591680 05:15:33 INFO - PROCESS | 21403 | 05:16:25 INFO - PROCESS | 21403 | 1468844185059 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:18:32 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:35842/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35842/tests/dromaeo/cssquery-ext.html) 05:18:33 INFO - PROCESS | 21403 | RSS: Main: 245944320 05:18:33 INFO - PROCESS | 21403 | 05:21:35 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:35842/tests/dromaeo/cssquery-ext.html (next: http://localhost:35842/tests/dromaeo/cssquery-jquery.html) 05:21:36 INFO - PROCESS | 21403 | RSS: Main: 230170624 05:21:36 INFO - PROCESS | 21403 | 05:24:38 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:35842/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35842/tests/dromaeo/cssquery-mootools.html) 05:24:38 INFO - PROCESS | 21403 | RSS: Main: 219279360 05:24:38 INFO - PROCESS | 21403 | 05:27:40 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:35842/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35842/tests/dromaeo/cssquery-prototype.html) 05:27:40 INFO - PROCESS | 21403 | RSS: Main: 219127808 05:27:40 INFO - PROCESS | 21403 | 05:30:43 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:35842/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35842/tests/dromaeo/cssquery-yui.html) 05:30:44 INFO - PROCESS | 21403 | RSS: Main: 206311424 05:30:44 INFO - PROCESS | 21403 | 05:33:46 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:35842/tests/dromaeo/cssquery-yui.html (next: http://localhost:35842/tests/dromaeo/cssquery-dojo.html) 05:33:46 INFO - PROCESS | 21403 | RSS: Main: 247185408 05:33:46 INFO - PROCESS | 21403 | 05:33:46 INFO - PROCESS | 21403 | __start_tp_report 05:33:46 INFO - PROCESS | 21403 | _x_x_mozilla_page_load 05:33:46 INFO - PROCESS | 21403 | _x_x_mozilla_page_load_details 05:33:46 INFO - PROCESS | 21403 | |i|pagename|runs| 05:33:46 INFO - PROCESS | 21403 | |0;dojo.html;3346.29727757171;3392.4402473591845;3408.6932176104156;3414.743894207935;3436.3986302397075;5544.528715059219;5573.052581061214;5575.8606034849145;5578.609497335188;5583.58123140764;5482.314710661168;5585.636933599323;5589.664620122796;5594.86012849679;5639.041362968295;4983.5265649763305;5018.5985121190215;5023.648344615878;5137.820176293831;5178.404483484391;4979.377577802775;5067.239914012891;5070.188769796833;5071.087204303224;5072.467390923936;5010.423801262847;5065.316182315377;5124.538791508763;5145.305383773199;5145.485451454843;5144.408393034792;5163.070647283487;5168.431472538018;5176.637635365526;5201.609879259071;4913.484084171147;5000.699958002531;5055.317532133152;5069.417017043051;5070.974645126787;5454.91817622736;5472.425395333473;5497.47773961473;5521.4478552144865;5528.889422211573;5956.761729530814;5969.910451343233;5973.492253158443;5976.8505787355225;5977.043673012341;5983.1623572699855;5993.430624090704;6047.546434017467;6065.545084118665;6074.119252708377;5577.776888924479;5593.832185034415;5624.915626265651;5628.04323265046;5643.040683083886;5999.370066142992;6129.1419201311855;6143.139960405547;6149.477294429934;6151.6001459904965;5842.620229685142;5898.675572843449;5907.586468947133;5918.852028699317;5919.082542205879;5953.940460595425;5956.821295361146;5960.135780311917;5964.701764911737;5969.850753731192;5805.6806875621405;5930.28836539618;5932.3474417814;5933.9406605934255;5948.226730525091;5938.940610593925;5961.850953726105;5970;5975.312839023481;6009.969950150309;4541.091781643684;4552.044070745114;4554.3851580036935;4555.1117532080925;4578.633709303248;4048.068944142805;4058.9391159132047;4088.509378874495;4099.975006248438;4132.607402296777;5715.714214289269;5745.454181852718;5751.367349591542;5753.223314852441;5754.280714910637;6042.848928776728;6046.455818976313;6047.365026672224;6049.0926361046195;6053.092036194606;5606.046972014768;5679.375268720438;5720.11338242573;5756.194132821408;5778.3354914184565;5024.874378140576;5033.874153146127;5035.77339019745;5037.722925239147;5066.746662666926;6218.129461875341;6225.346338634468;6227;6227.595206311576;6227.657478838707;5908.734106965111;5972.134040564094;6038.094285857156;6132.264128304453;6137.539684523768;6230.345813689497;6244.750209991549;6274.372562743689;6274.435300822765;6276.717547710273;5900.675462849585;5904.645721256738;5905.704714764159;5909.911351329648;5936.5844390892225;5824.737886795019;6024.277086749618;6079.1793107931635;6128.846778830565;6133.141360209485;5830.76676932918;5835.328937172279;5840.415958404125;5843.357230704704;5850.151727999501;5780.132980053026;5813.447722466359;5827.854303642443;5838.474537291664;5843.766249349978;5680.6591604503865;5764.798232061858;5788.247527821524;5791.160281759206;5860.238169037998;5884.617499862496;5901.7639294427745;5904.881902362014;5914.881702365842;5919.733611987384;5667.4615911488345;5792.102224155263;5793.15999180125;5798.913016304675;5808.07070868659 05:33:46 INFO - PROCESS | 21403 | |1;ext.html;633.2938773267808;658.1772784019975;673.5453568841033;676.5433332500564;679.7824696097249;31913.52129718056;32423.83788081062;40067.599324006755;40447;40458.39312410316;44560.55439445605;45118;45129.774351128195;45187;45216.09567808642;7754.8449031019345;8766.649334026632;8951;8951.597178126967;10378.377297362182;10415.739606509822;10545.789084218311;10549.050585447309;10551.73620659482;10553.366797992107;10583;10603.045725884669;10689.144868410547;10700;10712.571497140105;10496.632617858377;10563.73590660232;10564.524596393105;10571.207159462994;10571.682849514527;10453.895461045367;10591.152707783436;10599.0990765785;10931.289466184673;10931.945340273327;44712;44923.55076449226;45100.3234951476;45161.09677806425;45383.54616453826;3910.6480416762342;4039.414284928698;4094.5905409459115;4201.76890271035;4481.058977614704;33971.49042764361;34294;34403.311933761186;34855.825720871486;34871.30257394838;4574.908501829978;4674.13132415451;4678.883027924295;4706.247000479941;4801.855944321676;366023;555087;562430.9999999959;566649;568128;63410.365896340445;63562.68218658877;63847;63957.680211599574;64011;72943.63528182326;73729;73770;74007.62996184985;74337.62831185809;17445.7383139253;18655;18981.24075036983;18994.430167095008;18995.90502047481;14829.629259268604;15131.773023404658;15134;15142.848571514143;15163.545093647208;20693.379198624065;21115.782842801284;21119.26082587133;21122.894385527972;21149.89425052865;7096.964515177494;7113.656581406731;7254.16577093641;7300.853982920312;7351.301626345488;1135.500379832871;1164.2374244869625;1245.8131280307846;1248.9500419983099;1269.136986848933;33713;34013.63945442204;34173.65826341754;34544.654553454144;35414.822925885725;1213.3993673131856;1226.258113841131;1241.2552468518816;1251.8622951475331;1280.1487011137676;18032.188551515213;18155.72766408505;18242.726359104625;18345.81654183441;18485.260589576268;540737;543035;548814;550672;550703;64563;65265;65271.673641632435;65391;65449;1347.353270430199;1485.3241774992352;1525.3745964154866;1531.5864716526698;1607.0759313394844;30891.536626950165;31521.369572608877;31854;31896;32347;47351.52648473471;47432.52567474419;47604.7619761899;47692.76153619349;47711.761441192575;238456;243807;244739;245030;245121;26674.19977400681;26768.59847102334;30821.691783081882;32813.50779738258;33558.328833423686;49541.256881147536;50808.49191508185;51091;51435.228471573704;51662;42205;42322;42493.787531062146;42620.147597048504;44120.33819492646;40988.38517422182;41428.37857432081;41556;42059.369109463994;42828.5717142837;43207.135857283305;43545;43548.78225608852;44024.339634906144;44442.77778611086;36092.819535902156;37607;37962.240755185296;38182.427263590514;38290.23419531538;28799.56800648034;28945.85527072351;29428.705712942596;29479;29522.409551809273 05:33:46 INFO - PROCESS | 21403 | |2;jquery.html;425.15394365213234;425.7764673546388;429.39669763981607;431.40250752707493;435.6819521749123;18483.168257428413;19110.52223694408;19137;19348.806511934876;20146.89926550369;20379.898100509476;20517.692234616494;20577;20623.381298561068;20634.587308253827;5268.236105764662;5455.09990851511;5685.033544297458;5691.08942569189;5697.487226149646;3991.9800400997956;5104.800371912597;5663.915041274364;5681.8579535511735;6414.583052101621;6377;6399.5840270382505;6405.167328247345;6408.807735767911;6412.422881940624;6223.688815559227;6356.36436356363;6356.427921487065;6628.53600247978;6646.335366463363;5955.434233747787;5956.791512297092;5960.314563825173;5969.701514924236;5982.880342393171;14232.003759736823;21312.78687213139;22336.441588960242;22360.217392391187;22366.66450003251;2403.5319647801216;2453.644221587878;2535.2140836340795;2946.4254470378287;2960.4674736151633;10518.842217366746;10558.049775520163;12402.75194496114;13730.794038089436;14467.348969296407;2023.5244717491378;2042.1320938601036;2042.9080691368924;2052.963253556959;2073.056759174572;82851.75722364169;83745.58127209386;85787.57106214491;86611;88399.55800220958;11276;11707.707307317214;11773.117016223818;11854.051675866083;11874.0500759939;16327.59181020484;16366.918165409097;16504;16510.504684859472;16529.752053719203;8825.249853762502;9110.180083792358;9167.541622918827;9194.540272986324;9255.814883702289;8856.38005339633;8869.556522173865;8979;8992.820143597091;8996.145366190201;5097.515736005073;5145.4854514549;5146.176611742103;5187.844364669066;5280.735963201824;2000.879507475789;2077.574097310048;2111.440468275908;2173.847830651839;2191.4630915425823;965.5317171171976;1038.8649475568127;1039.7556574205055;1074.4788777442934;1155.6359746679937;16007.439739609057;18981.715274270897;20015.299464518965;20042.498937526678;20266.088026038862;1061.5010944855906;1084.9620263290747;1104.3318792130806;1148.5750272399098;1189.7144685275646;10807.783844323227;11206.831897521544;11305.943470282597;11314.660560183207;11444.256123351955;529753;530212;534864;547673;550002;71194.64402677954;93637.53181234187;97674;99517;100103.49948250213;1102.244962200879;1109.4286442482128;1117.1063149480547;1125.499152876962;1141.08713029576;13603.795943060664;16857.409990650267;17340.046297453762;17950.640987180446;18078.728819067463;41539;41660.58339416567;41780.866435016884;41982.580174197865;42297.788511057246;56632.71683641555;57911;58082.419175809395;58212.41787582239;58276;9052.502112383881;9095.090490951117;9095.49974751395;9262.490563019099;9553.426794392359;13372.732545348845;13672.65818354549;13741.312934353042;13947.37236824325;14022.78965815534;12109.75780484403;12237.326947017644;12301.138920275853;12396.132270740962;12629;11806.232594881305;11809.23239989398;11971.401429928643;12237.449314780679;12390.132690711564;11782.646520604396;12397.876021239672;12488.313142777235;12532.310722909962;12910.160839545399;9067.727968160701;9141.954290228507;9207.585658645243;9229.861552076858;9368.063193680577;9495;12307.507699691912;12653.11428200054;12744.171628844466;12874.742505149658 05:33:46 INFO - PROCESS | 21403 | |3;mootools.html;1380.758367285726;1460.2406748490785;1522.3606085444117;1735.4273089880332;1872.2417420944523;7666.080070391554;8328;8442.282405995482;8446.239838414542;8463.619137138829;8067.314278286338;8223.424360294766;8236.670533178665;8239.629216685249;8242.91757082429;2456.128074533537;2475.1460746042676;2481.0944005437977;2481.8759062046825;2483.3295010347197;2315.4327189838427;2489.3154382544853;2491.1032028469735;2491.676082109323;2492;2451.742567030463;2475.4801491686767;2479.504099180162;2482.094035676983;2489.788367988714;2423.878806059699;2451.44842410458;2458.53287875304;2476.195236548111;2486.055298986392;2395.5927492326346;2425.466397392571;2434.6591477193206;2435.7320694723567;2483.552960467115;8271.54506502142;8483.703070392507;8645.265152461985;8699.086595907465;8712.172343627346;5409.161579955114;5507.642003269774;5515;5517.69652669103;5523.088690366125;3813.504244448204;3852.0947577319307;3887.786171760552;3931.1351502669368;3937.1298633149027;1237.9133460657758;1274.6367285323638;1291.6189724031433;1321.86781321868;1346.8181795457683;11892.108091893057;12259.080568957364;12271.018318534585;12284.692882678004;12300.446479908425;4592.908141837212;4712.293156026623;4749.121412538691;4830.420349558076;4833.540813622701;9851;9852.261080418997;9864.704058878246;9867.506624668738;9874.60501579943;5352.357717073976;5357.35711714589;5401.783928642811;5409.783608655688;5412.539934105566;4385.956140438619;4463.486699029589;4941.555260026543;4998.375203099613;5008.749562521859;4006.318925782624;4017.2969730297664;4081.163361510883;4104.486939132608;4107.9178416431505;1236.3570943109712;1243.570968016033;1243.9813402798966;1248.3945286536023;1258.8552316483722;1038.5949479702922;1046.3460337289193;1055.2771351624008;1056.8573242612304;1072.785442911421;5841.299044114733;5901.616394934315;5940.940590594125;5986.494247182987;6180.3201647818705;459.25371271683514;460.537160154043;485.934398856157;491.0963826559077;512.4004914250336;4085.7957102144774;4152.795689250144;4279.593438623326;4285.8285668573535;4316.870493885189;10262.589496420209;10480.73798155037;10572.52423640938;10577.524011419504;10579.894201058045;10222.386656800616;10233;10270.0756931875;10378.42918639482;10382.42896640692;8028.799280017929;8082.797930051678;8116.228958248957;8410.285125764256;8465.91534084676;6084.1475652924;6094.299155597163;6176.722047507783;6190.907136392868;6224.284207316216;9459.10138536838;9633.036696330311;9745;9751.414915105117;9771.85342219853;9709.27180461454;9759.853602195832;9909.801803964025;9931.304808663324;10078.445685487368;6941.201761797256;7096.822579435556;7439.70241190368;7857.057153141431;7977.2022797719765;8176.509409435215;8181.590920453835;8246.422750407653;8264.586770661563;8273.544955027532;7243.963780181065;7307.26927307265;7433.033705618235;7579.1284002340435;7583.734569290048;7391.40868730511;7448.776536703907;7451.627418628938;7540.132884718328;7542.358899493604;6874.9656251718425;6877.105976223059;6880.449564034765;6894.724211031503;6938.653067346713;5098.337216161875;5162.199859021707;5172.482751724798;5329.147336426153;5354.759035843318;5305.283786688902;5349.090654588807;5409.648372855751;5430.13117901134;5454.809081682122 05:33:46 INFO - PROCESS | 21403 | |4;prototype.html;337.4095333166958;345.63535470079063;347.7200853313083;372.9272791805597;373.402555910543;6024.759009639614;6025.7288422021;6160.322364539903;6198.132261483396;6231.376862313767;6025.096235564656;6045.939540604592;6070.119832624267;6124.418180272878;6133.447989680928;4444;4701.7414042227665;4703.576678098962;4708.74101924394;4711.316859055435;4506.932396014063;4629.467611224702;4638.165130276549;4638.281066434708;4642.883927901813;4592.035672508777;4594.770261486929;4595;4601.401817763703;4608.907821843561;4392.538783427758;4498.932516012263;4588.931166032512;4598.747068911209;4600.97699511502;3924.627160419784;3943.7774289970203;3989.2420440116284;3994.500687414073;3996.820143093568;5833.183354330397;5844.503217226541;5882.323532793698;5884.352721200665;5887.116932460122;5359.624826262163;5360.544353729938;5368.436314187033;5369.3556773187465;5373.731313434352;6409.711562979631;6416.524199434156;6418.582792118497;6420.229572451289;6421.133147025139;4340.392345071693;4484.753338566377;4486.349479325512;4491.910161796745;4504;6733.663316834188;6771.9661401693165;6786.898196527056;6795.864082718367;6800.489963252776;4570.657200709894;4571.337156112345;4577.176108300538;4582.793774280099;4592.954070459319;4635.420572428447;4637.698549594265;4642.53574642533;4643.3731446255;4645.210314246586;5372.62391632582;5374.48942350476;5376.46235376467;5381.730913454312;5391.7304134793885;6386.808395748135;6520.9347906520325;6524.249711283263;6526.216853977553;6542.509311801634;1599.448190374319;1617.6926383987004;1618.2070785315345;1619.8542131208249;1624.0336999485287;1062.1184416933927;1062.553727434464;1067.4982758103833;1067.9679609611724;1071.5124618298655;6130.111133885562;6239.438450539473;6316.62100273985;6338.492920566344;6343.5876668016435;6665.466762658975;6699.76550820719;6710.798676039727;6725.05849181115;6742.696578653972;6355.586886852339;6360.363963603602;6360.554761166766;6362.618242905441;6367.395097465734;3576.803275819855;3611.9277614447565;3614.566252049771;3615.186583018852;3617.8010209438735;6832.726690932406;7018.1929078155645;7030.753923612649;7034.472414568928;7046.43628509718;6847.144106986627;6876.106106206261;6886.931130688629;6888.138982627172;6891.3797758201;7015.789526314321;7022.262662420474;7047;7050.259722729143;7073.221945585981;6712.060311556288;6722.563033402813;6724.731010759515;6724.798256052326;6728.8654226914205;6627.900581491185;6633.834154145992;6639.3692599203;6644.202695676549;6649.202095748541;6894.8621027580175;7069.222385537484;7087.255838137127;7096.290370962863;7096.787096387116;4536.72779633223;4593.173228818845;4594.035252596858;4596.103759766814;4597.609203217764;6677.966610166918;6742.359475849787;6745.325467453215;6746.4940129489505;6753.729850806109;6547.770828020996;6550.443212327005;6552.868942621216;6559.114519539801;6559.344065593403;6390.808275751735;6555.80332590023;6565.770198043046;6567.671616419065;6575.736970521126;6401.743930242738;6404.295527491879;6442.710078046405;6449.5485316027425;6452.12896258999;6609.537332386879;6616.2722100567935;6620.172478440195;6620.900686489803;6626.337366263335;6470.126532917996;6472.126262954441;6482.189726284215;6483.7730679425995;6484.1894763154605 05:33:46 INFO - PROCESS | 21403 | |5;yui.html;873.3449912565578;917.3395155488047;925.4493576322091;927.3276874266154;932.3892850183132;15511;15693.215339233022;15708.371665133394;15723;15723;14148.50480233192;14181.858181418183;14188;14197.92901035496;14214.78677819831;755.5806527377304;932.2914584915445;934.9158575728183;939.2579861909084;958.8226178157029;943.5093751249346;945.7399215215836;946.7254496196094;947.8341290274209;947.943123412594;982.6855406269997;987.6888780034302;993.2401712689798;993.538004827755;993.587661120634;782.7729958312083;796.9362451003906;797.214743477677;970.8495183246608;974.2303580171656;722.3029776265929;722.3823630795647;722.8301349182938;724.2142275630947;725.5936675461759;15802.683946321124;15820.920895395564;15864;15889.841101588952;15899;14187.858121418756;14298.285085745774;14311.856881431157;14548.272586370638;14583.854161458356;12125.818112728317;12237.20458170216;12246;12359.62921112368;12442.440090195963;4629.722216667011;4683.718976861399;4684.882877928045;4738.502457241974;4906.165951788204;59897.10154347645;61311.38688613101;61716.38283617151;61727.38272617261;61820.69089654568;11855.34795586251;11957.461914213882;12008;12068.637940861789;12485.56300529477;19436.805631943782;19505.902470487556;19538.90230548838;19569.1193896275;19596.314129005415;8532.786680332918;8627.741167764978;8804.078804078754;8805.42764720304;8846.203841654282;4971.751412429364;5058.9494105058475;5074.543291103819;5133.23001549763;5229.555487783505;3781.697464202857;3847.019010152449;3849.5188101487315;3852.056246219638;3852.24881148179;672.7275453441364;696.6412297666706;700.9369156775915;710.1939298895687;720.5028530314066;800.2277801921174;800.5516910530122;817.3787921179827;818.7707441916273;824.9340052795762;9881;10187.185025197967;10269.537870795832;10300;10468.581256749645;787.279639130201;817.0522194254636;818.6725309876098;827.2513375395276;833.212614079701;4693.624510039189;4889.2910527973245;4918.336024636628;5057.039162559102;5077.441481437039;55470;55554.44445555493;56030.43969560252;56116.15825762535;58909.11636325459;49350.25974610384;49825.50174498209;49907;50119;50841;52354.21468677973;52520.737396312776;52799.208011879855;53023.73488132535;54803.17795233075;10266.743331416774;10311.123554497952;10434.530446130095;10490.423026733297;10510.579576817148;36153.45769813508;36913.815430922674;37822.62177378191;37972.430413544374;38864.80567597144;45675;46931.53068469271;47071.529284708085;49048.75475622599;49213;12383.938080309541;12576.748465030465;12661.113722039368;12893.161944473579;13046.282454465096;12630.621081367573;12987.870121299044;13025.869741302466;13461.663458413226;13540.72918541604;13537.864621354054;13615.863841361856;13981.720365592835;14059.648508787363;14082.647933801736;12415.62753117408;12486.95217879885;12613.747725045265;12801.167924085277;12834.807477887653;12318.876811231772;12351.69120771988;12572.371381431074;13146.145500542434;13864.96012799024;11084.501197445972;11087.44562771842;11387.145964052563;11583.884161158618;11645.708857278636;10931.180161488079;11078.390688512209;11211.831822522505;11270.436478175894;11510.30938143714 05:33:46 INFO - PROCESS | 21403 | __end_tp_report 05:33:46 INFO - PROCESS | 21403 | __start_cc_report 05:33:46 INFO - PROCESS | 21403 | _x_x_mozilla_cycle_collect,881 05:33:46 INFO - PROCESS | 21403 | __end_cc_report 05:33:46 INFO - PROCESS | 21403 | __startTimestamp1468845226722__endTimestamp 05:33:46 INFO - PROCESS | 21403 | 05:33:46 INFO - PROCESS | 21403 | ------- Summary: start ------- 05:33:46 INFO - PROCESS | 21403 | Number of tests: 6 05:33:46 INFO - PROCESS | 21403 | 05:33:46 INFO - PROCESS | 21403 | [#0] dojo.html Cycles:165 Average:5566.54 Median:5793.16 stddev:623.97 (10.8%) stddev-sans-first:601.08 05:33:46 INFO - PROCESS | 21403 | Values: 3346.3 3392.4 3408.7 3414.7 3436.4 5544.5 5573.1 5575.9 5578.6 5583.6 5482.3 5585.6 5589.7 5594.9 5639.0 4983.5 5018.6 5023.6 5137.8 5178.4 4979.4 5067.2 5070.2 5071.1 5072.5 5010.4 5065.3 5124.5 5145.3 5145.5 5144.4 5163.1 5168.4 5176.6 5201.6 4913.5 5000.7 5055.3 5069.4 5071.0 5454.9 5472.4 5497.5 5521.4 5528.9 5956.8 5969.9 5973.5 5976.9 5977.0 5983.2 5993.4 6047.5 6065.5 6074.1 5577.8 5593.8 5624.9 5628.0 5643.0 5999.4 6129.1 6143.1 6149.5 6151.6 5842.6 5898.7 5907.6 5918.9 5919.1 5953.9 5956.8 5960.1 5964.7 5969.9 5805.7 5930.3 5932.3 5933.9 5948.2 5938.9 5961.9 5970.0 5975.3 6010.0 4541.1 4552.0 4554.4 4555.1 4578.6 4048.1 4058.9 4088.5 4100.0 4132.6 5715.7 5745.5 5751.4 5753.2 5754.3 6042.8 6046.5 6047.4 6049.1 6053.1 5606.0 5679.4 5720.1 5756.2 5778.3 5024.9 5033.9 5035.8 5037.7 5066.7 6218.1 6225.3 6227.0 6227.6 6227.7 5908.7 5972.1 6038.1 6132.3 6137.5 6230.3 6244.8 6274.4 6274.4 6276.7 5900.7 5904.6 5905.7 5909.9 5936.6 5824.7 6024.3 6079.2 6128.8 6133.1 5830.8 5835.3 5840.4 5843.4 5850.2 5780.1 5813.4 5827.9 5838.5 5843.8 5680.7 5764.8 5788.2 5791.2 5860.2 5884.6 5901.8 5904.9 5914.9 5919.7 5667.5 5792.1 5793.2 5798.9 5808.1 05:33:46 INFO - PROCESS | 21403 | 05:33:46 INFO - PROCESS | 21403 | [#1] ext.html Cycles:180 Average:61474.87 Median:37784.62 stddev:122902.31 (325.3%) stddev-sans-first:123162.19 05:33:46 INFO - PROCESS | 21403 | Values: 633.3 658.2 673.5 676.5 679.8 31913.5 32423.8 40067.6 40447.0 40458.4 44560.6 45118.0 45129.8 45187.0 45216.1 7754.8 8766.6 8951.0 8951.6 10378.4 10415.7 10545.8 10549.1 10551.7 10553.4 10583.0 10603.0 10689.1 10700.0 10712.6 10496.6 10563.7 10564.5 10571.2 10571.7 10453.9 10591.2 10599.1 10931.3 10931.9 44712.0 44923.6 45100.3 45161.1 45383.5 3910.6 4039.4 4094.6 4201.8 4481.1 33971.5 34294.0 34403.3 34855.8 34871.3 4574.9 4674.1 4678.9 4706.2 4801.9 366023.0 555087.0 562431.0 566649.0 568128.0 63410.4 63562.7 63847.0 63957.7 64011.0 72943.6 73729.0 73770.0 74007.6 74337.6 17445.7 18655.0 18981.2 18994.4 18995.9 14829.6 15131.8 15134.0 15142.8 15163.5 20693.4 21115.8 21119.3 21122.9 21149.9 7097.0 7113.7 7254.2 7300.9 7351.3 1135.5 1164.2 1245.8 1249.0 1269.1 33713.0 34013.6 34173.7 34544.7 35414.8 1213.4 1226.3 1241.3 1251.9 1280.1 18032.2 18155.7 18242.7 18345.8 18485.3 540737.0 543035.0 548814.0 550672.0 550703.0 64563.0 65265.0 65271.7 65391.0 65449.0 1347.4 1485.3 1525.4 1531.6 1607.1 30891.5 31521.4 31854.0 31896.0 32347.0 47351.5 47432.5 47604.8 47692.8 47711.8 238456.0 243807.0 244739.0 245030.0 245121.0 26674.2 26768.6 30821.7 32813.5 33558.3 49541.3 50808.5 51091.0 51435.2 51662.0 42205.0 42322.0 42493.8 42620.1 44120.3 40988.4 41428.4 41556.0 42059.4 42828.6 43207.1 43545.0 43548.8 44024.3 44442.8 36092.8 37607.0 37962.2 38182.4 38290.2 28799.6 28945.9 29428.7 29479.0 29522.4 05:33:46 INFO - PROCESS | 21403 | 05:33:46 INFO - PROCESS | 21403 | [#2] jquery.html Cycles:180 Average:30788.84 Median:12263.95 stddev:88580.39 (722.3%) stddev-sans-first:88799.54 05:33:46 INFO - PROCESS | 21403 | Values: 425.2 425.8 429.4 431.4 435.7 18483.2 19110.5 19137.0 19348.8 20146.9 20379.9 20517.7 20577.0 20623.4 20634.6 5268.2 5455.1 5685.0 5691.1 5697.5 3992.0 5104.8 5663.9 5681.9 6414.6 6377.0 6399.6 6405.2 6408.8 6412.4 6223.7 6356.4 6356.4 6628.5 6646.3 5955.4 5956.8 5960.3 5969.7 5982.9 14232.0 21312.8 22336.4 22360.2 22366.7 2403.5 2453.6 2535.2 2946.4 2960.5 10518.8 10558.0 12402.8 13730.8 14467.3 2023.5 2042.1 2042.9 2053.0 2073.1 82851.8 83745.6 85787.6 86611.0 88399.6 11276.0 11707.7 11773.1 11854.1 11874.1 16327.6 16366.9 16504.0 16510.5 16529.8 8825.2 9110.2 9167.5 9194.5 9255.8 8856.4 8869.6 8979.0 8992.8 8996.1 5097.5 5145.5 5146.2 5187.8 5280.7 2000.9 2077.6 2111.4 2173.8 2191.5 965.5 1038.9 1039.8 1074.5 1155.6 16007.4 18981.7 20015.3 20042.5 20266.1 1061.5 1085.0 1104.3 1148.6 1189.7 10807.8 11206.8 11305.9 11314.7 11444.3 529753.0 530212.0 534864.0 547673.0 550002.0 71194.6 93637.5 97674.0 99517.0 100103.5 1102.2 1109.4 1117.1 1125.5 1141.1 13603.8 16857.4 17340.0 17950.6 18078.7 41539.0 41660.6 41780.9 41982.6 42297.8 56632.7 57911.0 58082.4 58212.4 58276.0 9052.5 9095.1 9095.5 9262.5 9553.4 13372.7 13672.7 13741.3 13947.4 14022.8 12109.8 12237.3 12301.1 12396.1 12629.0 11806.2 11809.2 11971.4 12237.4 12390.1 11782.6 12397.9 12488.3 12532.3 12910.2 9067.7 9142.0 9207.6 9229.9 9368.1 9495.0 12307.5 12653.1 12744.2 12874.7 05:33:46 INFO - PROCESS | 21403 | 05:33:46 INFO - PROCESS | 21403 | [#3] mootools.html Cycles:180 Average:5733.72 Median:2805.37 stddev:3127.02 (111.5%) stddev-sans-first:3118.68 05:33:46 INFO - PROCESS | 21403 | Values: 1380.8 1460.2 1522.4 1735.4 1872.2 7666.1 8328.0 8442.3 8446.2 8463.6 8067.3 8223.4 8236.7 8239.6 8242.9 2456.1 2475.1 2481.1 2481.9 2483.3 2315.4 2489.3 2491.1 2491.7 2492.0 2451.7 2475.5 2479.5 2482.1 2489.8 2423.9 2451.4 2458.5 2476.2 2486.1 2395.6 2425.5 2434.7 2435.7 2483.6 8271.5 8483.7 8645.3 8699.1 8712.2 5409.2 5507.6 5515.0 5517.7 5523.1 3813.5 3852.1 3887.8 3931.1 3937.1 1237.9 1274.6 1291.6 1321.9 1346.8 11892.1 12259.1 12271.0 12284.7 12300.4 4592.9 4712.3 4749.1 4830.4 4833.5 9851.0 9852.3 9864.7 9867.5 9874.6 5352.4 5357.4 5401.8 5409.8 5412.5 4386.0 4463.5 4941.6 4998.4 5008.7 4006.3 4017.3 4081.2 4104.5 4107.9 1236.4 1243.6 1244.0 1248.4 1258.9 1038.6 1046.3 1055.3 1056.9 1072.8 5841.3 5901.6 5940.9 5986.5 6180.3 459.3 460.5 485.9 491.1 512.4 4085.8 4152.8 4279.6 4285.8 4316.9 10262.6 10480.7 10572.5 10577.5 10579.9 10222.4 10233.0 10270.1 10378.4 10382.4 8028.8 8082.8 8116.2 8410.3 8465.9 6084.1 6094.3 6176.7 6190.9 6224.3 9459.1 9633.0 9745.0 9751.4 9771.9 9709.3 9759.9 9909.8 9931.3 10078.4 6941.2 7096.8 7439.7 7857.1 7977.2 8176.5 8181.6 8246.4 8264.6 8273.5 7244.0 7307.3 7433.0 7579.1 7583.7 7391.4 7448.8 7451.6 7540.1 7542.4 6875.0 6877.1 6880.4 6894.7 6938.7 5098.3 5162.2 5172.5 5329.1 5354.8 5305.3 5349.1 5409.6 5430.1 5454.8 05:33:46 INFO - PROCESS | 21403 | 05:33:46 INFO - PROCESS | 21403 | [#4] prototype.html Cycles:180 Average:5439.05 Median:6235.41 stddev:1666.77 (26.7%) stddev-sans-first:1626.86 05:33:46 INFO - PROCESS | 21403 | Values: 337.4 345.6 347.7 372.9 373.4 6024.8 6025.7 6160.3 6198.1 6231.4 6025.1 6045.9 6070.1 6124.4 6133.4 4444.0 4701.7 4703.6 4708.7 4711.3 4506.9 4629.5 4638.2 4638.3 4642.9 4592.0 4594.8 4595.0 4601.4 4608.9 4392.5 4498.9 4588.9 4598.7 4601.0 3924.6 3943.8 3989.2 3994.5 3996.8 5833.2 5844.5 5882.3 5884.4 5887.1 5359.6 5360.5 5368.4 5369.4 5373.7 6409.7 6416.5 6418.6 6420.2 6421.1 4340.4 4484.8 4486.3 4491.9 4504.0 6733.7 6772.0 6786.9 6795.9 6800.5 4570.7 4571.3 4577.2 4582.8 4593.0 4635.4 4637.7 4642.5 4643.4 4645.2 5372.6 5374.5 5376.5 5381.7 5391.7 6386.8 6520.9 6524.2 6526.2 6542.5 1599.4 1617.7 1618.2 1619.9 1624.0 1062.1 1062.6 1067.5 1068.0 1071.5 6130.1 6239.4 6316.6 6338.5 6343.6 6665.5 6699.8 6710.8 6725.1 6742.7 6355.6 6360.4 6360.6 6362.6 6367.4 3576.8 3611.9 3614.6 3615.2 3617.8 6832.7 7018.2 7030.8 7034.5 7046.4 6847.1 6876.1 6886.9 6888.1 6891.4 7015.8 7022.3 7047.0 7050.3 7073.2 6712.1 6722.6 6724.7 6724.8 6728.9 6627.9 6633.8 6639.4 6644.2 6649.2 6894.9 7069.2 7087.3 7096.3 7096.8 4536.7 4593.2 4594.0 4596.1 4597.6 6678.0 6742.4 6745.3 6746.5 6753.7 6547.8 6550.4 6552.9 6559.1 6559.3 6390.8 6555.8 6565.8 6567.7 6575.7 6401.7 6404.3 6442.7 6449.5 6452.1 6609.5 6616.3 6620.2 6620.9 6626.3 6470.1 6472.1 6482.2 6483.8 6484.2 05:33:46 INFO - PROCESS | 21403 | 05:33:46 INFO - PROCESS | 21403 | [#5] yui.html Cycles:180 Average:15368.92 Median:4656.72 stddev:17133.22 (367.9%) stddev-sans-first:17146.70 05:33:46 INFO - PROCESS | 21403 | Values: 873.3 917.3 925.4 927.3 932.4 15511.0 15693.2 15708.4 15723.0 15723.0 14148.5 14181.9 14188.0 14197.9 14214.8 755.6 932.3 934.9 939.3 958.8 943.5 945.7 946.7 947.8 947.9 982.7 987.7 993.2 993.5 993.6 782.8 796.9 797.2 970.8 974.2 722.3 722.4 722.8 724.2 725.6 15802.7 15820.9 15864.0 15889.8 15899.0 14187.9 14298.3 14311.9 14548.3 14583.9 12125.8 12237.2 12246.0 12359.6 12442.4 4629.7 4683.7 4684.9 4738.5 4906.2 59897.1 61311.4 61716.4 61727.4 61820.7 11855.3 11957.5 12008.0 12068.6 12485.6 19436.8 19505.9 19538.9 19569.1 19596.3 8532.8 8627.7 8804.1 8805.4 8846.2 4971.8 5058.9 5074.5 5133.2 5229.6 3781.7 3847.0 3849.5 3852.1 3852.2 672.7 696.6 700.9 710.2 720.5 800.2 800.6 817.4 818.8 824.9 9881.0 10187.2 10269.5 10300.0 10468.6 787.3 817.1 818.7 827.3 833.2 4693.6 4889.3 4918.3 5057.0 5077.4 55470.0 55554.4 56030.4 56116.2 58909.1 49350.3 49825.5 49907.0 50119.0 50841.0 52354.2 52520.7 52799.2 53023.7 54803.2 10266.7 10311.1 10434.5 10490.4 10510.6 36153.5 36913.8 37822.6 37972.4 38864.8 45675.0 46931.5 47071.5 49048.8 49213.0 12383.9 12576.7 12661.1 12893.2 13046.3 12630.6 12987.9 13025.9 13461.7 13540.7 13537.9 13615.9 13981.7 14059.6 14082.6 12415.6 12487.0 12613.7 12801.2 12834.8 12318.9 12351.7 12572.4 13146.1 13865.0 11084.5 11087.4 11387.1 11583.9 11645.7 10931.2 11078.4 11211.8 11270.4 11510.3 05:33:46 INFO - PROCESS | 21403 | -------- Summary: end -------- 05:33:46 INFO - PROCESS | 21403 | 05:33:47 INFO - TEST-INFO | 21403: exit 0 05:33:47 INFO - TEST-OK | dromaeo_css | took 1110878ms 05:33:47 INFO - TEST-START | kraken 05:33:47 INFO - operating with platform_type : linux_ 05:33:47 INFO - Initialising browser for kraken test... 05:33:47 INFO - TEST-INFO | started process 21600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJe9Pyu/profile http://localhost:35842/getInfo.html) 05:33:51 INFO - PROCESS | 21600 | __metrics Screen width/height:1600/1200 05:33:51 INFO - PROCESS | 21600 | colorDepth:24 05:33:51 INFO - PROCESS | 21600 | Browser inner width/height: 1024/697 05:33:51 INFO - PROCESS | 21600 | __metrics 05:33:51 INFO - PROCESS | 21600 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:33:51 ERROR - PROCESS | 21600 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:33:52 INFO - TEST-INFO | 21600: exit 0 05:33:52 INFO - Browser initialized. 05:33:52 INFO - Running cycle 1/1 for kraken test... 05:33:52 INFO - TEST-INFO | started process 21691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJe9Pyu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:04 INFO - PROCESS | 21691 | RSS: Main: 139292672 05:34:04 INFO - PROCESS | 21691 | 05:34:06 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35842/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:07 INFO - PROCESS | 21691 | RSS: Main: 197328896 05:34:07 INFO - PROCESS | 21691 | 05:34:10 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35842/tests/kraken/driver.html?testName=audio-dft) 05:34:10 INFO - PROCESS | 21691 | RSS: Main: 184389632 05:34:10 INFO - PROCESS | 21691 | 05:34:13 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35842/tests/kraken/driver.html?testName=audio-fft) 05:34:14 INFO - PROCESS | 21691 | RSS: Main: 272797696 05:34:14 INFO - PROCESS | 21691 | 05:34:16 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35842/tests/kraken/driver.html?testName=audio-oscillator) 05:34:17 INFO - PROCESS | 21691 | RSS: Main: 179400704 05:34:17 INFO - PROCESS | 21691 | 05:34:19 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35842/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:19 INFO - PROCESS | 21691 | RSS: Main: 177598464 05:34:19 INFO - PROCESS | 21691 | 05:34:22 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35842/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:23 INFO - PROCESS | 21691 | RSS: Main: 213139456 05:34:23 INFO - PROCESS | 21691 | 05:34:26 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35842/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:27 INFO - PROCESS | 21691 | RSS: Main: 212369408 05:34:27 INFO - PROCESS | 21691 | 05:34:29 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35842/tests/kraken/driver.html?testName=json-parse-financial) 05:34:30 INFO - PROCESS | 21691 | RSS: Main: 212422656 05:34:30 INFO - PROCESS | 21691 | 05:34:32 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35842/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:34:32 INFO - PROCESS | 21691 | RSS: Main: 196759552 05:34:32 INFO - PROCESS | 21691 | 05:34:34 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35842/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:34:34 INFO - PROCESS | 21691 | RSS: Main: 199237632 05:34:34 INFO - PROCESS | 21691 | 05:34:36 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35842/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:34:37 INFO - PROCESS | 21691 | RSS: Main: 209870848 05:34:37 INFO - PROCESS | 21691 | 05:34:39 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:34:40 INFO - PROCESS | 21691 | RSS: Main: 217575424 05:34:40 INFO - PROCESS | 21691 | 05:34:43 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:34:43 INFO - PROCESS | 21691 | RSS: Main: 214421504 05:34:43 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:35842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35842/tests/kraken/driver.html?testName=ai-astar) 05:34:45 INFO - PROCESS | 21691 | RSS: Main: 274366464 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | __start_tp_report 05:34:45 INFO - PROCESS | 21691 | _x_x_mozilla_page_load 05:34:45 INFO - PROCESS | 21691 | _x_x_mozilla_page_load_details 05:34:45 INFO - PROCESS | 21691 | |i|pagename|runs| 05:34:45 INFO - PROCESS | 21691 | |0;ai-astar;109;110;110;112;113;108;103;107;109;109 05:34:45 INFO - PROCESS | 21691 | |1;audio-beat-detection;158;128;151;182;128;159;159;126;188;134 05:34:45 INFO - PROCESS | 21691 | |2;audio-dft;161;161;162;160;159;161;161;160;160;160 05:34:45 INFO - PROCESS | 21691 | |3;audio-fft;72;76;76;168;76;73;75;74;165;76 05:34:45 INFO - PROCESS | 21691 | |4;audio-oscillator;92;90;150;91;91;91;160;91;91;141 05:34:45 INFO - PROCESS | 21691 | |5;imaging-gaussian-blur;116;117;117;116;116;116;117;116;117;116 05:34:45 INFO - PROCESS | 21691 | |6;imaging-darkroom;145;145;145;144;145;145;145;145;145;145 05:34:45 INFO - PROCESS | 21691 | |7;imaging-desaturate;94;94;95;95;94;94;94;94;95;94 05:34:45 INFO - PROCESS | 21691 | |8;json-parse-financial;55;55;54;54;53;53;56;74;56;53 05:34:45 INFO - PROCESS | 21691 | |9;json-stringify-tinderbox;57;58;57;57;57;56;56;57;57;57 05:34:45 INFO - PROCESS | 21691 | |10;stanford-crypto-aes;74;73;73;73;73;74;74;74;75;76 05:34:45 INFO - PROCESS | 21691 | |11;stanford-crypto-ccm;113;113;119;114;113;112;111;111;129;133 05:34:45 INFO - PROCESS | 21691 | |12;stanford-crypto-pbkdf2;156;161;158;160;161;165;158;156;161;157 05:34:45 INFO - PROCESS | 21691 | |13;stanford-crypto-sha256-iterative;67;67;68;67;67;65;64;66;66;64 05:34:45 INFO - PROCESS | 21691 | __end_tp_report 05:34:45 INFO - PROCESS | 21691 | __start_cc_report 05:34:45 INFO - PROCESS | 21691 | _x_x_mozilla_cycle_collect,1596 05:34:45 INFO - PROCESS | 21691 | __end_cc_report 05:34:45 INFO - PROCESS | 21691 | __startTimestamp1468845285796__endTimestamp 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | ------- Summary: start ------- 05:34:45 INFO - PROCESS | 21691 | Number of tests: 14 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:2.75 (2.5%) stddev-sans-first:2.92 05:34:45 INFO - PROCESS | 21691 | Values: 109.0 110.0 110.0 112.0 113.0 108.0 103.0 107.0 109.0 109.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:158.50 stddev:22.31 (14.1%) stddev-sans-first:23.53 05:34:45 INFO - PROCESS | 21691 | Values: 158.0 128.0 151.0 182.0 128.0 159.0 159.0 126.0 188.0 134.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 05:34:45 INFO - PROCESS | 21691 | Values: 161.0 161.0 162.0 160.0 159.0 161.0 161.0 160.0 160.0 160.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.50 stddev:38.72 (51.3%) stddev-sans-first:40.31 05:34:45 INFO - PROCESS | 21691 | Values: 72.0 76.0 76.0 168.0 76.0 73.0 75.0 74.0 165.0 76.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:91.00 stddev:29.01 (31.9%) stddev-sans-first:30.13 05:34:45 INFO - PROCESS | 21691 | Values: 92.0 90.0 150.0 91.0 91.0 91.0 160.0 91.0 91.0 141.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:34:45 INFO - PROCESS | 21691 | Values: 116.0 117.0 117.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 05:34:45 INFO - PROCESS | 21691 | Values: 145.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:34:45 INFO - PROCESS | 21691 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.00 stddev:6.33 (11.5%) stddev-sans-first:6.69 05:34:45 INFO - PROCESS | 21691 | Values: 55.0 55.0 54.0 54.0 53.0 53.0 56.0 74.0 56.0 53.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 05:34:45 INFO - PROCESS | 21691 | Values: 57.0 58.0 57.0 57.0 57.0 56.0 56.0 57.0 57.0 57.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:0.99 (1.3%) stddev-sans-first:1.05 05:34:45 INFO - PROCESS | 21691 | Values: 74.0 73.0 73.0 73.0 73.0 74.0 74.0 74.0 75.0 76.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:113.50 stddev:7.87 (6.9%) stddev-sans-first:8.23 05:34:45 INFO - PROCESS | 21691 | Values: 113.0 113.0 119.0 114.0 113.0 112.0 111.0 111.0 129.0 133.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:160.50 stddev:2.83 (1.8%) stddev-sans-first:2.74 05:34:45 INFO - PROCESS | 21691 | Values: 156.0 161.0 158.0 160.0 161.0 165.0 158.0 156.0 161.0 157.0 05:34:45 INFO - PROCESS | 21691 | 05:34:45 INFO - PROCESS | 21691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:67.00 stddev:1.37 (2.0%) stddev-sans-first:1.41 05:34:45 INFO - PROCESS | 21691 | Values: 67.0 67.0 68.0 67.0 67.0 65.0 64.0 66.0 66.0 64.0 05:34:45 INFO - PROCESS | 21691 | -------- Summary: end -------- 05:34:45 INFO - PROCESS | 21691 | 05:34:46 INFO - TEST-INFO | 21691: exit 0 05:34:46 INFO - TEST-OK | kraken | took 59268ms 05:34:46 INFO - SUITE-END | took 1170s 05:34:46 INFO - Completed test suite (00:19:30) 05:34:46 INFO - javascript benchmark 05:34:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3346.29727757171, 3392.4402473591845, 3408.6932176104156, 3414.743894207935, 3436.3986302397075, 5544.528715059219, 5573.052581061214, 5575.8606034849145, 5578.609497335188, 5583.58123140764, 5482.314710661168, 5585.636933599323, 5589.664620122796, 5594.86012849679, 5639.041362968295, 4983.5265649763305, 5018.5985121190215, 5023.648344615878, 5137.820176293831, 5178.404483484391, 4979.377577802775, 5067.239914012891, 5070.188769796833, 5071.087204303224, 5072.467390923936, 5010.423801262847, 5065.316182315377, 5124.538791508763, 5145.305383773199, 5145.485451454843, 5144.408393034792, 5163.070647283487, 5168.431472538018, 5176.637635365526, 5201.609879259071, 4913.484084171147, 5000.699958002531, 5055.317532133152, 5069.417017043051, 5070.974645126787, 5454.91817622736, 5472.425395333473, 5497.47773961473, 5521.4478552144865, 5528.889422211573, 5956.761729530814, 5969.910451343233, 5973.492253158443, 5976.8505787355225, 5977.043673012341, 5983.1623572699855, 5993.430624090704, 6047.546434017467, 6065.545084118665, 6074.119252708377, 5577.776888924479, 5593.832185034415, 5624.915626265651, 5628.04323265046, 5643.040683083886, 5999.370066142992, 6129.1419201311855, 6143.139960405547, 6149.477294429934, 6151.6001459904965, 5842.620229685142, 5898.675572843449, 5907.586468947133, 5918.852028699317, 5919.082542205879, 5953.940460595425, 5956.821295361146, 5960.135780311917, 5964.701764911737, 5969.850753731192, 5805.6806875621405, 5930.28836539618, 5932.3474417814, 5933.9406605934255, 5948.226730525091, 5938.940610593925, 5961.850953726105, 5970.0, 5975.312839023481, 6009.969950150309, 4541.091781643684, 4552.044070745114, 4554.3851580036935, 4555.1117532080925, 4578.633709303248, 4048.068944142805, 4058.9391159132047, 4088.509378874495, 4099.975006248438, 4132.607402296777, 5715.714214289269, 5745.454181852718, 5751.367349591542, 5753.223314852441, 5754.280714910637, 6042.848928776728, 6046.455818976313, 6047.365026672224, 6049.0926361046195, 6053.092036194606, 5606.046972014768, 5679.375268720438, 5720.11338242573, 5756.194132821408, 5778.3354914184565, 5024.874378140576, 5033.874153146127, 5035.77339019745, 5037.722925239147, 5066.746662666926, 6218.129461875341, 6225.346338634468, 6227.0, 6227.595206311576, 6227.657478838707, 5908.734106965111, 5972.134040564094, 6038.094285857156, 6132.264128304453, 6137.539684523768, 6230.345813689497, 6244.750209991549, 6274.372562743689, 6274.435300822765, 6276.717547710273, 5900.675462849585, 5904.645721256738, 5905.704714764159, 5909.911351329648, 5936.5844390892225, 5824.737886795019, 6024.277086749618, 6079.1793107931635, 6128.846778830565, 6133.141360209485, 5830.76676932918, 5835.328937172279, 5840.415958404125, 5843.357230704704, 5850.151727999501, 5780.132980053026, 5813.447722466359, 5827.854303642443, 5838.474537291664, 5843.766249349978, 5680.6591604503865, 5764.798232061858, 5788.247527821524, 5791.160281759206, 5860.238169037998, 5884.617499862496, 5901.7639294427745, 5904.881902362014, 5914.881702365842, 5919.733611987384, 5667.4615911488345, 5792.102224155263, 5793.15999180125, 5798.913016304675, 5808.07070868659], "value": 5525.896217681651, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.2938773267808, 658.1772784019975, 673.5453568841033, 676.5433332500564, 679.7824696097249, 31913.52129718056, 32423.83788081062, 40067.599324006755, 40447.0, 40458.39312410316, 44560.55439445605, 45118.0, 45129.774351128195, 45187.0, 45216.09567808642, 7754.8449031019345, 8766.649334026632, 8951.0, 8951.597178126967, 10378.377297362182, 10415.739606509822, 10545.789084218311, 10549.050585447309, 10551.73620659482, 10553.366797992107, 10583.0, 10603.045725884669, 10689.144868410547, 10700.0, 10712.571497140105, 10496.632617858377, 10563.73590660232, 10564.524596393105, 10571.207159462994, 10571.682849514527, 10453.895461045367, 10591.152707783436, 10599.0990765785, 10931.289466184673, 10931.945340273327, 44712.0, 44923.55076449226, 45100.3234951476, 45161.09677806425, 45383.54616453826, 3910.6480416762342, 4039.414284928698, 4094.5905409459115, 4201.76890271035, 4481.058977614704, 33971.49042764361, 34294.0, 34403.311933761186, 34855.825720871486, 34871.30257394838, 4574.908501829978, 4674.13132415451, 4678.883027924295, 4706.247000479941, 4801.855944321676, 366023.0, 555087.0, 562430.9999999959, 566649.0, 568128.0, 63410.365896340445, 63562.68218658877, 63847.0, 63957.680211599574, 64011.0, 72943.63528182326, 73729.0, 73770.0, 74007.62996184985, 74337.62831185809, 17445.7383139253, 18655.0, 18981.24075036983, 18994.430167095008, 18995.90502047481, 14829.629259268604, 15131.773023404658, 15134.0, 15142.848571514143, 15163.545093647208, 20693.379198624065, 21115.782842801284, 21119.26082587133, 21122.894385527972, 21149.89425052865, 7096.964515177494, 7113.656581406731, 7254.16577093641, 7300.853982920312, 7351.301626345488, 1135.500379832871, 1164.2374244869625, 1245.8131280307846, 1248.9500419983099, 1269.136986848933, 33713.0, 34013.63945442204, 34173.65826341754, 34544.654553454144, 35414.822925885725, 1213.3993673131856, 1226.258113841131, 1241.2552468518816, 1251.8622951475331, 1280.1487011137676, 18032.188551515213, 18155.72766408505, 18242.726359104625, 18345.81654183441, 18485.260589576268, 540737.0, 543035.0, 548814.0, 550672.0, 550703.0, 64563.0, 65265.0, 65271.673641632435, 65391.0, 65449.0, 1347.353270430199, 1485.3241774992352, 1525.3745964154866, 1531.5864716526698, 1607.0759313394844, 30891.536626950165, 31521.369572608877, 31854.0, 31896.0, 32347.0, 47351.52648473471, 47432.52567474419, 47604.7619761899, 47692.76153619349, 47711.761441192575, 238456.0, 243807.0, 244739.0, 245030.0, 245121.0, 26674.19977400681, 26768.59847102334, 30821.691783081882, 32813.50779738258, 33558.328833423686, 49541.256881147536, 50808.49191508185, 51091.0, 51435.228471573704, 51662.0, 42205.0, 42322.0, 42493.787531062146, 42620.147597048504, 44120.33819492646, 40988.38517422182, 41428.37857432081, 41556.0, 42059.369109463994, 42828.5717142837, 43207.135857283305, 43545.0, 43548.78225608852, 44024.339634906144, 44442.77778611086, 36092.819535902156, 37607.0, 37962.240755185296, 38182.427263590514, 38290.23419531538, 28799.56800648034, 28945.85527072351, 29428.705712942596, 29479.0, 29522.409551809273], "value": 21531.93396300916, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.15394365213234, 425.7764673546388, 429.39669763981607, 431.40250752707493, 435.6819521749123, 18483.168257428413, 19110.52223694408, 19137.0, 19348.806511934876, 20146.89926550369, 20379.898100509476, 20517.692234616494, 20577.0, 20623.381298561068, 20634.587308253827, 5268.236105764662, 5455.09990851511, 5685.033544297458, 5691.08942569189, 5697.487226149646, 3991.9800400997956, 5104.800371912597, 5663.915041274364, 5681.8579535511735, 6414.583052101621, 6377.0, 6399.5840270382505, 6405.167328247345, 6408.807735767911, 6412.422881940624, 6223.688815559227, 6356.36436356363, 6356.427921487065, 6628.53600247978, 6646.335366463363, 5955.434233747787, 5956.791512297092, 5960.314563825173, 5969.701514924236, 5982.880342393171, 14232.003759736823, 21312.78687213139, 22336.441588960242, 22360.217392391187, 22366.66450003251, 2403.5319647801216, 2453.644221587878, 2535.2140836340795, 2946.4254470378287, 2960.4674736151633, 10518.842217366746, 10558.049775520163, 12402.75194496114, 13730.794038089436, 14467.348969296407, 2023.5244717491378, 2042.1320938601036, 2042.9080691368924, 2052.963253556959, 2073.056759174572, 82851.75722364169, 83745.58127209386, 85787.57106214491, 86611.0, 88399.55800220958, 11276.0, 11707.707307317214, 11773.117016223818, 11854.051675866083, 11874.0500759939, 16327.59181020484, 16366.918165409097, 16504.0, 16510.504684859472, 16529.752053719203, 8825.249853762502, 9110.180083792358, 9167.541622918827, 9194.540272986324, 9255.814883702289, 8856.38005339633, 8869.556522173865, 8979.0, 8992.820143597091, 8996.145366190201, 5097.515736005073, 5145.4854514549, 5146.176611742103, 5187.844364669066, 5280.735963201824, 2000.879507475789, 2077.574097310048, 2111.440468275908, 2173.847830651839, 2191.4630915425823, 965.5317171171976, 1038.8649475568127, 1039.7556574205055, 1074.4788777442934, 1155.6359746679937, 16007.439739609057, 18981.715274270897, 20015.299464518965, 20042.498937526678, 20266.088026038862, 1061.5010944855906, 1084.9620263290747, 1104.3318792130806, 1148.5750272399098, 1189.7144685275646, 10807.783844323227, 11206.831897521544, 11305.943470282597, 11314.660560183207, 11444.256123351955, 529753.0, 530212.0, 534864.0, 547673.0, 550002.0, 71194.64402677954, 93637.53181234187, 97674.0, 99517.0, 100103.49948250213, 1102.244962200879, 1109.4286442482128, 1117.1063149480547, 1125.499152876962, 1141.08713029576, 13603.795943060664, 16857.409990650267, 17340.046297453762, 17950.640987180446, 18078.728819067463, 41539.0, 41660.58339416567, 41780.866435016884, 41982.580174197865, 42297.788511057246, 56632.71683641555, 57911.0, 58082.419175809395, 58212.41787582239, 58276.0, 9052.502112383881, 9095.090490951117, 9095.49974751395, 9262.490563019099, 9553.426794392359, 13372.732545348845, 13672.65818354549, 13741.312934353042, 13947.37236824325, 14022.78965815534, 12109.75780484403, 12237.326947017644, 12301.138920275853, 12396.132270740962, 12629.0, 11806.232594881305, 11809.23239989398, 11971.401429928643, 12237.449314780679, 12390.132690711564, 11782.646520604396, 12397.876021239672, 12488.313142777235, 12532.310722909962, 12910.160839545399, 9067.727968160701, 9141.954290228507, 9207.585658645243, 9229.861552076858, 9368.063193680577, 9495.0, 12307.507699691912, 12653.11428200054, 12744.171628844466, 12874.742505149658], "value": 9729.1180157057, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.758367285726, 1460.2406748490785, 1522.3606085444117, 1735.4273089880332, 1872.2417420944523, 7666.080070391554, 8328.0, 8442.282405995482, 8446.239838414542, 8463.619137138829, 8067.314278286338, 8223.424360294766, 8236.670533178665, 8239.629216685249, 8242.91757082429, 2456.128074533537, 2475.1460746042676, 2481.0944005437977, 2481.8759062046825, 2483.3295010347197, 2315.4327189838427, 2489.3154382544853, 2491.1032028469735, 2491.676082109323, 2492.0, 2451.742567030463, 2475.4801491686767, 2479.504099180162, 2482.094035676983, 2489.788367988714, 2423.878806059699, 2451.44842410458, 2458.53287875304, 2476.195236548111, 2486.055298986392, 2395.5927492326346, 2425.466397392571, 2434.6591477193206, 2435.7320694723567, 2483.552960467115, 8271.54506502142, 8483.703070392507, 8645.265152461985, 8699.086595907465, 8712.172343627346, 5409.161579955114, 5507.642003269774, 5515.0, 5517.69652669103, 5523.088690366125, 3813.504244448204, 3852.0947577319307, 3887.786171760552, 3931.1351502669368, 3937.1298633149027, 1237.9133460657758, 1274.6367285323638, 1291.6189724031433, 1321.86781321868, 1346.8181795457683, 11892.108091893057, 12259.080568957364, 12271.018318534585, 12284.692882678004, 12300.446479908425, 4592.908141837212, 4712.293156026623, 4749.121412538691, 4830.420349558076, 4833.540813622701, 9851.0, 9852.261080418997, 9864.704058878246, 9867.506624668738, 9874.60501579943, 5352.357717073976, 5357.35711714589, 5401.783928642811, 5409.783608655688, 5412.539934105566, 4385.956140438619, 4463.486699029589, 4941.555260026543, 4998.375203099613, 5008.749562521859, 4006.318925782624, 4017.2969730297664, 4081.163361510883, 4104.486939132608, 4107.9178416431505, 1236.3570943109712, 1243.570968016033, 1243.9813402798966, 1248.3945286536023, 1258.8552316483722, 1038.5949479702922, 1046.3460337289193, 1055.2771351624008, 1056.8573242612304, 1072.785442911421, 5841.299044114733, 5901.616394934315, 5940.940590594125, 5986.494247182987, 6180.3201647818705, 459.25371271683514, 460.537160154043, 485.934398856157, 491.0963826559077, 512.4004914250336, 4085.7957102144774, 4152.795689250144, 4279.593438623326, 4285.8285668573535, 4316.870493885189, 10262.589496420209, 10480.73798155037, 10572.52423640938, 10577.524011419504, 10579.894201058045, 10222.386656800616, 10233.0, 10270.0756931875, 10378.42918639482, 10382.42896640692, 8028.799280017929, 8082.797930051678, 8116.228958248957, 8410.285125764256, 8465.91534084676, 6084.1475652924, 6094.299155597163, 6176.722047507783, 6190.907136392868, 6224.284207316216, 9459.10138536838, 9633.036696330311, 9745.0, 9751.414915105117, 9771.85342219853, 9709.27180461454, 9759.853602195832, 9909.801803964025, 9931.304808663324, 10078.445685487368, 6941.201761797256, 7096.822579435556, 7439.70241190368, 7857.057153141431, 7977.2022797719765, 8176.509409435215, 8181.590920453835, 8246.422750407653, 8264.586770661563, 8273.544955027532, 7243.963780181065, 7307.26927307265, 7433.033705618235, 7579.1284002340435, 7583.734569290048, 7391.40868730511, 7448.776536703907, 7451.627418628938, 7540.132884718328, 7542.358899493604, 6874.9656251718425, 6877.105976223059, 6880.449564034765, 6894.724211031503, 6938.653067346713, 5098.337216161875, 5162.199859021707, 5172.482751724798, 5329.147336426153, 5354.759035843318, 5305.283786688902, 5349.090654588807, 5409.648372855751, 5430.13117901134, 5454.809081682122], "value": 4606.171192085003, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.4095333166958, 345.63535470079063, 347.7200853313083, 372.9272791805597, 373.402555910543, 6024.759009639614, 6025.7288422021, 6160.322364539903, 6198.132261483396, 6231.376862313767, 6025.096235564656, 6045.939540604592, 6070.119832624267, 6124.418180272878, 6133.447989680928, 4444.0, 4701.7414042227665, 4703.576678098962, 4708.74101924394, 4711.316859055435, 4506.932396014063, 4629.467611224702, 4638.165130276549, 4638.281066434708, 4642.883927901813, 4592.035672508777, 4594.770261486929, 4595.0, 4601.401817763703, 4608.907821843561, 4392.538783427758, 4498.932516012263, 4588.931166032512, 4598.747068911209, 4600.97699511502, 3924.627160419784, 3943.7774289970203, 3989.2420440116284, 3994.500687414073, 3996.820143093568, 5833.183354330397, 5844.503217226541, 5882.323532793698, 5884.352721200665, 5887.116932460122, 5359.624826262163, 5360.544353729938, 5368.436314187033, 5369.3556773187465, 5373.731313434352, 6409.711562979631, 6416.524199434156, 6418.582792118497, 6420.229572451289, 6421.133147025139, 4340.392345071693, 4484.753338566377, 4486.349479325512, 4491.910161796745, 4504.0, 6733.663316834188, 6771.9661401693165, 6786.898196527056, 6795.864082718367, 6800.489963252776, 4570.657200709894, 4571.337156112345, 4577.176108300538, 4582.793774280099, 4592.954070459319, 4635.420572428447, 4637.698549594265, 4642.53574642533, 4643.3731446255, 4645.210314246586, 5372.62391632582, 5374.48942350476, 5376.46235376467, 5381.730913454312, 5391.7304134793885, 6386.808395748135, 6520.9347906520325, 6524.249711283263, 6526.216853977553, 6542.509311801634, 1599.448190374319, 1617.6926383987004, 1618.2070785315345, 1619.8542131208249, 1624.0336999485287, 1062.1184416933927, 1062.553727434464, 1067.4982758103833, 1067.9679609611724, 1071.5124618298655, 6130.111133885562, 6239.438450539473, 6316.62100273985, 6338.492920566344, 6343.5876668016435, 6665.466762658975, 6699.76550820719, 6710.798676039727, 6725.05849181115, 6742.696578653972, 6355.586886852339, 6360.363963603602, 6360.554761166766, 6362.618242905441, 6367.395097465734, 3576.803275819855, 3611.9277614447565, 3614.566252049771, 3615.186583018852, 3617.8010209438735, 6832.726690932406, 7018.1929078155645, 7030.753923612649, 7034.472414568928, 7046.43628509718, 6847.144106986627, 6876.106106206261, 6886.931130688629, 6888.138982627172, 6891.3797758201, 7015.789526314321, 7022.262662420474, 7047.0, 7050.259722729143, 7073.221945585981, 6712.060311556288, 6722.563033402813, 6724.731010759515, 6724.798256052326, 6728.8654226914205, 6627.900581491185, 6633.834154145992, 6639.3692599203, 6644.202695676549, 6649.202095748541, 6894.8621027580175, 7069.222385537484, 7087.255838137127, 7096.290370962863, 7096.787096387116, 4536.72779633223, 4593.173228818845, 4594.035252596858, 4596.103759766814, 4597.609203217764, 6677.966610166918, 6742.359475849787, 6745.325467453215, 6746.4940129489505, 6753.729850806109, 6547.770828020996, 6550.443212327005, 6552.868942621216, 6559.114519539801, 6559.344065593403, 6390.808275751735, 6555.80332590023, 6565.770198043046, 6567.671616419065, 6575.736970521126, 6401.743930242738, 6404.295527491879, 6442.710078046405, 6449.5485316027425, 6452.12896258999, 6609.537332386879, 6616.2722100567935, 6620.172478440195, 6620.900686489803, 6626.337366263335, 6470.126532917996, 6472.126262954441, 6482.189726284215, 6483.7730679425995, 6484.1894763154605], "value": 4897.765392038787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.3449912565578, 917.3395155488047, 925.4493576322091, 927.3276874266154, 932.3892850183132, 15511.0, 15693.215339233022, 15708.371665133394, 15723.0, 15723.0, 14148.50480233192, 14181.858181418183, 14188.0, 14197.92901035496, 14214.78677819831, 755.5806527377304, 932.2914584915445, 934.9158575728183, 939.2579861909084, 958.8226178157029, 943.5093751249346, 945.7399215215836, 946.7254496196094, 947.8341290274209, 947.943123412594, 982.6855406269997, 987.6888780034302, 993.2401712689798, 993.538004827755, 993.587661120634, 782.7729958312083, 796.9362451003906, 797.214743477677, 970.8495183246608, 974.2303580171656, 722.3029776265929, 722.3823630795647, 722.8301349182938, 724.2142275630947, 725.5936675461759, 15802.683946321124, 15820.920895395564, 15864.0, 15889.841101588952, 15899.0, 14187.858121418756, 14298.285085745774, 14311.856881431157, 14548.272586370638, 14583.854161458356, 12125.818112728317, 12237.20458170216, 12246.0, 12359.62921112368, 12442.440090195963, 4629.722216667011, 4683.718976861399, 4684.882877928045, 4738.502457241974, 4906.165951788204, 59897.10154347645, 61311.38688613101, 61716.38283617151, 61727.38272617261, 61820.69089654568, 11855.34795586251, 11957.461914213882, 12008.0, 12068.637940861789, 12485.56300529477, 19436.805631943782, 19505.902470487556, 19538.90230548838, 19569.1193896275, 19596.314129005415, 8532.786680332918, 8627.741167764978, 8804.078804078754, 8805.42764720304, 8846.203841654282, 4971.751412429364, 5058.9494105058475, 5074.543291103819, 5133.23001549763, 5229.555487783505, 3781.697464202857, 3847.019010152449, 3849.5188101487315, 3852.056246219638, 3852.24881148179, 672.7275453441364, 696.6412297666706, 700.9369156775915, 710.1939298895687, 720.5028530314066, 800.2277801921174, 800.5516910530122, 817.3787921179827, 818.7707441916273, 824.9340052795762, 9881.0, 10187.185025197967, 10269.537870795832, 10300.0, 10468.581256749645, 787.279639130201, 817.0522194254636, 818.6725309876098, 827.2513375395276, 833.212614079701, 4693.624510039189, 4889.2910527973245, 4918.336024636628, 5057.039162559102, 5077.441481437039, 55470.0, 55554.44445555493, 56030.43969560252, 56116.15825762535, 58909.11636325459, 49350.25974610384, 49825.50174498209, 49907.0, 50119.0, 50841.0, 52354.21468677973, 52520.737396312776, 52799.208011879855, 53023.73488132535, 54803.17795233075, 10266.743331416774, 10311.123554497952, 10434.530446130095, 10490.423026733297, 10510.579576817148, 36153.45769813508, 36913.815430922674, 37822.62177378191, 37972.430413544374, 38864.80567597144, 45675.0, 46931.53068469271, 47071.529284708085, 49048.75475622599, 49213.0, 12383.938080309541, 12576.748465030465, 12661.113722039368, 12893.161944473579, 13046.282454465096, 12630.621081367573, 12987.870121299044, 13025.869741302466, 13461.663458413226, 13540.72918541604, 13537.864621354054, 13615.863841361856, 13981.720365592835, 14059.648508787363, 14082.647933801736, 12415.62753117408, 12486.95217879885, 12613.747725045265, 12801.167924085277, 12834.807477887653, 12318.876811231772, 12351.69120771988, 12572.371381431074, 13146.145500542434, 13864.96012799024, 11084.501197445972, 11087.44562771842, 11387.145964052563, 11583.884161158618, 11645.708857278636, 10931.180161488079, 11078.390688512209, 11211.831822522505, 11270.436478175894, 11510.30938143714], "value": 7282.7986735440745, "unit": "score"}], "name": "dromaeo_css", "value": 7583.557678380135, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 112.0, 113.0, 108.0, 103.0, 107.0, 109.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 151.0, 182.0, 128.0, 159.0, 159.0, 126.0, 188.0, 134.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 159.0, 161.0, 161.0, 160.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 76.0, 168.0, 76.0, 73.0, 75.0, 74.0, 165.0, 76.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 150.0, 91.0, 91.0, 91.0, 160.0, 91.0, 91.0, 141.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 53.0, 53.0, 56.0, 74.0, 56.0, 53.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 57.0, 57.0, 56.0, 56.0, 57.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 74.0, 74.0, 74.0, 75.0, 76.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 119.0, 114.0, 113.0, 112.0, 111.0, 111.0, 129.0, 133.0], "value": 116.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 161.0, 158.0, 160.0, 161.0, 165.0, 158.0, 156.0, 161.0, 157.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 65.0, 64.0, 66.0, 66.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1507.6, "alertThreshold": 2.0}]} 05:34:47 INFO - Return code: 0 05:34:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:34:47 ERROR - # TBPL SUCCESS # 05:34:47 INFO - Running post-action listener: _resource_record_post_action 05:34:47 INFO - Running post-run listener: _resource_record_post_run 05:34:48 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 28672; Write bytes: 481255424; Read time: 28; Write time: 387236 05:34:48 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 258670592; Read time: 0; Write time: 251192 05:34:48 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222584832; Read time: 12; Write time: 136044 05:34:48 INFO - Running post-run listener: _upload_blobber_files 05:34:48 INFO - Blob upload gear active. 05:34:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:34:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:34:48 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'] 05:34:48 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 05:34:48 INFO - (blobuploader) - INFO - Open directory for files ... 05:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:49 INFO - (blobuploader) - INFO - Done attempting. 05:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:34:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:50 INFO - (blobuploader) - INFO - Done attempting. 05:34:50 INFO - (blobuploader) - INFO - Iteration through files over. 05:34:50 INFO - Return code: 0 05:34:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:34:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:34:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ee53e3fb452145e77d7585ec0da2064482ee2c82b136a37b925afe614de524c4dd9e2bd9760a7b7eb2aaedad085e7bf6d52b49a72c4175a588baa8273c9d65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d7e7123011c35405743d91333b6053180cfbc4871d91b56bae4c97e61aa5690814d14b432fa0d1d0e04541881fe33961e7832c279a26a1d70a4ab6b8e8bd04f"} 05:34:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:34:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:34:50 INFO - Contents: 05:34:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ee53e3fb452145e77d7585ec0da2064482ee2c82b136a37b925afe614de524c4dd9e2bd9760a7b7eb2aaedad085e7bf6d52b49a72c4175a588baa8273c9d65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d7e7123011c35405743d91333b6053180cfbc4871d91b56bae4c97e61aa5690814d14b432fa0d1d0e04541881fe33961e7832c279a26a1d70a4ab6b8e8bd04f"} 05:34:50 INFO - Running post-run listener: copy_logs_to_upload_dir 05:34:50 INFO - Copying logs to upload dir... 05:34:50 INFO - mkdir: /builds/slave/test/build/upload/logs 05:34:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.719660 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-18 05:34:50.070959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:34:50.075177) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131 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/7ee53e3fb452145e77d7585ec0da2064482ee2c82b136a37b925afe614de524c4dd9e2bd9760a7b7eb2aaedad085e7bf6d52b49a72c4175a588baa8273c9d65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d7e7123011c35405743d91333b6053180cfbc4871d91b56bae4c97e61aa5690814d14b432fa0d1d0e04541881fe33961e7832c279a26a1d70a4ab6b8e8bd04f"} build_url:https://queue.taskcluster.net/v1/task/bM1dEaksR7GfLZOIWYwBqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/bM1dEaksR7GfLZOIWYwBqw/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/7ee53e3fb452145e77d7585ec0da2064482ee2c82b136a37b925afe614de524c4dd9e2bd9760a7b7eb2aaedad085e7bf6d52b49a72c4175a588baa8273c9d65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d7e7123011c35405743d91333b6053180cfbc4871d91b56bae4c97e61aa5690814d14b432fa0d1d0e04541881fe33961e7832c279a26a1d70a4ab6b8e8bd04f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:34:50.108804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:34:50.109585) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468844065.996330-960627131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:34:50.193150) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:34:50.193497) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:34:50.193835) ========= ========= Total master_lag: 0.19 =========