builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1461846153.89 results: success (0) buildid: 20160428024229 builduid: 73c716e0482e455ba8bc20b11ec4ba4c revision: d928d2fde8c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:33.886225) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:33.886727) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:33.887063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:33.914012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:33.914309) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 05:22:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-04-28 05:22:35 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.349756 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:34.280242) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:34.280590) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017420 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:34.330650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:34.331032) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d928d2fde8c7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d928d2fde8c7 --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=74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 05:22:35,399 Setting DEBUG logging. 2016-04-28 05:22:35,399 attempt 1/10 2016-04-28 05:22:35,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d928d2fde8c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 05:22:35,661 unpacking tar archive at: mozilla-inbound-d928d2fde8c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552931 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:34.896597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:34.896940) ========= script_repo_revision: d928d2fde8c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:34.897324) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:34.897588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:22:34.906326) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-28 05:22:34.906692) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:22:36 INFO - MultiFileLogger online at 20160428 05:22:36 in /builds/slave/test 05:22:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 05:22:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:22:36 INFO - {'append_to_log': False, 05:22:36 INFO - 'base_work_dir': '/builds/slave/test', 05:22:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 05:22:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:22:36 INFO - 'branch': 'Mozilla-Inbound', 05:22:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:22:36 INFO - 'config_files': ('talos/linux_config.py',), 05:22:36 INFO - 'default_actions': ('clobber', 05:22:36 INFO - 'read-buildbot-config', 05:22:36 INFO - 'download-and-extract', 05:22:36 INFO - 'populate-webroot', 05:22:36 INFO - 'create-virtualenv', 05:22:36 INFO - 'install', 05:22:36 INFO - 'run-tests'), 05:22:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:22:36 INFO - 'download_minidump_stackwalk': True, 05:22:36 INFO - 'download_symbols': 'ondemand', 05:22:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:22:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:22:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:22:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:22:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:22:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:22:36 INFO - 'installer_path': 'installer.exe', 05:22:36 INFO - 'log_level': 'info', 05:22:36 INFO - 'log_name': 'talos', 05:22:36 INFO - 'log_to_console': True, 05:22:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:22:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:22:36 INFO - 'opt_config_files': (), 05:22:36 INFO - 'pip_index': False, 05:22:36 INFO - 'sps_profile': False, 05:22:36 INFO - 'sps_profile_interval': 0, 05:22:36 INFO - 'suite': 'dromaeojs', 05:22:36 INFO - 'system_bits': '32', 05:22:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:22:36 INFO - 'title': 'talos-linux64-ix-042', 05:22:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:22:36 INFO - 'use_talos_json': True, 05:22:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:22:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:22:36 INFO - 'work_dir': 'build'} 05:22:36 INFO - ##### 05:22:36 INFO - ##### Running clobber step. 05:22:36 INFO - ##### 05:22:36 INFO - Running pre-action listener: _resource_record_pre_action 05:22:36 INFO - Running main action method: clobber 05:22:36 INFO - rmtree: /builds/slave/test/build 05:22:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:22:36 INFO - Running post-action listener: _resource_record_post_action 05:22:36 INFO - ##### 05:22:36 INFO - ##### Running read-buildbot-config step. 05:22:36 INFO - ##### 05:22:36 INFO - Running pre-action listener: _resource_record_pre_action 05:22:36 INFO - Running main action method: read_buildbot_config 05:22:36 INFO - Using buildbot properties: 05:22:36 INFO - { 05:22:36 INFO - "project": "", 05:22:36 INFO - "product": "firefox", 05:22:36 INFO - "script_repo_revision": "production", 05:22:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 05:22:36 INFO - "repository": "", 05:22:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 05:22:36 INFO - "buildid": "20160428024229", 05:22:36 INFO - "pgo_build": "True", 05:22:36 INFO - "basedir": "/builds/slave/test", 05:22:36 INFO - "buildnumber": 1761, 05:22:36 INFO - "slavename": "talos-linux64-ix-042", 05:22:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:22:36 INFO - "platform": "ubuntu64_hw", 05:22:36 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 05:22:36 INFO - "branch": "mozilla-inbound", 05:22:36 INFO - "repo_path": "integration/mozilla-inbound", 05:22:36 INFO - "revision": "d928d2fde8c7", 05:22:36 INFO - "stage_platform": "linux64-pgo", 05:22:36 INFO - "builduid": "73c716e0482e455ba8bc20b11ec4ba4c", 05:22:36 INFO - "slavebuilddir": "test" 05:22:36 INFO - } 05:22:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:22:36 INFO - Running post-action listener: _resource_record_post_action 05:22:36 INFO - ##### 05:22:36 INFO - ##### Running download-and-extract step. 05:22:36 INFO - ##### 05:22:36 INFO - Running pre-action listener: _resource_record_pre_action 05:22:36 INFO - Running main action method: download_and_extract 05:22:36 INFO - mkdir: /builds/slave/test/build/tests 05:22:36 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:22:36 INFO - https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:22:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:22:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:22:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:22:43 INFO - Downloaded 1361 bytes. 05:22:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:22:43 INFO - Using the following test package requirements: 05:22:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:22:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:22:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:22:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:43 INFO - u'jsshell-linux-x86_64.zip'], 05:22:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:22:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:22:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:22:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:22:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:22:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:22:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:22: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:22:43 INFO - https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:22:46 INFO - Downloaded 23872717 bytes. 05:22:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:22:47 INFO - Return code: 0 05:22:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:47 INFO - https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:22:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:22:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:22:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:22:49 INFO - Downloaded 23872717 bytes. 05:22:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:22:50 INFO - Return code: 0 05:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:50 INFO - https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:22:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:22:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:22:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:22:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:22:52 INFO - Downloaded 10840145 bytes. 05:22:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:22:52 INFO - Return code: 0 05:22: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:22:52 INFO - https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:22:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:22:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:22:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:22:53 INFO - Downloaded 58384343 bytes. 05:22:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:22:54 INFO - mkdir: /builds/slave/test/properties 05:22:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:22:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:22:54 INFO - Contents: 05:22:54 INFO - build_url:https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:22:54 INFO - Running post-action listener: _resource_record_post_action 05:22:54 INFO - Running post-action listener: set_extra_try_arguments 05:22:54 INFO - ##### 05:22:54 INFO - ##### Running populate-webroot step. 05:22:54 INFO - ##### 05:22:54 INFO - Running pre-action listener: _resource_record_pre_action 05:22:54 INFO - Running main action method: populate_webroot 05:22:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:22:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:22:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:22:54 INFO - '--tppagecycles', 05:22:54 INFO - '7'], 05:22:54 INFO - 'tests': ['tsvgm']}}, 05:22:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:22:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:22:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:22:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:22:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:22:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:22:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:54 INFO - 'talos_options': ['--disable-e10s'], 05:22:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:54 INFO - 'talos_options': ['--disable-e10s'], 05:22:54 INFO - 'tests': ['damp', 'tps']}, 05:22:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:54 INFO - 'tests': ['damp', 'tps']}, 05:22:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:22:54 INFO - 'tests': ['dromaeo_dom']}, 05:22:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:22:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:22:54 INFO - 'tests': ['a11yr', 05:22:54 INFO - 'ts_paint', 05:22:54 INFO - 'tpaint', 05:22:54 INFO - 'sessionrestore', 05:22:54 INFO - 'sessionrestore_no_auto_restore', 05:22:54 INFO - 'tabpaint']}, 05:22:54 INFO - 'other-e10s': {'tests': ['a11yr', 05:22:54 INFO - 'ts_paint', 05:22:54 INFO - 'tpaint', 05:22:54 INFO - 'sessionrestore', 05:22:54 INFO - 'sessionrestore_no_auto_restore', 05:22:54 INFO - 'tabpaint']}, 05:22:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:22:54 INFO - 'ts_paint', 05:22:54 INFO - 'tpaint', 05:22:54 INFO - 'sessionrestore', 05:22:54 INFO - 'sessionrestore_no_auto_restore', 05:22:54 INFO - 'tabpaint']}, 05:22:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:22:54 INFO - 'ts_paint', 05:22:54 INFO - 'tpaint', 05:22:54 INFO - 'sessionrestore', 05:22:54 INFO - 'sessionrestore_no_auto_restore', 05:22:54 INFO - 'tabpaint']}, 05:22:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:22:54 INFO - 'tests': ['a11yr', 05:22:54 INFO - 'ts_paint', 05:22:54 INFO - 'tpaint', 05:22:54 INFO - 'sessionrestore', 05:22:54 INFO - 'sessionrestore_no_auto_restore', 05:22:54 INFO - 'tabpaint']}, 05:22:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:22:54 INFO - 'tests': ['a11yr', 05:22:54 INFO - 'ts_paint', 05:22:54 INFO - 'tpaint', 05:22:54 INFO - 'sessionrestore', 05:22:54 INFO - 'sessionrestore_no_auto_restore', 05:22:54 INFO - 'tabpaint']}, 05:22:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:22:54 INFO - 'tests': ['tsvgx', 05:22:54 INFO - 'tsvgr_opacity', 05:22:54 INFO - 'tart', 05:22:54 INFO - 'tscrollx', 05:22:54 INFO - 'cart']}, 05:22:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:22:54 INFO - 'tsvgr_opacity', 05:22:54 INFO - 'tart', 05:22:54 INFO - 'tscrollx', 05:22:54 INFO - 'cart']}, 05:22:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:54 INFO - 'talos_options': ['--disable-e10s'], 05:22:54 INFO - 'tests': ['tp5o']}, 05:22:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:54 INFO - 'tests': ['tp5o']}, 05:22:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:54 INFO - 'talos_options': ['--disable-e10s', 05:22:54 INFO - '--xperf_path', 05:22:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:54 INFO - 'tests': ['tp5n']}, 05:22:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:54 INFO - 'talos_options': ['--xperf_path', 05:22:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:54 INFO - 'tests': ['tp5n']}}, 05:22:54 INFO - 'talos.zip': {'path': '', 05:22:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:22:54 INFO - Running post-action listener: _resource_record_post_action 05:22:54 INFO - ##### 05:22:54 INFO - ##### Running create-virtualenv step. 05:22:54 INFO - ##### 05:22:54 INFO - Running pre-action listener: _resource_record_pre_action 05:22:54 INFO - Running main action method: create_virtualenv 05:22:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:22:54 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:22:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:22:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:22:54 INFO - Using real prefix '/usr' 05:22:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:22:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:22:57 INFO - Installing pip.................done. 05:22:57 INFO - Return code: 0 05:22:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:57 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 0x7ff62db8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, '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 0x140a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', '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:22:57 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:22:57 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:22:57 INFO - Using env: {'DISPLAY': ':0', 05:22:57 INFO - 'HOME': '/home/cltbld', 05:22:57 INFO - 'LANG': 'en_US.UTF-8', 05:22:57 INFO - 'LANGUAGE': 'en_US:en', 05:22:57 INFO - 'LOGNAME': 'cltbld', 05:22:57 INFO - 'MAIL': '/var/mail/cltbld', 05:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:57 INFO - 'MOZ_NO_REMOTE': '1', 05:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:57 INFO - 'NO_EM_RESTART': '1', 05:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:57 INFO - 'PWD': '/builds/slave/test', 05:22:57 INFO - 'SHELL': '/bin/bash', 05:22:57 INFO - 'SHLVL': '1', 05:22:57 INFO - 'TERM': 'linux', 05:22:57 INFO - 'TMOUT': '86400', 05:22:57 INFO - 'USER': 'cltbld', 05:22:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', 05:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:57 INFO - '_': '/tools/buildbot/bin/python'} 05:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:57 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:22:57 INFO - Cleaning up... 05:22:57 INFO - Return code: 0 05:22:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:57 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 0x7ff62db8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, '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 0x140a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', '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:22:57 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:22:57 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:22:57 INFO - Using env: {'DISPLAY': ':0', 05:22:57 INFO - 'HOME': '/home/cltbld', 05:22:57 INFO - 'LANG': 'en_US.UTF-8', 05:22:57 INFO - 'LANGUAGE': 'en_US:en', 05:22:57 INFO - 'LOGNAME': 'cltbld', 05:22:57 INFO - 'MAIL': '/var/mail/cltbld', 05:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:57 INFO - 'MOZ_NO_REMOTE': '1', 05:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:57 INFO - 'NO_EM_RESTART': '1', 05:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:57 INFO - 'PWD': '/builds/slave/test', 05:22:57 INFO - 'SHELL': '/bin/bash', 05:22:57 INFO - 'SHLVL': '1', 05:22:57 INFO - 'TERM': 'linux', 05:22:57 INFO - 'TMOUT': '86400', 05:22:57 INFO - 'USER': 'cltbld', 05:22:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', 05:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:57 INFO - '_': '/tools/buildbot/bin/python'} 05:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:57 INFO - Downloading/unpacking psutil>=0.7.1 05:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:22:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:59 INFO - Installing collected packages: psutil 05:22:59 INFO - Running setup.py install for psutil 05:22:59 INFO - building 'psutil._psutil_linux' extension 05:22:59 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:23:00 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:23:00 INFO - building 'psutil._psutil_posix' extension 05:23:00 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:23:00 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:23:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:00 INFO - Successfully installed psutil 05:23:00 INFO - Cleaning up... 05:23:00 INFO - Return code: 0 05:23:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff62db8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, '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 0x140a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', '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:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:23:00 INFO - Using env: {'DISPLAY': ':0', 05:23:00 INFO - 'HOME': '/home/cltbld', 05:23:00 INFO - 'LANG': 'en_US.UTF-8', 05:23:00 INFO - 'LANGUAGE': 'en_US:en', 05:23:00 INFO - 'LOGNAME': 'cltbld', 05:23:00 INFO - 'MAIL': '/var/mail/cltbld', 05:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:00 INFO - 'MOZ_NO_REMOTE': '1', 05:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:00 INFO - 'NO_EM_RESTART': '1', 05:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:00 INFO - 'PWD': '/builds/slave/test', 05:23:00 INFO - 'SHELL': '/bin/bash', 05:23:00 INFO - 'SHLVL': '1', 05:23:00 INFO - 'TERM': 'linux', 05:23:00 INFO - 'TMOUT': '86400', 05:23:00 INFO - 'USER': 'cltbld', 05:23:00 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', 05:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:00 INFO - '_': '/tools/buildbot/bin/python'} 05:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:23: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:23: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:23: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:23: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:23: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:23: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:23:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:23:02 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:23:02 INFO - Installing collected packages: mozsystemmonitor 05:23:02 INFO - Running setup.py install for mozsystemmonitor 05:23:02 INFO - Successfully installed mozsystemmonitor 05:23:02 INFO - Cleaning up... 05:23:02 INFO - Return code: 0 05:23:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:23:02 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:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:02 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:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:02 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 0x7ff62db8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, '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 0x140a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', '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:23:02 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:23:02 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:23:02 INFO - Using env: {'DISPLAY': ':0', 05:23:02 INFO - 'HOME': '/home/cltbld', 05:23:02 INFO - 'LANG': 'en_US.UTF-8', 05:23:02 INFO - 'LANGUAGE': 'en_US:en', 05:23:02 INFO - 'LOGNAME': 'cltbld', 05:23:02 INFO - 'MAIL': '/var/mail/cltbld', 05:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:02 INFO - 'MOZ_NO_REMOTE': '1', 05:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:02 INFO - 'NO_EM_RESTART': '1', 05:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:02 INFO - 'PWD': '/builds/slave/test', 05:23:02 INFO - 'SHELL': '/bin/bash', 05:23:02 INFO - 'SHLVL': '1', 05:23:02 INFO - 'TERM': 'linux', 05:23:02 INFO - 'TMOUT': '86400', 05:23:02 INFO - 'USER': 'cltbld', 05:23:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', 05:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:02 INFO - '_': '/tools/buildbot/bin/python'} 05:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:23:02 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:23:02 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:23:02 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:23:02 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:23:02 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:23:02 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:23:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:23:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:23:04 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:23:04 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:23:04 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:23:04 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:23:04 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:23:04 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:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:23:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:05 INFO - Downloading docopt-0.6.1.tar.gz 05:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:23:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:23:05 INFO - Running setup.py install for blobuploader 05:23:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:23:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:23:05 INFO - Running setup.py install for requests 05:23:05 INFO - Running setup.py install for docopt 05:23:06 INFO - Successfully installed blobuploader requests docopt 05:23:06 INFO - Cleaning up... 05:23:06 INFO - Return code: 0 05:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:06 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 0x7ff62db8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, '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 0x140a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', '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:23:06 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:23:06 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:23:06 INFO - Using env: {'DISPLAY': ':0', 05:23:06 INFO - 'HOME': '/home/cltbld', 05:23:06 INFO - 'LANG': 'en_US.UTF-8', 05:23:06 INFO - 'LANGUAGE': 'en_US:en', 05:23:06 INFO - 'LOGNAME': 'cltbld', 05:23:06 INFO - 'MAIL': '/var/mail/cltbld', 05:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:06 INFO - 'MOZ_NO_REMOTE': '1', 05:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:06 INFO - 'NO_EM_RESTART': '1', 05:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:06 INFO - 'PWD': '/builds/slave/test', 05:23:06 INFO - 'SHELL': '/bin/bash', 05:23:06 INFO - 'SHLVL': '1', 05:23:06 INFO - 'TERM': 'linux', 05:23:06 INFO - 'TMOUT': '86400', 05:23:06 INFO - 'USER': 'cltbld', 05:23:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', 05:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:06 INFO - '_': '/tools/buildbot/bin/python'} 05:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:06 INFO - Running setup.py (path:/tmp/pip-1MKzim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:06 INFO - Running setup.py (path:/tmp/pip-v3imYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:06 INFO - Running setup.py (path:/tmp/pip-2Br3HY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:06 INFO - Running setup.py (path:/tmp/pip-Ta475U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:06 INFO - Running setup.py (path:/tmp/pip-GbQvEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:06 INFO - Running setup.py (path:/tmp/pip-DVr7k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:06 INFO - Running setup.py (path:/tmp/pip-Byb9b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:06 INFO - Running setup.py (path:/tmp/pip-sYpotG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:06 INFO - Running setup.py (path:/tmp/pip-30UfIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:06 INFO - Running setup.py (path:/tmp/pip-3tiSOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:07 INFO - Running setup.py (path:/tmp/pip-f2e26t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:07 INFO - Running setup.py (path:/tmp/pip-dFmHtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:07 INFO - Running setup.py (path:/tmp/pip-L0ogM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:07 INFO - Running setup.py (path:/tmp/pip-kKJAbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:07 INFO - Running setup.py (path:/tmp/pip-How6Lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:07 INFO - Running setup.py (path:/tmp/pip-YisCVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:07 INFO - Running setup.py (path:/tmp/pip-Qrz6Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:23:07 INFO - Running setup.py install for manifestparser 05:23:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for mozcrash 05:23:07 INFO - Running setup.py install for mozdebug 05:23:07 INFO - Running setup.py install for mozdevice 05:23:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for mozfile 05:23:08 INFO - Running setup.py install for mozhttpd 05:23:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Running setup.py install for mozinfo 05:23:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Running setup.py install for mozInstall 05:23:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Running setup.py install for mozleak 05:23:08 INFO - Running setup.py install for mozlog 05:23:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Running setup.py install for moznetwork 05:23:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Running setup.py install for mozprocess 05:23:08 INFO - Running setup.py install for mozprofile 05:23:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Running setup.py install for mozrunner 05:23:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:23:09 INFO - Running setup.py install for mozscreenshot 05:23:09 INFO - Running setup.py install for moztest 05:23:09 INFO - Running setup.py install for mozversion 05:23:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:23:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:23:09 INFO - Cleaning up... 05:23:09 INFO - Return code: 0 05:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:09 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 0x7ff62db8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, '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 0x140a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', '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:23:09 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:23:09 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:23:09 INFO - Using env: {'DISPLAY': ':0', 05:23:09 INFO - 'HOME': '/home/cltbld', 05:23:09 INFO - 'LANG': 'en_US.UTF-8', 05:23:09 INFO - 'LANGUAGE': 'en_US:en', 05:23:09 INFO - 'LOGNAME': 'cltbld', 05:23:09 INFO - 'MAIL': '/var/mail/cltbld', 05:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:09 INFO - 'MOZ_NO_REMOTE': '1', 05:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:09 INFO - 'NO_EM_RESTART': '1', 05:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:09 INFO - 'PWD': '/builds/slave/test', 05:23:09 INFO - 'SHELL': '/bin/bash', 05:23:09 INFO - 'SHLVL': '1', 05:23:09 INFO - 'TERM': 'linux', 05:23:09 INFO - 'TMOUT': '86400', 05:23:09 INFO - 'USER': 'cltbld', 05:23:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', 05:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:09 INFO - '_': '/tools/buildbot/bin/python'} 05:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:09 INFO - Running setup.py (path:/tmp/pip-HzC4df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:09 INFO - Running setup.py (path:/tmp/pip-7LcuPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:09 INFO - Running setup.py (path:/tmp/pip-tykdMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:09 INFO - Running setup.py (path:/tmp/pip-f9YrBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:09 INFO - Running setup.py (path:/tmp/pip-SxUKgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:09 INFO - Running setup.py (path:/tmp/pip-h4lbtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:09 INFO - Running setup.py (path:/tmp/pip-OEVF4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:10 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:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:10 INFO - Running setup.py (path:/tmp/pip-LXmoYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:10 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:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:10 INFO - Running setup.py (path:/tmp/pip-DHr8Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:10 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:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:10 INFO - Running setup.py (path:/tmp/pip-ivzyRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:10 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:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:10 INFO - Running setup.py (path:/tmp/pip-kY_gS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:10 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:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:10 INFO - Running setup.py (path:/tmp/pip-jBQSVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:10 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:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:10 INFO - Running setup.py (path:/tmp/pip-sJWhH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:10 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:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:10 INFO - Running setup.py (path:/tmp/pip-JKgXmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:10 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:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:10 INFO - Running setup.py (path:/tmp/pip-Vi4mCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:10 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:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:10 INFO - Running setup.py (path:/tmp/pip-1MHus4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:10 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:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:10 INFO - Running setup.py (path:/tmp/pip-ZaTGlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:10 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:23:10 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:23:10 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:23:10 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:23:10 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:23:10 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:23:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:12 INFO - Downloading blessings-1.6.tar.gz 05:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:23:12 INFO - Installing collected packages: blessings 05:23:12 INFO - Running setup.py install for blessings 05:23:12 INFO - Successfully installed blessings 05:23:12 INFO - Cleaning up... 05:23:12 INFO - Return code: 0 05:23:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:13 INFO - Reading from file tmpfile_stdout 05:23:13 INFO - Current package versions: 05:23:13 INFO - argparse == 1.2.1 05:23:13 INFO - blessings == 1.6 05:23:13 INFO - blobuploader == 1.2.4 05:23:13 INFO - docopt == 0.6.1 05:23:13 INFO - manifestparser == 1.1 05:23:13 INFO - mozInstall == 1.12 05:23:13 INFO - mozcrash == 0.17 05:23:13 INFO - mozdebug == 0.1 05:23:13 INFO - mozdevice == 0.48 05:23:13 INFO - mozfile == 1.2 05:23:13 INFO - mozhttpd == 0.7 05:23:13 INFO - mozinfo == 0.9 05:23:13 INFO - mozleak == 0.1 05:23:13 INFO - mozlog == 3.1 05:23:13 INFO - moznetwork == 0.27 05:23:13 INFO - mozprocess == 0.22 05:23:13 INFO - mozprofile == 0.28 05:23:13 INFO - mozrunner == 6.11 05:23:13 INFO - mozscreenshot == 0.1 05:23:13 INFO - mozsystemmonitor == 0.0 05:23:13 INFO - moztest == 0.7 05:23:13 INFO - mozversion == 1.4 05:23:13 INFO - psutil == 3.1.1 05:23:13 INFO - requests == 1.2.3 05:23:13 INFO - wsgiref == 0.1.2 05:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:13 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 0x7ff62db8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, '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 0x140a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', '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:23:13 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:23:13 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:23:13 INFO - Using env: {'DISPLAY': ':0', 05:23:13 INFO - 'HOME': '/home/cltbld', 05:23:13 INFO - 'LANG': 'en_US.UTF-8', 05:23:13 INFO - 'LANGUAGE': 'en_US:en', 05:23:13 INFO - 'LOGNAME': 'cltbld', 05:23:13 INFO - 'MAIL': '/var/mail/cltbld', 05:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:13 INFO - 'MOZ_NO_REMOTE': '1', 05:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:13 INFO - 'NO_EM_RESTART': '1', 05:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:13 INFO - 'PWD': '/builds/slave/test', 05:23:13 INFO - 'SHELL': '/bin/bash', 05:23:13 INFO - 'SHLVL': '1', 05:23:13 INFO - 'TERM': 'linux', 05:23:13 INFO - 'TMOUT': '86400', 05:23:13 INFO - 'USER': 'cltbld', 05:23:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', 05:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:13 INFO - '_': '/tools/buildbot/bin/python'} 05:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 INFO - Cleaning up... 05:23:13 INFO - Return code: 0 05:23:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:13 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 0x7ff62db8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, '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 0x140a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', '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:23:13 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:23:13 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:23:13 INFO - Using env: {'DISPLAY': ':0', 05:23:13 INFO - 'HOME': '/home/cltbld', 05:23:13 INFO - 'LANG': 'en_US.UTF-8', 05:23:13 INFO - 'LANGUAGE': 'en_US:en', 05:23:13 INFO - 'LOGNAME': 'cltbld', 05:23:13 INFO - 'MAIL': '/var/mail/cltbld', 05:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:13 INFO - 'MOZ_NO_REMOTE': '1', 05:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:13 INFO - 'NO_EM_RESTART': '1', 05:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:13 INFO - 'PWD': '/builds/slave/test', 05:23:13 INFO - 'SHELL': '/bin/bash', 05:23:13 INFO - 'SHLVL': '1', 05:23:13 INFO - 'TERM': 'linux', 05:23:13 INFO - 'TMOUT': '86400', 05:23:13 INFO - 'USER': 'cltbld', 05:23:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', 05:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:13 INFO - '_': '/tools/buildbot/bin/python'} 05:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:13 INFO - Downloading/unpacking jsonschema 05:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:23:15 INFO - Downloading/unpacking functools32 (from jsonschema) 05:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:23:15 INFO - warning: no files found matching '*.txt' 05:23:15 INFO - no previously-included directories found matching 'build' 05:23:15 INFO - no previously-included directories found matching 'dist' 05:23:15 INFO - no previously-included directories found matching '.git*' 05:23:15 INFO - Installing collected packages: jsonschema, functools32 05:23:15 INFO - Running setup.py install for functools32 05:23:15 INFO - warning: no files found matching '*.txt' 05:23:15 INFO - no previously-included directories found matching 'build' 05:23:15 INFO - no previously-included directories found matching 'dist' 05:23:15 INFO - no previously-included directories found matching '.git*' 05:23:15 INFO - Successfully installed jsonschema functools32 05:23:15 INFO - Cleaning up... 05:23:15 INFO - Return code: 0 05:23:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:23: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:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:15 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 0x7ff62db8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, '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 0x140a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', '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:23:15 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:23:15 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:23:15 INFO - Using env: {'DISPLAY': ':0', 05:23:15 INFO - 'HOME': '/home/cltbld', 05:23:15 INFO - 'LANG': 'en_US.UTF-8', 05:23:15 INFO - 'LANGUAGE': 'en_US:en', 05:23:15 INFO - 'LOGNAME': 'cltbld', 05:23:15 INFO - 'MAIL': '/var/mail/cltbld', 05:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:15 INFO - 'MOZ_NO_REMOTE': '1', 05:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:15 INFO - 'NO_EM_RESTART': '1', 05:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:15 INFO - 'PWD': '/builds/slave/test', 05:23:15 INFO - 'SHELL': '/bin/bash', 05:23:15 INFO - 'SHLVL': '1', 05:23:15 INFO - 'TERM': 'linux', 05:23:15 INFO - 'TMOUT': '86400', 05:23:15 INFO - 'USER': 'cltbld', 05:23:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', 05:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:15 INFO - '_': '/tools/buildbot/bin/python'} 05:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:16 INFO - Downloading/unpacking flake8 05:23:16 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:23:16 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:23:16 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:23:16 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:23:16 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:23:16 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:23:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:23:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:23:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:23:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:23:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:23:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:23:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:23:18 INFO - no previously-included directories found matching 'docs/_build' 05:23:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:23:18 INFO - Running setup.py install for pep8 05:23:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:23:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:23:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:23:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:23:19 INFO - no previously-included directories found matching 'docs/_build' 05:23:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:23:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:23:19 INFO - Cleaning up... 05:23:19 INFO - Return code: 0 05:23:19 INFO - Running post-action listener: _resource_record_post_action 05:23:19 INFO - Running post-action listener: _start_resource_monitoring 05:23:19 INFO - Starting resource monitoring. 05:23:19 INFO - ##### 05:23:19 INFO - ##### Running install step. 05:23:19 INFO - ##### 05:23:19 INFO - Running pre-action listener: _resource_record_pre_action 05:23:19 INFO - Running main action method: install 05:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:19 INFO - Reading from file tmpfile_stdout 05:23:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:23:19 INFO - Reading from file tmpfile_stdout 05:23:19 INFO - Output received: 05:23:19 INFO - Usage: mozinstall [options] installer 05:23:19 INFO - Options: 05:23:19 INFO - -h, --help show this help message and exit 05:23:19 INFO - -d DEST, --destination=DEST 05:23:19 INFO - Directory to install application into. [default: 05:23:19 INFO - "/builds/slave/test"] 05:23:19 INFO - --app=APP Application being installed. [default: firefox] 05:23:19 INFO - mkdir: /builds/slave/test/build/application 05:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:23:36 INFO - Reading from file tmpfile_stdout 05:23:36 INFO - Output received: 05:23:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:23:36 INFO - Running post-action listener: _resource_record_post_action 05:23:36 INFO - ##### 05:23:36 INFO - ##### Running run-tests step. 05:23:36 INFO - ##### 05:23:36 INFO - Running pre-action listener: _resource_record_pre_action 05:23:36 INFO - Running main action method: run_tests 05:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:23:36 INFO - Python 2.7.3 05:23:36 INFO - Return code: 0 05:23:36 INFO - grabbing minidump binary from tooltool 05:23:36 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:23:36 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 0x1409410>, '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 0x140a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:23:36 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:23:36 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:23:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:23:36 INFO - Return code: 0 05:23:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:23:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:23:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:23:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:23:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:23:37 INFO - Return code: 0 05:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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:23:37 INFO - Using env: {'DISPLAY': ':0', 05:23:37 INFO - 'HOME': '/home/cltbld', 05:23:37 INFO - 'LANG': 'en_US.UTF-8', 05:23:37 INFO - 'LANGUAGE': 'en_US:en', 05:23:37 INFO - 'LOGNAME': 'cltbld', 05:23:37 INFO - 'MAIL': '/var/mail/cltbld', 05:23:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:23:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:37 INFO - 'MOZ_NO_REMOTE': '1', 05:23:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:37 INFO - 'NO_EM_RESTART': '1', 05:23:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:37 INFO - 'PWD': '/builds/slave/test', 05:23:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:23:37 INFO - 'SHELL': '/bin/bash', 05:23:37 INFO - 'SHLVL': '1', 05:23:37 INFO - 'TERM': 'linux', 05:23:37 INFO - 'TMOUT': '86400', 05:23:37 INFO - 'USER': 'cltbld', 05:23:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972', 05:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:37 INFO - '_': '/tools/buildbot/bin/python'} 05:23:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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:23:37 INFO - mozversion application_buildid: 20160428024229 05:23:37 INFO - mozversion application_changeset: d928d2fde8c71f629774efb5771c2a3084af5d69 05:23:37 INFO - mozversion application_display_name: Nightly 05:23:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:23:37 INFO - mozversion application_name: Firefox 05:23:37 INFO - mozversion application_remotingname: firefox 05:23:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:23:37 INFO - mozversion application_vendor: Mozilla 05:23:37 INFO - mozversion application_version: 49.0a1 05:23:37 INFO - mozversion platform_buildid: 20160428024229 05:23:37 INFO - mozversion platform_changeset: d928d2fde8c71f629774efb5771c2a3084af5d69 05:23:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:23:37 INFO - mozversion platform_version: 49.0a1 05:23:37 INFO - using testdate: 1461846217 05:23:37 INFO - actual date: 1461846217 05:23:37 INFO - starting webserver on 'localhost:58160' 05:23:37 INFO - SUITE-START | Running 2 tests 05:23:37 INFO - TEST-START | dromaeo_css 05:23:37 INFO - operating with platform_type : linux_ 05:23:37 INFO - Initialising browser for dromaeo_css test... 05:23:37 INFO - TEST-INFO | started process 29992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptCQ8I5/profile http://localhost:58160/getInfo.html) 05:23:41 INFO - PROCESS | 29992 | __metrics Screen width/height:1600/1200 05:23:41 INFO - PROCESS | 29992 | colorDepth:24 05:23:41 INFO - PROCESS | 29992 | Browser inner width/height: 1024/697 05:23:41 INFO - PROCESS | 29992 | __metrics 05:23:42 ERROR - PROCESS | 29992 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:23:43 INFO - TEST-INFO | 29992: exit 0 05:23:43 INFO - Browser initialized. 05:23:43 INFO - Running cycle 1/1 for dromaeo_css test... 05:23:43 INFO - TEST-INFO | started process 30075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptCQ8I5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:55 INFO - PROCESS | 30075 | RSS: Main: 154169344 05:23:55 INFO - PROCESS | 30075 | 05:24:46 INFO - PROCESS | 30075 | 1461846286042 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:26:53 INFO - PROCESS | 30075 | Cycle 1(1): loaded http://localhost:58160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58160/tests/dromaeo/cssquery-ext.html) 05:26:54 INFO - PROCESS | 30075 | RSS: Main: 260448256 05:26:54 INFO - PROCESS | 30075 | 05:29:56 INFO - PROCESS | 30075 | Cycle 1(1): loaded http://localhost:58160/tests/dromaeo/cssquery-ext.html (next: http://localhost:58160/tests/dromaeo/cssquery-jquery.html) 05:29:57 INFO - PROCESS | 30075 | RSS: Main: 245121024 05:29:57 INFO - PROCESS | 30075 | 05:32:59 INFO - PROCESS | 30075 | Cycle 1(1): loaded http://localhost:58160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58160/tests/dromaeo/cssquery-mootools.html) 05:32:59 INFO - PROCESS | 30075 | RSS: Main: 242184192 05:32:59 INFO - PROCESS | 30075 | 05:36:01 INFO - PROCESS | 30075 | Cycle 1(1): loaded http://localhost:58160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58160/tests/dromaeo/cssquery-prototype.html) 05:36:02 INFO - PROCESS | 30075 | RSS: Main: 228798464 05:36:02 INFO - PROCESS | 30075 | 05:39:05 INFO - PROCESS | 30075 | Cycle 1(1): loaded http://localhost:58160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58160/tests/dromaeo/cssquery-yui.html) 05:39:05 INFO - PROCESS | 30075 | RSS: Main: 220393472 05:39:05 INFO - PROCESS | 30075 | 05:42:08 INFO - PROCESS | 30075 | Cycle 1(1): loaded http://localhost:58160/tests/dromaeo/cssquery-yui.html (next: http://localhost:58160/tests/dromaeo/cssquery-dojo.html) 05:42:08 INFO - PROCESS | 30075 | RSS: Main: 275095552 05:42:08 INFO - PROCESS | 30075 | 05:42:08 INFO - PROCESS | 30075 | __start_tp_report 05:42:08 INFO - PROCESS | 30075 | _x_x_mozilla_page_load 05:42:08 INFO - PROCESS | 30075 | _x_x_mozilla_page_load_details 05:42:08 INFO - PROCESS | 30075 | |i|pagename|runs| 05:42:08 INFO - PROCESS | 30075 | |0;dojo.html;3043.8173709577413;3071.95392069119;3082.6454957679875;3100.7364374028207;3101.9534706979393;5293.179557168635;5332.520073193412;5399.865003374917;5425.2404663347115;5429.4027656957705;5339.813106541272;5357.223202635615;5403.405625381205;5473.67157970522;5481.588880833933;4880.877978050542;4904.215325547913;4917.557419832215;4937.950620493785;5092.363454568179;5004.099262132815;5030.798768049273;5069.2649565812935;5071.695698258098;5077.162268225757;4802.183628783097;4870.09903167915;4928.310036594879;4978.452370239271;5036.043151801183;4885.193942999401;4896.265560165968;4896.681715688469;4929.309896614477;4929.359183306183;4760.357351757503;4855.44162421319;4884.267359896008;4897.51024897511;4909.680870743426;5303.761330740126;5320;5328.786848526093;5348.866278343034;5398.757055932492;5746.195532625436;5753.798617048383;5775.1337299405;5778.711064446761;5781.855453613652;5614.017546929271;5684.687342196177;5720.942790572124;5799.855003624901;5810.477057064884;5420.9971155336;5444.292242008553;5445.591580631469;5447.046766815792;5454.427285135083;5911;5921.881562368814;5928.703564821742;5928.940710592925;5930.347661757203;5491.533219676292;5641.492265696107;5695;5706.42935706426;5721.742521586539;5767.904098221325;5773.538116950634;5778.595498315078;5781;5786.681732504669;5684.54523638108;5705.828825135252;5710.229119068873;5710.3433105193435;5717;5489.231507588941;5622.100463925753;5707.600467967285;5733;5753.108268218349;4347.652187824967;4350;4352.847650332224;4357.694961352739;4390.62679672225;3810.2189051244427;3868.1296708240984;3872.3223435898603;3912.6478616924046;3921.784301863368;5443.346798384219;5483.670979741229;5492.835214943558;5543.556515478752;5547.944520554743;5716.228309178207;5725.08398656213;5725.914111288334;5727.856803579861;5738.139279108167;5308.973455132699;5354.089804733205;5387.8125263173415;5400.864978375572;5454;4928.778204980785;4947.035328110984;4947.158982972904;4956.851294461172;4990.50094990498;5968.731407086605;5981.5214782817275;5985.6408615483215;5987.341392446828;5991.670458124845;5624.409437009055;5778.624389414758;5790.189373487631;5836.474717275466;5889.528837692888;5952.672603006876;5970.58205925581;5974.551908606785;5978.103284507359;5991.310999235144;5685.886282274414;5687.800926967702;5688.203651488878;5693.373728889902;5699.487046165699;5619.831405057855;5766.077427611562;5771.711414429178;5819.592628515963;5862.501687356623;5599.860003499945;5601.579881508985;5605.663660180402;5606.24315717373;5607.80372686954;5539.806106786243;5574.108142697311;5583.944160558342;5588.217649529151;5589.161625756169;5225.190095535046;5397.676139431646;5529.723513824212;5537.2524709163745;5585.720713964204;5645.4072322405555;5651.321841379061;5676.7161641918565;5690.430956904276;5704.3725190228215;5388.353397592314;5571.8885622288135;5588.413216612197;5590.608657393944;5595 05:42:08 INFO - PROCESS | 30075 | |1;ext.html;583.4515555377944;631.9715612797423;642.569478449439;662.9701663425149;663.4857985061574;29264.414711705755;37364.25271494569;37990.62009379905;38129.61870381295;38130.618693813056;40195.39706904399;40861.18277634445;40899.59100408995;40921.18157636853;40925.18149637005;8466.492010479376;8664.956675216616;8693.69572064978;8693.913060869405;8695.95652021739;8483.74548763538;8623;8657.177568131017;8662.783430414258;8666.696665616704;8844.911550884473;8893.95553022234;8912.287017038621;8916.108389161065;8925;8731.781705457352;8835;8853.911460885438;8862.601182946783;8866.778330541723;8671.869921951176;8776;8787.868181977276;8789.472631642122;8794.384393092487;41213;41317;41618.37572436416;41733.58266417358;41931.580684193075;3543.1496440854266;3548.946765798515;3578.946315805239;3709.6290370962956;4145.689073319513;28799.712002880122;29533.261668458246;29588.112356629335;29754.553681694793;29933.850330748424;4291.635211007068;4318.5465526119615;4342.587454191878;4380.408644832939;4430.490493593245;330918;332296;333166;334906;335905;47526;62492.68753656203;63041.68479157666;63073;63092.369076309566;52494.21258681123;53085.46914530882;53842.46157538453;53926.73036634792;53939.19091213635;17787.110644467724;18096.27614895416;18149.27402903869;18152;18173.091345432676;12116.878831211576;12341.197822141532;13743.03798734099;13832.30838458073;13835.169889806644;18569.628607427774;18886.244550217838;18954.336598219274;19028.71456928147;19095.713564296548;6967.477439192081;6986.196587392515;7281.381082607932;7310.744123955636;7324.828027515572;1131.6039386214923;1160.1299025730702;1206.2460961898814;1228.5945637939458;1253.9937300313622;30710.38579228403;30746.538801917988;31080.84459577733;32399.676003240136;32503.51244731331;1084.4631907205983;1125.6960620632547;1132.6941725734005;1190.6070996571111;1196.3599474281218;16882.74675879863;17306.394276200273;17539.386121485688;17557.561060973578;17562.912185439247;492812;501276;501583;502793;503298;57272.42727572671;59110.704446478354;59117.40882591205;59121.70439147777;59144.40855591389;1323.2854258700195;1331.2145833958011;1375.2229990055587;1420.4673247532176;1445.8554144585457;22340.664890026987;30999.22107491647;31626.36747265088;31890.36219275555;32395.51406728948;48710.26934596055;50175.4842064216;50277.24584131314;50310.245346319105;51680.224796628834;321984;323992;325353;325424;327746;32885.17787055343;36514;37811.62188378081;38455.423168653055;40217.79891100526;41923;43143.56856431396;43201.35197972096;43204.78397607992;43863.34204986991;36729.63270367369;36905.63094369022;37089.25821483501;37196.81401592975;38190.427143592315;38759.22481550297;39304;39310.41034384544;39539.209215816096;40246;40701;40837.591624083376;41229.793851031754;41245;41276.793616031726;33717.49423758694;34819.82590087033;35930.28139437249;36205.0948726284;36246.456303156;26730;27274.45451091007;27316.45367092687;27417;27702.168934931986 05:42:08 INFO - PROCESS | 30075 | |2;jquery.html;387.41693750904886;397.87665823594705;398.58547111004555;401.46805482735385;413.4067612975381;14108.647283817909;15699.686006279868;17458;18177.63644727105;18285.542861428454;17576.736348954775;18096.81903180968;18414.35549755759;18434.446966591022;18436.262549498006;5048.066107770056;5163.302954101205;5201.635885488017;5212.218167274901;5215;3964.167524819791;5129.12804823181;5182.378114626231;5522.751476183561;5803.361630220694;5699.088145896658;5780.0751879699255;5799.333076696192;5803.2165657636315;5806.1000544915605;5491.203775452557;5733.369329373765;5738.569607279429;5743.081107022877;5767.452092051249;5542.501174894279;5545.916811247795;5550.583706222009;5551.972885016285;5562.666240025571;19854.40436786899;21032;21035.579288414145;21196.152153913827;22784.77215227843;2186.4752459409788;2235.642297232435;2261.3216035189375;2403.579373609611;2417.830751847371;9635.662751803724;9670.90329096714;9692.321537492378;9919.603215871357;11800.52797888092;1906.7711874575002;1990.3431867483696;2016.8084032016934;2034.6541088014924;2079.199508189343;77158;82775.17224827735;83076;83111;83597.58201208955;10617.203709721802;10690;10714.946425267979;10845.51195196218;10851.131909447226;14548.127112373291;14704.779428308584;14749.926250368679;14848;14896.776548351783;8053.677852885936;8245.13426090264;8362.205590468895;8438.198371154731;8542.316614670935;8093.797655058553;8148.633311500997;8261.586920653943;8347.916520834835;8426.915730842737;4537.727736335831;4590;4636.281376386665;4651.976740116278;4654.394928659252;1953.8827670339824;1993.1728332742039;2006.618742438932;2019.899005049771;2029.594081183769;1026.384169498295;1042.3224903812581;1058.5659879449388;1077.2997551591527;1079.7462596289865;18561.44315670532;18946.242150313832;19330;19352.225910963403;19480.805191948184;1005.1456262177092;1024.9641262555774;1040.6149724601946;1091.6414704994545;1092.159037541089;10450.320729152581;10680;10957.12343012557;11000.779984400428;11012.229143959847;468996;492731;496827;518308;524345;71477;82766;85506;93084.53457732667;99585;1001.4577550572183;1002.368507840056;1018.2719355660738;1025.7640742629237;1049.3651340938775;17117.74323385175;17185.656286873942;17266.728753442905;17456;17641.558961026076;39102.4134637975;40162;40555;40560.79719601383;40945.59054409418;55606.44393556013;56552.717236413555;56583.15125273207;56626.7168664154;57955;8153;8238.176182381714;8534.146585341416;8553.957230214059;8599.742007739778;11496.597619083292;12652.936735316265;12665.620031399072;12712.618621441372;12932.935335323264;10599.417032063311;10848.132149427869;10878.238523303293;10978;11096.056835169102;10613.522391492555;10717;10935.671929842118;11112.277701949348;11214.327140371604;10652.82818889906;10873.782524349626;10958.890411095786;11129.83305250438;11201.71995700114;8128;8264.545450000307;8300.294474969694;8390.328773697967;8522.914770852212;8214.753557393287;9765.511724413893;10489.265751397328;10689.839652405064;11071.83392249133 05:42:08 INFO - PROCESS | 30075 | |3;mootools.html;1363.291088633911;1538.846115388461;1540.8459154084594;1745.1099939031099;1875.56861921758;7077.150741910965;8069.636866341014;8329.37529685273;8341.91658083419;8354.081051084384;8111.91888081119;8232.629531671075;8252.752417427471;8265.09084000761;8267;1982.0981453438724;2280.6579013147993;2291.942701432469;2325.6744055832196;2348.5537747827857;2292.1519037955895;2312.387217387394;2313.456337760625;2313.571989181998;2325.0351104291785;2315.8842057897123;2316.444053427174;2353.011735071274;2356.0340260493203;2358.1157066100213;1910.1308904448442;2179.5422961178174;2240.675102110185;2247.1460844878843;2275.340151356105;2243.652233903731;2245.259064508708;2267.0705010945435;2267.682524446579;2271.738750043733;8175.672973081069;8239;8263.091059983397;8267.255946964802;8280.668773249123;4995.850124496271;5123.077845987721;5123.897522049539;5130.871728206787;5163.225516172567;3222.8066316021113;3266.70599646033;3313.8177400242976;3330.0675810773023;3346.9497957530657;1039.4127318065268;1042.2495803021811;1065.648336049102;1067.3809190669392;1082.1234799812098;11521.654350369503;11552;11558.884411155948;11567.652970410902;11578.073754099652;4466.218411777926;4563;4644.442666879996;4652.1626107300335;4657.74382408964;9811.362261452983;9812.264080194014;9815.656452024145;9831.852522212173;9832.262580306506;5113.3097031900215;5218.191180367049;5249.212618107238;5263.131583288791;5264.236685680555;4108.096218831853;4624.722516649012;4725.740084295397;4759.857204283877;4780.043991201774;3815.42768584709;3837.4052021936645;3904.863329783501;3905.4922860028014;3947.8420863165725;1261.0794120292237;1267.461328935199;1278.3161008860216;1286.298967062953;1293.1465232946211;1008.510872226984;1040.1003132290514;1041.3699711674478;1063.781924705449;1066.7866426714534;5863.530917526673;5924.6149000314845;5986.5210783137245;6045.617200122904;6168.753249870045;454.72489144068027;458.48649512545495;462.1288870479104;464.7281340415827;466.2400287531302;3937.665298449607;3942.8619998299923;3971.3645816669195;3995.260876737813;4175.269327867611;9123.224525915239;9563.043695630382;9572.664956726481;9665.71002869915;9685;9506.334556580972;9569.665061722806;9575.904240957641;9579.856302155473;9601.32790704644;7769.92230077692;7869.960650196713;7882.842343153105;7953.642086106023;7970.442069055226;5700.458456446631;5883.264591926009;6011.7595296187665;6031.4270144336215;6046.062860256668;9689.806203876024;9756.414615123116;9807.460589667637;9818.263630227619;9892.208623309974;9713.562889670124;9817.214622830299;10006.199504039514;10111.3427627204;10121.746956325856;6424.743010279536;6651.900221496779;6665.466762659073;7513.737019204302;7655.6937722490475;7192.136943566806;8027.317677997436;8273;8292.04641466239;8298.834023319621;7382.741604044048;7421.962890185515;7459.291367320096;7559.395248380227;7568.470207085671;7409.147947986051;7484.401247900264;7567.697292108254;7599.240075992357;7651.846963060819;7020.964895175492;7030.156381234285;7081.327273908971;7098.219195888551;7099.645017749195;5056.241563765465;5226.11156103471;5239.292695486213;5313.54834839043;5352.759125839269;5167.844964651066;5205.271262023244;5216.347956505437;5283.2075188722;5294 05:42:08 INFO - PROCESS | 30075 | |4;prototype.html;327.80331800919436;334.30464633562184;339.14535370865406;340.6457284424199;341.27308832187435;5147.742612869356;5157.30376399186;5184.3778746550415;5199.428062913086;5230.267762513246;5058.241263810431;5088.9313244218665;5111.335526381575;5130.281760553526;5144.485551444854;3873.5351757789035;3930.94103588445;3994.720369574131;4038.6970977176684;4091.9795401023102;4052.3111071117983;4074.348104303312;4081.3266560710113;4084.7957602119923;4111.280525907954;4047.1467615331267;4050.453188819501;4051.858184963527;4052.250333688277;4082.8159833648356;3864.420336949466;3921.450996860442;4064.6992962252093;4071.2671719090554;4097.97951010246;3580.5882323532865;3597.4963505109304;3602.171500554861;3623.873164439232;3642.5811031731423;4856.951430485685;4919.278252611593;4930.33440485537;4941.431735350445;4980.850574482772;4505.887352816173;4565.155446242456;4609.170349337118;4618.769061546909;4622.791974361162;5308.681479111266;5316.3354580677415;5322.627416080876;5335.493128152819;5343.438938911436;3933.311670457687;3942.231264903345;3943.881683549498;3944.7830369329677;3968.0873399118077;5423.159410291371;5475.1110866750905;5528.668279903259;5530.446955304437;5578.24693666358;3986.7607943522903;3997.300472417315;4007.919841603152;4015.3976903464713;4019.0354314964784;4071.3485842265095;4075.1645912587846;4077.918441631151;4082.8775136745944;4096.836126554964;4491.46102467706;4577.427821522309;4604.654650901196;4607.424071991001;4651.4418269807165;5324.254604355393;5348.171033489815;5355.464453554613;5359.410464848864;5377.973110134424;1472.7938088667595;1485.9628509287354;1487.6578386970841;1493.1559523987867;1493.7759336099455;965.7344230336713;1003.8694969654044;1019.3883669798211;1035.8290882004385;1048.9318194317345;5483.232347471358;5496.367917689437;5535.086710692691;5545.223668686387;5545.944540554624;5835.79574714883;5848.502877255481;5862.736176872051;5863.589548731633;5883.823485295448;5388.784448622089;5524.861878452991;5532.5573954083575;5564.998300305902;5574.554035677136;3103.3017571046335;3117.1116231873807;3120.2043478912733;3124.4535703401657;3125.6405513366253;5892.351841297454;6028.156058151862;6031;6040.275166979903;6071.848203794941;5976.61152025117;5978.491828194652;6006.819795406145;6016.669083200379;6025.156478092983;5996.940030599638;6006.546235914367;6017.428344307371;6023.397660234029;6058.848528786815;5355.866103347447;5594.580406469449;5626.156076588544;5635.830925072254;5780.248567686174;5538.421549858271;5547.611667183259;5553.416891226525;5559.2217089606675;5567.331920169606;5631.774729010794;5756.30924289088;5787.3378246007305;5787.594868359174;5806.593538452268;3951.782651954055;3955.268275369066;3962.791348638693;3969.3450580653866;3980.90047748797;5561.555075593862;5607.80372686954;5613.578981576316;5625.746841392229;5641.435856414326;5231.189165679326;5443.972780136074;5451.318585176853;5459.727013649381;5497.8075767347955;5426.213199086032;5433.125571677765;5445.346558413015;5457.263269458731;5479.671219726829;5097.974510127426;5195.116830138961;5326.7336633167415;5352.84913743547;5384.9192262116885;5474.945250547444;5501.009818232596;5501.944980550144;5508.338999320107;5510.724463776875;5370.845268267341;5373.408925018167;5375.381831089475;5396.109641909041;5399.055165346127 05:42:08 INFO - PROCESS | 30075 | |5;yui.html;782.4092809928505;818.4230117766974;855.7304449098533;856.0775540641313;863.5941107679389;14398.712025759492;14915.25423728812;14925.626859328522;15007.624809379771;15012.924935375322;13520.459181632723;13547.390367433465;13664;13675.93162034191;13687.384067716952;676.5298117808126;787.7597332813518;813.947093438926;815.9347252219808;826.305903041445;811.5860910935406;817.9713710020151;819.4059307002406;821.3183058061824;821.5809936932147;862.1421685423013;869.8564736818417;870.3428911172088;870.9346798990069;871.6949067826273;711.8967749676294;728.624758249502;729;834.453433001379;861.418542483824;627.3475585391187;627.8116565030473;628.0296941225818;628.1739512540994;628.9779857704958;14178.858211417857;14225.78661320081;14229.715405691828;14246.145231286157;14280.143191408548;13330.466781328736;14256.429742810275;14457.566273011826;14457.710845783131;14536.127832329988;11599.710007249801;11745.530178792838;11795;11935.104867135;11993.220440671328;3889.8444062237477;3920.941185882214;3936.193080418507;4004.4193591929006;4015.217032678629;54120.91758164854;54524.18213726797;54534.181987270225;54798.53406596713;57648;10758.784824303626;10971;10999.285046471954;11129.241039324323;11153.72115697114;20525.38423847287;20566.58866822655;20622.27822026222;20712.792872071386;20761.480962976046;8442.915570844212;8476.49141051539;8616.181462761153;8775.824483510294;8894.155055269739;4682.695624784378;4810.807567697253;4819.421669399624;4834.927476087862;4988.052270068675;3400.506926495644;3491.4239150539875;3513.5256740340237;3517.82410879455;3522.5420695309444;642.6947200079925;655.4395991427357;657.139147716493;666.2970566052763;667.3826710292959;747.4058123791599;773.7523992322402;793.3098204562068;802.4463120446873;814.0353680888167;8916.420432671855;9780.55987480565;9804.705858824247;9844.458554779556;9889.10998010168;750.9624518774149;757.5227606607801;770.0912922751096;777.7005852746734;796.2395911904117;4735.195016847144;4985.700857948535;5044.369453818273;5091.287219789232;5107.412647545506;64816.35183648103;65968.67015664987;67233.32766672368;67511.66244168748;67675.32324676789;58063.70968145132;58240.708796456594;59196;59607.10589341163;60054.399456005754;53282;53866.46133538614;54024.729876350364;54361.45638543643;54463;9758.219342452729;9781.217502599917;9878.30851840393;9879.308448408543;10154.847677284994;35087.12282192965;35604.64395356117;36044;36202.4569631461;36481.45277820888;44994.550054500345;46663.53336466727;46877.29684054674;47097.529024709314;47114;12247.08146888969;12251.509939602316;12334.136610437183;12341.259524428562;12586.370681466073;13630.014166972336;13977.818374212871;14149.151050936976;14150.646233844236;14428.495002675276;8492.761796431816;12619.30593817349;12792.74414511723;13336.466541338626;13392.397342119433;12413.503459861504;12922.806157907828;12990.545330913372;13133.146345487512;13446.663833404244;12493.750124997267;12742.936285318514;12802.423890925116;13146.014048946176;13750.931245343709;10844.728881778019;11237.3257604544;11261.493232804707;11289.491972861077;11441.828372574251;10964.396958167377;11039.944800275947;11117.16621253393;11179.944100279447;11268.83096753533 05:42:08 INFO - PROCESS | 30075 | __end_tp_report 05:42:08 INFO - PROCESS | 30075 | __start_cc_report 05:42:08 INFO - PROCESS | 30075 | _x_x_mozilla_cycle_collect,911 05:42:08 INFO - PROCESS | 30075 | __end_cc_report 05:42:08 INFO - PROCESS | 30075 | __startTimestamp1461847328378__endTimestamp 05:42:08 INFO - PROCESS | 30075 | 05:42:08 INFO - PROCESS | 30075 | ------- Summary: start ------- 05:42:08 INFO - PROCESS | 30075 | Number of tests: 6 05:42:08 INFO - PROCESS | 30075 | 05:42:08 INFO - PROCESS | 30075 | [#0] dojo.html Cycles:165 Average:5345.65 Median:5547.94 stddev:611.84 (11.0%) stddev-sans-first:586.46 05:42:08 INFO - PROCESS | 30075 | Values: 3043.8 3072.0 3082.6 3100.7 3102.0 5293.2 5332.5 5399.9 5425.2 5429.4 5339.8 5357.2 5403.4 5473.7 5481.6 4880.9 4904.2 4917.6 4938.0 5092.4 5004.1 5030.8 5069.3 5071.7 5077.2 4802.2 4870.1 4928.3 4978.5 5036.0 4885.2 4896.3 4896.7 4929.3 4929.4 4760.4 4855.4 4884.3 4897.5 4909.7 5303.8 5320.0 5328.8 5348.9 5398.8 5746.2 5753.8 5775.1 5778.7 5781.9 5614.0 5684.7 5720.9 5799.9 5810.5 5421.0 5444.3 5445.6 5447.0 5454.4 5911.0 5921.9 5928.7 5928.9 5930.3 5491.5 5641.5 5695.0 5706.4 5721.7 5767.9 5773.5 5778.6 5781.0 5786.7 5684.5 5705.8 5710.2 5710.3 5717.0 5489.2 5622.1 5707.6 5733.0 5753.1 4347.7 4350.0 4352.8 4357.7 4390.6 3810.2 3868.1 3872.3 3912.6 3921.8 5443.3 5483.7 5492.8 5543.6 5547.9 5716.2 5725.1 5725.9 5727.9 5738.1 5309.0 5354.1 5387.8 5400.9 5454.0 4928.8 4947.0 4947.2 4956.9 4990.5 5968.7 5981.5 5985.6 5987.3 5991.7 5624.4 5778.6 5790.2 5836.5 5889.5 5952.7 5970.6 5974.6 5978.1 5991.3 5685.9 5687.8 5688.2 5693.4 5699.5 5619.8 5766.1 5771.7 5819.6 5862.5 5599.9 5601.6 5605.7 5606.2 5607.8 5539.8 5574.1 5583.9 5588.2 5589.2 5225.2 5397.7 5529.7 5537.3 5585.7 5645.4 5651.3 5676.7 5690.4 5704.4 5388.4 5571.9 5588.4 5590.6 5595.0 05:42:08 INFO - PROCESS | 30075 | 05:42:08 INFO - PROCESS | 30075 | [#1] ext.html Cycles:180 Average:55050.87 Median:39424.81 stddev:104299.52 (264.6%) stddev-sans-first:104511.94 05:42:08 INFO - PROCESS | 30075 | Values: 583.5 632.0 642.6 663.0 663.5 29264.4 37364.3 37990.6 38129.6 38130.6 40195.4 40861.2 40899.6 40921.2 40925.2 8466.5 8665.0 8693.7 8693.9 8696.0 8483.7 8623.0 8657.2 8662.8 8666.7 8844.9 8894.0 8912.3 8916.1 8925.0 8731.8 8835.0 8853.9 8862.6 8866.8 8671.9 8776.0 8787.9 8789.5 8794.4 41213.0 41317.0 41618.4 41733.6 41931.6 3543.1 3548.9 3578.9 3709.6 4145.7 28799.7 29533.3 29588.1 29754.6 29933.9 4291.6 4318.5 4342.6 4380.4 4430.5 330918.0 332296.0 333166.0 334906.0 335905.0 47526.0 62492.7 63041.7 63073.0 63092.4 52494.2 53085.5 53842.5 53926.7 53939.2 17787.1 18096.3 18149.3 18152.0 18173.1 12116.9 12341.2 13743.0 13832.3 13835.2 18569.6 18886.2 18954.3 19028.7 19095.7 6967.5 6986.2 7281.4 7310.7 7324.8 1131.6 1160.1 1206.2 1228.6 1254.0 30710.4 30746.5 31080.8 32399.7 32503.5 1084.5 1125.7 1132.7 1190.6 1196.4 16882.7 17306.4 17539.4 17557.6 17562.9 492812.0 501276.0 501583.0 502793.0 503298.0 57272.4 59110.7 59117.4 59121.7 59144.4 1323.3 1331.2 1375.2 1420.5 1445.9 22340.7 30999.2 31626.4 31890.4 32395.5 48710.3 50175.5 50277.2 50310.2 51680.2 321984.0 323992.0 325353.0 325424.0 327746.0 32885.2 36514.0 37811.6 38455.4 40217.8 41923.0 43143.6 43201.4 43204.8 43863.3 36729.6 36905.6 37089.3 37196.8 38190.4 38759.2 39304.0 39310.4 39539.2 40246.0 40701.0 40837.6 41229.8 41245.0 41276.8 33717.5 34819.8 35930.3 36205.1 36246.5 26730.0 27274.5 27316.5 27417.0 27702.2 05:42:08 INFO - PROCESS | 30075 | 05:42:08 INFO - PROCESS | 30075 | [#2] jquery.html Cycles:180 Average:28750.63 Median:12523.05 stddev:82449.28 (658.4%) stddev-sans-first:82653.07 05:42:08 INFO - PROCESS | 30075 | Values: 387.4 397.9 398.6 401.5 413.4 14108.6 15699.7 17458.0 18177.6 18285.5 17576.7 18096.8 18414.4 18434.4 18436.3 5048.1 5163.3 5201.6 5212.2 5215.0 3964.2 5129.1 5182.4 5522.8 5803.4 5699.1 5780.1 5799.3 5803.2 5806.1 5491.2 5733.4 5738.6 5743.1 5767.5 5542.5 5545.9 5550.6 5552.0 5562.7 19854.4 21032.0 21035.6 21196.2 22784.8 2186.5 2235.6 2261.3 2403.6 2417.8 9635.7 9670.9 9692.3 9919.6 11800.5 1906.8 1990.3 2016.8 2034.7 2079.2 77158.0 82775.2 83076.0 83111.0 83597.6 10617.2 10690.0 10714.9 10845.5 10851.1 14548.1 14704.8 14749.9 14848.0 14896.8 8053.7 8245.1 8362.2 8438.2 8542.3 8093.8 8148.6 8261.6 8347.9 8426.9 4537.7 4590.0 4636.3 4652.0 4654.4 1953.9 1993.2 2006.6 2019.9 2029.6 1026.4 1042.3 1058.6 1077.3 1079.7 18561.4 18946.2 19330.0 19352.2 19480.8 1005.1 1025.0 1040.6 1091.6 1092.2 10450.3 10680.0 10957.1 11000.8 11012.2 468996.0 492731.0 496827.0 518308.0 524345.0 71477.0 82766.0 85506.0 93084.5 99585.0 1001.5 1002.4 1018.3 1025.8 1049.4 17117.7 17185.7 17266.7 17456.0 17641.6 39102.4 40162.0 40555.0 40560.8 40945.6 55606.4 56552.7 56583.2 56626.7 57955.0 8153.0 8238.2 8534.1 8554.0 8599.7 11496.6 12652.9 12665.6 12712.6 12932.9 10599.4 10848.1 10878.2 10978.0 11096.1 10613.5 10717.0 10935.7 11112.3 11214.3 10652.8 10873.8 10958.9 11129.8 11201.7 8128.0 8264.5 8300.3 8390.3 8522.9 8214.8 9765.5 10489.3 10689.8 11071.8 05:42:08 INFO - PROCESS | 30075 | 05:42:08 INFO - PROCESS | 30075 | [#3] mootools.html Cycles:180 Average:5544.04 Median:5186.56 stddev:3062.52 (59.0%) stddev-sans-first:3054.99 05:42:08 INFO - PROCESS | 30075 | Values: 1363.3 1538.8 1540.8 1745.1 1875.6 7077.2 8069.6 8329.4 8341.9 8354.1 8111.9 8232.6 8252.8 8265.1 8267.0 1982.1 2280.7 2291.9 2325.7 2348.6 2292.2 2312.4 2313.5 2313.6 2325.0 2315.9 2316.4 2353.0 2356.0 2358.1 1910.1 2179.5 2240.7 2247.1 2275.3 2243.7 2245.3 2267.1 2267.7 2271.7 8175.7 8239.0 8263.1 8267.3 8280.7 4995.9 5123.1 5123.9 5130.9 5163.2 3222.8 3266.7 3313.8 3330.1 3346.9 1039.4 1042.2 1065.6 1067.4 1082.1 11521.7 11552.0 11558.9 11567.7 11578.1 4466.2 4563.0 4644.4 4652.2 4657.7 9811.4 9812.3 9815.7 9831.9 9832.3 5113.3 5218.2 5249.2 5263.1 5264.2 4108.1 4624.7 4725.7 4759.9 4780.0 3815.4 3837.4 3904.9 3905.5 3947.8 1261.1 1267.5 1278.3 1286.3 1293.1 1008.5 1040.1 1041.4 1063.8 1066.8 5863.5 5924.6 5986.5 6045.6 6168.8 454.7 458.5 462.1 464.7 466.2 3937.7 3942.9 3971.4 3995.3 4175.3 9123.2 9563.0 9572.7 9665.7 9685.0 9506.3 9569.7 9575.9 9579.9 9601.3 7769.9 7870.0 7882.8 7953.6 7970.4 5700.5 5883.3 6011.8 6031.4 6046.1 9689.8 9756.4 9807.5 9818.3 9892.2 9713.6 9817.2 10006.2 10111.3 10121.7 6424.7 6651.9 6665.5 7513.7 7655.7 7192.1 8027.3 8273.0 8292.0 8298.8 7382.7 7422.0 7459.3 7559.4 7568.5 7409.1 7484.4 7567.7 7599.2 7651.8 7021.0 7030.2 7081.3 7098.2 7099.6 5056.2 5226.1 5239.3 5313.5 5352.8 5167.8 5205.3 5216.3 5283.2 5294.0 05:42:08 INFO - PROCESS | 30075 | 05:42:08 INFO - PROCESS | 30075 | [#4] prototype.html Cycles:180 Average:4631.34 Median:5230.73 stddev:1358.69 (26.0%) stddev-sans-first:1323.55 05:42:08 INFO - PROCESS | 30075 | Values: 327.8 334.3 339.1 340.6 341.3 5147.7 5157.3 5184.4 5199.4 5230.3 5058.2 5088.9 5111.3 5130.3 5144.5 3873.5 3930.9 3994.7 4038.7 4092.0 4052.3 4074.3 4081.3 4084.8 4111.3 4047.1 4050.5 4051.9 4052.3 4082.8 3864.4 3921.5 4064.7 4071.3 4098.0 3580.6 3597.5 3602.2 3623.9 3642.6 4857.0 4919.3 4930.3 4941.4 4980.9 4505.9 4565.2 4609.2 4618.8 4622.8 5308.7 5316.3 5322.6 5335.5 5343.4 3933.3 3942.2 3943.9 3944.8 3968.1 5423.2 5475.1 5528.7 5530.4 5578.2 3986.8 3997.3 4007.9 4015.4 4019.0 4071.3 4075.2 4077.9 4082.9 4096.8 4491.5 4577.4 4604.7 4607.4 4651.4 5324.3 5348.2 5355.5 5359.4 5378.0 1472.8 1486.0 1487.7 1493.2 1493.8 965.7 1003.9 1019.4 1035.8 1048.9 5483.2 5496.4 5535.1 5545.2 5545.9 5835.8 5848.5 5862.7 5863.6 5883.8 5388.8 5524.9 5532.6 5565.0 5574.6 3103.3 3117.1 3120.2 3124.5 3125.6 5892.4 6028.2 6031.0 6040.3 6071.8 5976.6 5978.5 6006.8 6016.7 6025.2 5996.9 6006.5 6017.4 6023.4 6058.8 5355.9 5594.6 5626.2 5635.8 5780.2 5538.4 5547.6 5553.4 5559.2 5567.3 5631.8 5756.3 5787.3 5787.6 5806.6 3951.8 3955.3 3962.8 3969.3 3980.9 5561.6 5607.8 5613.6 5625.7 5641.4 5231.2 5444.0 5451.3 5459.7 5497.8 5426.2 5433.1 5445.3 5457.3 5479.7 5098.0 5195.1 5326.7 5352.8 5384.9 5474.9 5501.0 5501.9 5508.3 5510.7 5370.8 5373.4 5375.4 5396.1 5399.1 05:42:08 INFO - PROCESS | 30075 | 05:42:08 INFO - PROCESS | 30075 | [#5] yui.html Cycles:180 Average:15466.75 Median:25924.60 stddev:18047.07 (69.6%) stddev-sans-first:18064.01 05:42:08 INFO - PROCESS | 30075 | Values: 782.4 818.4 855.7 856.1 863.6 14398.7 14915.3 14925.6 15007.6 15012.9 13520.5 13547.4 13664.0 13675.9 13687.4 676.5 787.8 813.9 815.9 826.3 811.6 818.0 819.4 821.3 821.6 862.1 869.9 870.3 870.9 871.7 711.9 728.6 729.0 834.5 861.4 627.3 627.8 628.0 628.2 629.0 14178.9 14225.8 14229.7 14246.1 14280.1 13330.5 14256.4 14457.6 14457.7 14536.1 11599.7 11745.5 11795.0 11935.1 11993.2 3889.8 3920.9 3936.2 4004.4 4015.2 54120.9 54524.2 54534.2 54798.5 57648.0 10758.8 10971.0 10999.3 11129.2 11153.7 20525.4 20566.6 20622.3 20712.8 20761.5 8442.9 8476.5 8616.2 8775.8 8894.2 4682.7 4810.8 4819.4 4834.9 4988.1 3400.5 3491.4 3513.5 3517.8 3522.5 642.7 655.4 657.1 666.3 667.4 747.4 773.8 793.3 802.4 814.0 8916.4 9780.6 9804.7 9844.5 9889.1 751.0 757.5 770.1 777.7 796.2 4735.2 4985.7 5044.4 5091.3 5107.4 64816.4 65968.7 67233.3 67511.7 67675.3 58063.7 58240.7 59196.0 59607.1 60054.4 53282.0 53866.5 54024.7 54361.5 54463.0 9758.2 9781.2 9878.3 9879.3 10154.8 35087.1 35604.6 36044.0 36202.5 36481.5 44994.6 46663.5 46877.3 47097.5 47114.0 12247.1 12251.5 12334.1 12341.3 12586.4 13630.0 13977.8 14149.2 14150.6 14428.5 8492.8 12619.3 12792.7 13336.5 13392.4 12413.5 12922.8 12990.5 13133.1 13446.7 12493.8 12742.9 12802.4 13146.0 13750.9 10844.7 11237.3 11261.5 11289.5 11441.8 10964.4 11039.9 11117.2 11179.9 11268.8 05:42:08 INFO - PROCESS | 30075 | -------- Summary: end -------- 05:42:08 INFO - PROCESS | 30075 | 05:42:09 INFO - TEST-INFO | 30075: exit 0 05:42:09 INFO - TEST-OK | dromaeo_css | took 1111826ms 05:42:09 INFO - TEST-START | kraken 05:42:09 INFO - operating with platform_type : linux_ 05:42:09 INFO - Initialising browser for kraken test... 05:42:09 INFO - TEST-INFO | started process 30257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTVw3Lt/profile http://localhost:58160/getInfo.html) 05:42:13 INFO - PROCESS | 30257 | __metrics Screen width/height:1600/1200 05:42:13 INFO - PROCESS | 30257 | colorDepth:24 05:42:13 INFO - PROCESS | 30257 | Browser inner width/height: 1024/697 05:42:13 INFO - PROCESS | 30257 | __metrics 05:42:14 ERROR - PROCESS | 30257 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:42:15 INFO - TEST-INFO | 30257: exit 0 05:42:15 INFO - Browser initialized. 05:42:15 INFO - Running cycle 1/1 for kraken test... 05:42:15 INFO - TEST-INFO | started process 30343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTVw3Lt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:26 INFO - PROCESS | 30343 | RSS: Main: 154398720 05:42:26 INFO - PROCESS | 30343 | 05:42:29 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58160/tests/kraken/driver.html?testName=audio-beat-detection) 05:42:30 INFO - PROCESS | 30343 | RSS: Main: 209412096 05:42:30 INFO - PROCESS | 30343 | 05:42:32 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58160/tests/kraken/driver.html?testName=audio-dft) 05:42:33 INFO - PROCESS | 30343 | RSS: Main: 195227648 05:42:33 INFO - PROCESS | 30343 | 05:42:36 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58160/tests/kraken/driver.html?testName=audio-fft) 05:42:37 INFO - PROCESS | 30343 | RSS: Main: 264351744 05:42:37 INFO - PROCESS | 30343 | 05:42:39 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58160/tests/kraken/driver.html?testName=audio-oscillator) 05:42:39 INFO - PROCESS | 30343 | RSS: Main: 173608960 05:42:39 INFO - PROCESS | 30343 | 05:42:42 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:42:42 INFO - PROCESS | 30343 | RSS: Main: 178044928 05:42:42 INFO - PROCESS | 30343 | 05:42:45 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58160/tests/kraken/driver.html?testName=imaging-darkroom) 05:42:46 INFO - PROCESS | 30343 | RSS: Main: 213929984 05:42:46 INFO - PROCESS | 30343 | 05:42:49 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58160/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:50 INFO - PROCESS | 30343 | RSS: Main: 215261184 05:42:50 INFO - PROCESS | 30343 | 05:42:53 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58160/tests/kraken/driver.html?testName=json-parse-financial) 05:42:53 INFO - PROCESS | 30343 | RSS: Main: 214925312 05:42:53 INFO - PROCESS | 30343 | 05:42:55 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:42:56 INFO - PROCESS | 30343 | RSS: Main: 204234752 05:42:56 INFO - PROCESS | 30343 | 05:42:57 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58160/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:42:58 INFO - PROCESS | 30343 | RSS: Main: 202285056 05:42:58 INFO - PROCESS | 30343 | 05:43:00 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:43:01 INFO - PROCESS | 30343 | RSS: Main: 215363584 05:43:01 INFO - PROCESS | 30343 | 05:43:03 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:04 INFO - PROCESS | 30343 | RSS: Main: 223068160 05:43:04 INFO - PROCESS | 30343 | 05:43:07 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:43:07 INFO - PROCESS | 30343 | RSS: Main: 218902528 05:43:07 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | Cycle 1(1): loaded http://localhost:58160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58160/tests/kraken/driver.html?testName=ai-astar) 05:43:09 INFO - PROCESS | 30343 | RSS: Main: 282423296 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | __start_tp_report 05:43:09 INFO - PROCESS | 30343 | _x_x_mozilla_page_load 05:43:09 INFO - PROCESS | 30343 | _x_x_mozilla_page_load_details 05:43:09 INFO - PROCESS | 30343 | |i|pagename|runs| 05:43:09 INFO - PROCESS | 30343 | |0;ai-astar;112;114;108;111;112;113;99;112;112;111 05:43:09 INFO - PROCESS | 30343 | |1;audio-beat-detection;161;127;155;190;139;154;154;132;188;132 05:43:09 INFO - PROCESS | 30343 | |2;audio-dft;160;162;161;162;160;162;162;161;160;162 05:43:09 INFO - PROCESS | 30343 | |3;audio-fft;75;76;111;104;73;82;75;136;107;77 05:43:09 INFO - PROCESS | 30343 | |4;audio-oscillator;93;94;153;93;93;93;141;93;94;154 05:43:09 INFO - PROCESS | 30343 | |5;imaging-gaussian-blur;116;117;116;116;117;117;116;117;116;117 05:43:09 INFO - PROCESS | 30343 | |6;imaging-darkroom;145;146;146;146;146;145;146;146;146;145 05:43:09 INFO - PROCESS | 30343 | |7;imaging-desaturate;95;95;95;94;95;94;95;95;95;95 05:43:09 INFO - PROCESS | 30343 | |8;json-parse-financial;59;60;60;60;60;60;61;82;58;57 05:43:09 INFO - PROCESS | 30343 | |9;json-stringify-tinderbox;60;61;61;67;61;61;62;60;60;60 05:43:09 INFO - PROCESS | 30343 | |10;stanford-crypto-aes;77;81;75;75;77;78;78;78;79;78 05:43:09 INFO - PROCESS | 30343 | |11;stanford-crypto-ccm;123;125;123;122;120;127;122;123;155;125 05:43:09 INFO - PROCESS | 30343 | |12;stanford-crypto-pbkdf2;168;175;171;182;170;184;168;173;171;178 05:43:09 INFO - PROCESS | 30343 | |13;stanford-crypto-sha256-iterative;69;69;69;70;68;69;68;68;69;67 05:43:09 INFO - PROCESS | 30343 | __end_tp_report 05:43:09 INFO - PROCESS | 30343 | __start_cc_report 05:43:09 INFO - PROCESS | 30343 | _x_x_mozilla_cycle_collect,1634 05:43:09 INFO - PROCESS | 30343 | __end_cc_report 05:43:09 INFO - PROCESS | 30343 | __startTimestamp1461847389585__endTimestamp 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | ------- Summary: start ------- 05:43:09 INFO - PROCESS | 30343 | Number of tests: 14 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:4.30 (3.8%) stddev-sans-first:4.52 05:43:09 INFO - PROCESS | 30343 | Values: 112.0 114.0 108.0 111.0 112.0 113.0 99.0 112.0 112.0 111.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:154.50 stddev:22.16 (14.3%) stddev-sans-first:23.32 05:43:09 INFO - PROCESS | 30343 | Values: 161.0 127.0 155.0 190.0 139.0 154.0 154.0 132.0 188.0 132.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 05:43:09 INFO - PROCESS | 30343 | Values: 160.0 162.0 161.0 162.0 160.0 162.0 162.0 161.0 160.0 162.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#3] audio-fft Cycles:10 Average:91.60 Median:75.00 stddev:21.56 (28.7%) stddev-sans-first:22.02 05:43:09 INFO - PROCESS | 30343 | Values: 75.0 76.0 111.0 104.0 73.0 82.0 75.0 136.0 107.0 77.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:27.29 (29.3%) stddev-sans-first:28.24 05:43:09 INFO - PROCESS | 30343 | Values: 93.0 94.0 153.0 93.0 93.0 93.0 141.0 93.0 94.0 154.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:43:09 INFO - PROCESS | 30343 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 05:43:09 INFO - PROCESS | 30343 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:43:09 INFO - PROCESS | 30343 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:60.00 stddev:7.23 (12.0%) stddev-sans-first:7.60 05:43:09 INFO - PROCESS | 30343 | Values: 59.0 60.0 60.0 60.0 60.0 60.0 61.0 82.0 58.0 57.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:2.11 (3.5%) stddev-sans-first:2.19 05:43:09 INFO - PROCESS | 30343 | Values: 60.0 61.0 61.0 67.0 61.0 61.0 62.0 60.0 60.0 60.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.00 stddev:1.78 (2.3%) stddev-sans-first:1.87 05:43:09 INFO - PROCESS | 30343 | Values: 77.0 81.0 75.0 75.0 77.0 78.0 78.0 78.0 79.0 78.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:124.00 stddev:10.20 (8.2%) stddev-sans-first:10.74 05:43:09 INFO - PROCESS | 30343 | Values: 123.0 125.0 123.0 122.0 120.0 127.0 122.0 123.0 155.0 125.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:174.00 stddev:5.66 (3.3%) stddev-sans-first:5.57 05:43:09 INFO - PROCESS | 30343 | Values: 168.0 175.0 171.0 182.0 170.0 184.0 168.0 173.0 171.0 178.0 05:43:09 INFO - PROCESS | 30343 | 05:43:09 INFO - PROCESS | 30343 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 05:43:09 INFO - PROCESS | 30343 | Values: 69.0 69.0 69.0 70.0 68.0 69.0 68.0 68.0 69.0 67.0 05:43:09 INFO - PROCESS | 30343 | -------- Summary: end -------- 05:43:09 INFO - PROCESS | 30343 | 05:43:10 INFO - TEST-INFO | 30343: exit 0 05:43:10 INFO - TEST-OK | kraken | took 61461ms 05:43:10 INFO - SUITE-END | took 1173s 05:43:10 INFO - Completed test suite (00:19:33) 05:43:10 INFO - javascript benchmark 05:43:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.8173709577413, 3071.95392069119, 3082.6454957679875, 3100.7364374028207, 3101.9534706979393, 5293.179557168635, 5332.520073193412, 5399.865003374917, 5425.2404663347115, 5429.4027656957705, 5339.813106541272, 5357.223202635615, 5403.405625381205, 5473.67157970522, 5481.588880833933, 4880.877978050542, 4904.215325547913, 4917.557419832215, 4937.950620493785, 5092.363454568179, 5004.099262132815, 5030.798768049273, 5069.2649565812935, 5071.695698258098, 5077.162268225757, 4802.183628783097, 4870.09903167915, 4928.310036594879, 4978.452370239271, 5036.043151801183, 4885.193942999401, 4896.265560165968, 4896.681715688469, 4929.309896614477, 4929.359183306183, 4760.357351757503, 4855.44162421319, 4884.267359896008, 4897.51024897511, 4909.680870743426, 5303.761330740126, 5320.0, 5328.786848526093, 5348.866278343034, 5398.757055932492, 5746.195532625436, 5753.798617048383, 5775.1337299405, 5778.711064446761, 5781.855453613652, 5614.017546929271, 5684.687342196177, 5720.942790572124, 5799.855003624901, 5810.477057064884, 5420.9971155336, 5444.292242008553, 5445.591580631469, 5447.046766815792, 5454.427285135083, 5911.0, 5921.881562368814, 5928.703564821742, 5928.940710592925, 5930.347661757203, 5491.533219676292, 5641.492265696107, 5695.0, 5706.42935706426, 5721.742521586539, 5767.904098221325, 5773.538116950634, 5778.595498315078, 5781.0, 5786.681732504669, 5684.54523638108, 5705.828825135252, 5710.229119068873, 5710.3433105193435, 5717.0, 5489.231507588941, 5622.100463925753, 5707.600467967285, 5733.0, 5753.108268218349, 4347.652187824967, 4350.0, 4352.847650332224, 4357.694961352739, 4390.62679672225, 3810.2189051244427, 3868.1296708240984, 3872.3223435898603, 3912.6478616924046, 3921.784301863368, 5443.346798384219, 5483.670979741229, 5492.835214943558, 5543.556515478752, 5547.944520554743, 5716.228309178207, 5725.08398656213, 5725.914111288334, 5727.856803579861, 5738.139279108167, 5308.973455132699, 5354.089804733205, 5387.8125263173415, 5400.864978375572, 5454.0, 4928.778204980785, 4947.035328110984, 4947.158982972904, 4956.851294461172, 4990.50094990498, 5968.731407086605, 5981.5214782817275, 5985.6408615483215, 5987.341392446828, 5991.670458124845, 5624.409437009055, 5778.624389414758, 5790.189373487631, 5836.474717275466, 5889.528837692888, 5952.672603006876, 5970.58205925581, 5974.551908606785, 5978.103284507359, 5991.310999235144, 5685.886282274414, 5687.800926967702, 5688.203651488878, 5693.373728889902, 5699.487046165699, 5619.831405057855, 5766.077427611562, 5771.711414429178, 5819.592628515963, 5862.501687356623, 5599.860003499945, 5601.579881508985, 5605.663660180402, 5606.24315717373, 5607.80372686954, 5539.806106786243, 5574.108142697311, 5583.944160558342, 5588.217649529151, 5589.161625756169, 5225.190095535046, 5397.676139431646, 5529.723513824212, 5537.2524709163745, 5585.720713964204, 5645.4072322405555, 5651.321841379061, 5676.7161641918565, 5690.430956904276, 5704.3725190228215, 5388.353397592314, 5571.8885622288135, 5588.413216612197, 5590.608657393944, 5595.0], "value": 5303.66024300877, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4515555377944, 631.9715612797423, 642.569478449439, 662.9701663425149, 663.4857985061574, 29264.414711705755, 37364.25271494569, 37990.62009379905, 38129.61870381295, 38130.618693813056, 40195.39706904399, 40861.18277634445, 40899.59100408995, 40921.18157636853, 40925.18149637005, 8466.492010479376, 8664.956675216616, 8693.69572064978, 8693.913060869405, 8695.95652021739, 8483.74548763538, 8623.0, 8657.177568131017, 8662.783430414258, 8666.696665616704, 8844.911550884473, 8893.95553022234, 8912.287017038621, 8916.108389161065, 8925.0, 8731.781705457352, 8835.0, 8853.911460885438, 8862.601182946783, 8866.778330541723, 8671.869921951176, 8776.0, 8787.868181977276, 8789.472631642122, 8794.384393092487, 41213.0, 41317.0, 41618.37572436416, 41733.58266417358, 41931.580684193075, 3543.1496440854266, 3548.946765798515, 3578.946315805239, 3709.6290370962956, 4145.689073319513, 28799.712002880122, 29533.261668458246, 29588.112356629335, 29754.553681694793, 29933.850330748424, 4291.635211007068, 4318.5465526119615, 4342.587454191878, 4380.408644832939, 4430.490493593245, 330918.0, 332296.0, 333166.0, 334906.0, 335905.0, 47526.0, 62492.68753656203, 63041.68479157666, 63073.0, 63092.369076309566, 52494.21258681123, 53085.46914530882, 53842.46157538453, 53926.73036634792, 53939.19091213635, 17787.110644467724, 18096.27614895416, 18149.27402903869, 18152.0, 18173.091345432676, 12116.878831211576, 12341.197822141532, 13743.03798734099, 13832.30838458073, 13835.169889806644, 18569.628607427774, 18886.244550217838, 18954.336598219274, 19028.71456928147, 19095.713564296548, 6967.477439192081, 6986.196587392515, 7281.381082607932, 7310.744123955636, 7324.828027515572, 1131.6039386214923, 1160.1299025730702, 1206.2460961898814, 1228.5945637939458, 1253.9937300313622, 30710.38579228403, 30746.538801917988, 31080.84459577733, 32399.676003240136, 32503.51244731331, 1084.4631907205983, 1125.6960620632547, 1132.6941725734005, 1190.6070996571111, 1196.3599474281218, 16882.74675879863, 17306.394276200273, 17539.386121485688, 17557.561060973578, 17562.912185439247, 492812.0, 501276.0, 501583.0, 502793.0, 503298.0, 57272.42727572671, 59110.704446478354, 59117.40882591205, 59121.70439147777, 59144.40855591389, 1323.2854258700195, 1331.2145833958011, 1375.2229990055587, 1420.4673247532176, 1445.8554144585457, 22340.664890026987, 30999.22107491647, 31626.36747265088, 31890.36219275555, 32395.51406728948, 48710.26934596055, 50175.4842064216, 50277.24584131314, 50310.245346319105, 51680.224796628834, 321984.0, 323992.0, 325353.0, 325424.0, 327746.0, 32885.17787055343, 36514.0, 37811.62188378081, 38455.423168653055, 40217.79891100526, 41923.0, 43143.56856431396, 43201.35197972096, 43204.78397607992, 43863.34204986991, 36729.63270367369, 36905.63094369022, 37089.25821483501, 37196.81401592975, 38190.427143592315, 38759.22481550297, 39304.0, 39310.41034384544, 39539.209215816096, 40246.0, 40701.0, 40837.591624083376, 41229.793851031754, 41245.0, 41276.793616031726, 33717.49423758694, 34819.82590087033, 35930.28139437249, 36205.0948726284, 36246.456303156, 26730.0, 27274.45451091007, 27316.45367092687, 27417.0, 27702.168934931986], "value": 19772.08705040241, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.41693750904886, 397.87665823594705, 398.58547111004555, 401.46805482735385, 413.4067612975381, 14108.647283817909, 15699.686006279868, 17458.0, 18177.63644727105, 18285.542861428454, 17576.736348954775, 18096.81903180968, 18414.35549755759, 18434.446966591022, 18436.262549498006, 5048.066107770056, 5163.302954101205, 5201.635885488017, 5212.218167274901, 5215.0, 3964.167524819791, 5129.12804823181, 5182.378114626231, 5522.751476183561, 5803.361630220694, 5699.088145896658, 5780.0751879699255, 5799.333076696192, 5803.2165657636315, 5806.1000544915605, 5491.203775452557, 5733.369329373765, 5738.569607279429, 5743.081107022877, 5767.452092051249, 5542.501174894279, 5545.916811247795, 5550.583706222009, 5551.972885016285, 5562.666240025571, 19854.40436786899, 21032.0, 21035.579288414145, 21196.152153913827, 22784.77215227843, 2186.4752459409788, 2235.642297232435, 2261.3216035189375, 2403.579373609611, 2417.830751847371, 9635.662751803724, 9670.90329096714, 9692.321537492378, 9919.603215871357, 11800.52797888092, 1906.7711874575002, 1990.3431867483696, 2016.8084032016934, 2034.6541088014924, 2079.199508189343, 77158.0, 82775.17224827735, 83076.0, 83111.0, 83597.58201208955, 10617.203709721802, 10690.0, 10714.946425267979, 10845.51195196218, 10851.131909447226, 14548.127112373291, 14704.779428308584, 14749.926250368679, 14848.0, 14896.776548351783, 8053.677852885936, 8245.13426090264, 8362.205590468895, 8438.198371154731, 8542.316614670935, 8093.797655058553, 8148.633311500997, 8261.586920653943, 8347.916520834835, 8426.915730842737, 4537.727736335831, 4590.0, 4636.281376386665, 4651.976740116278, 4654.394928659252, 1953.8827670339824, 1993.1728332742039, 2006.618742438932, 2019.899005049771, 2029.594081183769, 1026.384169498295, 1042.3224903812581, 1058.5659879449388, 1077.2997551591527, 1079.7462596289865, 18561.44315670532, 18946.242150313832, 19330.0, 19352.225910963403, 19480.805191948184, 1005.1456262177092, 1024.9641262555774, 1040.6149724601946, 1091.6414704994545, 1092.159037541089, 10450.320729152581, 10680.0, 10957.12343012557, 11000.779984400428, 11012.229143959847, 468996.0, 492731.0, 496827.0, 518308.0, 524345.0, 71477.0, 82766.0, 85506.0, 93084.53457732667, 99585.0, 1001.4577550572183, 1002.368507840056, 1018.2719355660738, 1025.7640742629237, 1049.3651340938775, 17117.74323385175, 17185.656286873942, 17266.728753442905, 17456.0, 17641.558961026076, 39102.4134637975, 40162.0, 40555.0, 40560.79719601383, 40945.59054409418, 55606.44393556013, 56552.717236413555, 56583.15125273207, 56626.7168664154, 57955.0, 8153.0, 8238.176182381714, 8534.146585341416, 8553.957230214059, 8599.742007739778, 11496.597619083292, 12652.936735316265, 12665.620031399072, 12712.618621441372, 12932.935335323264, 10599.417032063311, 10848.132149427869, 10878.238523303293, 10978.0, 11096.056835169102, 10613.522391492555, 10717.0, 10935.671929842118, 11112.277701949348, 11214.327140371604, 10652.82818889906, 10873.782524349626, 10958.890411095786, 11129.83305250438, 11201.71995700114, 8128.0, 8264.545450000307, 8300.294474969694, 8390.328773697967, 8522.914770852212, 8214.753557393287, 9765.511724413893, 10489.265751397328, 10689.839652405064, 11071.83392249133], "value": 8996.343063562463, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.291088633911, 1538.846115388461, 1540.8459154084594, 1745.1099939031099, 1875.56861921758, 7077.150741910965, 8069.636866341014, 8329.37529685273, 8341.91658083419, 8354.081051084384, 8111.91888081119, 8232.629531671075, 8252.752417427471, 8265.09084000761, 8267.0, 1982.0981453438724, 2280.6579013147993, 2291.942701432469, 2325.6744055832196, 2348.5537747827857, 2292.1519037955895, 2312.387217387394, 2313.456337760625, 2313.571989181998, 2325.0351104291785, 2315.8842057897123, 2316.444053427174, 2353.011735071274, 2356.0340260493203, 2358.1157066100213, 1910.1308904448442, 2179.5422961178174, 2240.675102110185, 2247.1460844878843, 2275.340151356105, 2243.652233903731, 2245.259064508708, 2267.0705010945435, 2267.682524446579, 2271.738750043733, 8175.672973081069, 8239.0, 8263.091059983397, 8267.255946964802, 8280.668773249123, 4995.850124496271, 5123.077845987721, 5123.897522049539, 5130.871728206787, 5163.225516172567, 3222.8066316021113, 3266.70599646033, 3313.8177400242976, 3330.0675810773023, 3346.9497957530657, 1039.4127318065268, 1042.2495803021811, 1065.648336049102, 1067.3809190669392, 1082.1234799812098, 11521.654350369503, 11552.0, 11558.884411155948, 11567.652970410902, 11578.073754099652, 4466.218411777926, 4563.0, 4644.442666879996, 4652.1626107300335, 4657.74382408964, 9811.362261452983, 9812.264080194014, 9815.656452024145, 9831.852522212173, 9832.262580306506, 5113.3097031900215, 5218.191180367049, 5249.212618107238, 5263.131583288791, 5264.236685680555, 4108.096218831853, 4624.722516649012, 4725.740084295397, 4759.857204283877, 4780.043991201774, 3815.42768584709, 3837.4052021936645, 3904.863329783501, 3905.4922860028014, 3947.8420863165725, 1261.0794120292237, 1267.461328935199, 1278.3161008860216, 1286.298967062953, 1293.1465232946211, 1008.510872226984, 1040.1003132290514, 1041.3699711674478, 1063.781924705449, 1066.7866426714534, 5863.530917526673, 5924.6149000314845, 5986.5210783137245, 6045.617200122904, 6168.753249870045, 454.72489144068027, 458.48649512545495, 462.1288870479104, 464.7281340415827, 466.2400287531302, 3937.665298449607, 3942.8619998299923, 3971.3645816669195, 3995.260876737813, 4175.269327867611, 9123.224525915239, 9563.043695630382, 9572.664956726481, 9665.71002869915, 9685.0, 9506.334556580972, 9569.665061722806, 9575.904240957641, 9579.856302155473, 9601.32790704644, 7769.92230077692, 7869.960650196713, 7882.842343153105, 7953.642086106023, 7970.442069055226, 5700.458456446631, 5883.264591926009, 6011.7595296187665, 6031.4270144336215, 6046.062860256668, 9689.806203876024, 9756.414615123116, 9807.460589667637, 9818.263630227619, 9892.208623309974, 9713.562889670124, 9817.214622830299, 10006.199504039514, 10111.3427627204, 10121.746956325856, 6424.743010279536, 6651.900221496779, 6665.466762659073, 7513.737019204302, 7655.6937722490475, 7192.136943566806, 8027.317677997436, 8273.0, 8292.04641466239, 8298.834023319621, 7382.741604044048, 7421.962890185515, 7459.291367320096, 7559.395248380227, 7568.470207085671, 7409.147947986051, 7484.401247900264, 7567.697292108254, 7599.240075992357, 7651.846963060819, 7020.964895175492, 7030.156381234285, 7081.327273908971, 7098.219195888551, 7099.645017749195, 5056.241563765465, 5226.11156103471, 5239.292695486213, 5313.54834839043, 5352.759125839269, 5167.844964651066, 5205.271262023244, 5216.347956505437, 5283.2075188722, 5294.0], "value": 4419.486571284414, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.80331800919436, 334.30464633562184, 339.14535370865406, 340.6457284424199, 341.27308832187435, 5147.742612869356, 5157.30376399186, 5184.3778746550415, 5199.428062913086, 5230.267762513246, 5058.241263810431, 5088.9313244218665, 5111.335526381575, 5130.281760553526, 5144.485551444854, 3873.5351757789035, 3930.94103588445, 3994.720369574131, 4038.6970977176684, 4091.9795401023102, 4052.3111071117983, 4074.348104303312, 4081.3266560710113, 4084.7957602119923, 4111.280525907954, 4047.1467615331267, 4050.453188819501, 4051.858184963527, 4052.250333688277, 4082.8159833648356, 3864.420336949466, 3921.450996860442, 4064.6992962252093, 4071.2671719090554, 4097.97951010246, 3580.5882323532865, 3597.4963505109304, 3602.171500554861, 3623.873164439232, 3642.5811031731423, 4856.951430485685, 4919.278252611593, 4930.33440485537, 4941.431735350445, 4980.850574482772, 4505.887352816173, 4565.155446242456, 4609.170349337118, 4618.769061546909, 4622.791974361162, 5308.681479111266, 5316.3354580677415, 5322.627416080876, 5335.493128152819, 5343.438938911436, 3933.311670457687, 3942.231264903345, 3943.881683549498, 3944.7830369329677, 3968.0873399118077, 5423.159410291371, 5475.1110866750905, 5528.668279903259, 5530.446955304437, 5578.24693666358, 3986.7607943522903, 3997.300472417315, 4007.919841603152, 4015.3976903464713, 4019.0354314964784, 4071.3485842265095, 4075.1645912587846, 4077.918441631151, 4082.8775136745944, 4096.836126554964, 4491.46102467706, 4577.427821522309, 4604.654650901196, 4607.424071991001, 4651.4418269807165, 5324.254604355393, 5348.171033489815, 5355.464453554613, 5359.410464848864, 5377.973110134424, 1472.7938088667595, 1485.9628509287354, 1487.6578386970841, 1493.1559523987867, 1493.7759336099455, 965.7344230336713, 1003.8694969654044, 1019.3883669798211, 1035.8290882004385, 1048.9318194317345, 5483.232347471358, 5496.367917689437, 5535.086710692691, 5545.223668686387, 5545.944540554624, 5835.79574714883, 5848.502877255481, 5862.736176872051, 5863.589548731633, 5883.823485295448, 5388.784448622089, 5524.861878452991, 5532.5573954083575, 5564.998300305902, 5574.554035677136, 3103.3017571046335, 3117.1116231873807, 3120.2043478912733, 3124.4535703401657, 3125.6405513366253, 5892.351841297454, 6028.156058151862, 6031.0, 6040.275166979903, 6071.848203794941, 5976.61152025117, 5978.491828194652, 6006.819795406145, 6016.669083200379, 6025.156478092983, 5996.940030599638, 6006.546235914367, 6017.428344307371, 6023.397660234029, 6058.848528786815, 5355.866103347447, 5594.580406469449, 5626.156076588544, 5635.830925072254, 5780.248567686174, 5538.421549858271, 5547.611667183259, 5553.416891226525, 5559.2217089606675, 5567.331920169606, 5631.774729010794, 5756.30924289088, 5787.3378246007305, 5787.594868359174, 5806.593538452268, 3951.782651954055, 3955.268275369066, 3962.791348638693, 3969.3450580653866, 3980.90047748797, 5561.555075593862, 5607.80372686954, 5613.578981576316, 5625.746841392229, 5641.435856414326, 5231.189165679326, 5443.972780136074, 5451.318585176853, 5459.727013649381, 5497.8075767347955, 5426.213199086032, 5433.125571677765, 5445.346558413015, 5457.263269458731, 5479.671219726829, 5097.974510127426, 5195.116830138961, 5326.7336633167415, 5352.84913743547, 5384.9192262116885, 5474.945250547444, 5501.009818232596, 5501.944980550144, 5508.338999320107, 5510.724463776875, 5370.845268267341, 5373.408925018167, 5375.381831089475, 5396.109641909041, 5399.055165346127], "value": 4210.283691391443, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.4092809928505, 818.4230117766974, 855.7304449098533, 856.0775540641313, 863.5941107679389, 14398.712025759492, 14915.25423728812, 14925.626859328522, 15007.624809379771, 15012.924935375322, 13520.459181632723, 13547.390367433465, 13664.0, 13675.93162034191, 13687.384067716952, 676.5298117808126, 787.7597332813518, 813.947093438926, 815.9347252219808, 826.305903041445, 811.5860910935406, 817.9713710020151, 819.4059307002406, 821.3183058061824, 821.5809936932147, 862.1421685423013, 869.8564736818417, 870.3428911172088, 870.9346798990069, 871.6949067826273, 711.8967749676294, 728.624758249502, 729.0, 834.453433001379, 861.418542483824, 627.3475585391187, 627.8116565030473, 628.0296941225818, 628.1739512540994, 628.9779857704958, 14178.858211417857, 14225.78661320081, 14229.715405691828, 14246.145231286157, 14280.143191408548, 13330.466781328736, 14256.429742810275, 14457.566273011826, 14457.710845783131, 14536.127832329988, 11599.710007249801, 11745.530178792838, 11795.0, 11935.104867135, 11993.220440671328, 3889.8444062237477, 3920.941185882214, 3936.193080418507, 4004.4193591929006, 4015.217032678629, 54120.91758164854, 54524.18213726797, 54534.181987270225, 54798.53406596713, 57648.0, 10758.784824303626, 10971.0, 10999.285046471954, 11129.241039324323, 11153.72115697114, 20525.38423847287, 20566.58866822655, 20622.27822026222, 20712.792872071386, 20761.480962976046, 8442.915570844212, 8476.49141051539, 8616.181462761153, 8775.824483510294, 8894.155055269739, 4682.695624784378, 4810.807567697253, 4819.421669399624, 4834.927476087862, 4988.052270068675, 3400.506926495644, 3491.4239150539875, 3513.5256740340237, 3517.82410879455, 3522.5420695309444, 642.6947200079925, 655.4395991427357, 657.139147716493, 666.2970566052763, 667.3826710292959, 747.4058123791599, 773.7523992322402, 793.3098204562068, 802.4463120446873, 814.0353680888167, 8916.420432671855, 9780.55987480565, 9804.705858824247, 9844.458554779556, 9889.10998010168, 750.9624518774149, 757.5227606607801, 770.0912922751096, 777.7005852746734, 796.2395911904117, 4735.195016847144, 4985.700857948535, 5044.369453818273, 5091.287219789232, 5107.412647545506, 64816.35183648103, 65968.67015664987, 67233.32766672368, 67511.66244168748, 67675.32324676789, 58063.70968145132, 58240.708796456594, 59196.0, 59607.10589341163, 60054.399456005754, 53282.0, 53866.46133538614, 54024.729876350364, 54361.45638543643, 54463.0, 9758.219342452729, 9781.217502599917, 9878.30851840393, 9879.308448408543, 10154.847677284994, 35087.12282192965, 35604.64395356117, 36044.0, 36202.4569631461, 36481.45277820888, 44994.550054500345, 46663.53336466727, 46877.29684054674, 47097.529024709314, 47114.0, 12247.08146888969, 12251.509939602316, 12334.136610437183, 12341.259524428562, 12586.370681466073, 13630.014166972336, 13977.818374212871, 14149.151050936976, 14150.646233844236, 14428.495002675276, 8492.761796431816, 12619.30593817349, 12792.74414511723, 13336.466541338626, 13392.397342119433, 12413.503459861504, 12922.806157907828, 12990.545330913372, 13133.146345487512, 13446.663833404244, 12493.750124997267, 12742.936285318514, 12802.423890925116, 13146.014048946176, 13750.931245343709, 10844.728881778019, 11237.3257604544, 11261.493232804707, 11289.491972861077, 11441.828372574251, 10964.396958167377, 11039.944800275947, 11117.16621253393, 11179.944100279447, 11268.83096753533], "value": 6978.070228968789, "unit": "score"}], "name": "dromaeo_css", "value": 7047.360019037324, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 108.0, 111.0, 112.0, 113.0, 99.0, 112.0, 112.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 155.0, 190.0, 139.0, 154.0, 154.0, 132.0, 188.0, 132.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 162.0, 160.0, 162.0, 162.0, 161.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 111.0, 104.0, 73.0, 82.0, 75.0, 136.0, 107.0, 77.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 153.0, 93.0, 93.0, 93.0, 141.0, 93.0, 94.0, 154.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 82.0, 58.0, 57.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 67.0, 61.0, 61.0, 62.0, 60.0, 60.0, 60.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 75.0, 75.0, 77.0, 78.0, 78.0, 78.0, 79.0, 78.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 123.0, 122.0, 120.0, 127.0, 122.0, 123.0, 155.0, 125.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 175.0, 171.0, 182.0, 170.0, 184.0, 168.0, 173.0, 171.0, 178.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 70.0, 68.0, 69.0, 68.0, 68.0, 69.0, 67.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1553.1999999999998, "alertThreshold": 2.0}]} 05:43:10 INFO - Return code: 0 05:43:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:43:10 ERROR - # TBPL SUCCESS # 05:43:10 INFO - Running post-action listener: _resource_record_post_action 05:43:10 INFO - Running post-run listener: _resource_record_post_run 05:43:11 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534040576; Read time: 16; Write time: 603860 05:43:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 215105536; Read time: 0; Write time: 306548 05:43:12 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289411072; Read time: 16; Write time: 291532 05:43:12 INFO - Running post-run listener: _upload_blobber_files 05:43:12 INFO - Blob upload gear active. 05:43:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:43:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:43:12 INFO - (blobuploader) - INFO - Open directory for files ... 05:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:13 INFO - (blobuploader) - INFO - Done attempting. 05:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:14 INFO - (blobuploader) - INFO - Done attempting. 05:43:14 INFO - (blobuploader) - INFO - Iteration through files over. 05:43:14 INFO - Return code: 0 05:43:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:43:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:43:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aebb22adf67c7c6b81a5d9a813141922eaf125083a68891aa723d4540438869560a056cdf25568731b6c50faa5e19e8e8a2659ccf8b419b8e17a1d7fce3a5694", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24db766d842015f3c7a0ba9aaff5275cf1eec0f232b3dbb501eea3d0a5149330dd4980ec0dd9ecaff982b4ffb5c374072076beff163572c2a14499f37f19f589"} 05:43:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:43:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:43:14 INFO - Contents: 05:43:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aebb22adf67c7c6b81a5d9a813141922eaf125083a68891aa723d4540438869560a056cdf25568731b6c50faa5e19e8e8a2659ccf8b419b8e17a1d7fce3a5694", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24db766d842015f3c7a0ba9aaff5275cf1eec0f232b3dbb501eea3d0a5149330dd4980ec0dd9ecaff982b4ffb5c374072076beff163572c2a14499f37f19f589"} 05:43:14 INFO - Running post-run listener: copy_logs_to_upload_dir 05:43:14 INFO - Copying logs to upload dir... 05:43:14 INFO - mkdir: /builds/slave/test/build/upload/logs 05:43:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.184507 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-28 05:43:13.101617) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:43:13.105452) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972 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-Inbound/sha512/aebb22adf67c7c6b81a5d9a813141922eaf125083a68891aa723d4540438869560a056cdf25568731b6c50faa5e19e8e8a2659ccf8b419b8e17a1d7fce3a5694", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24db766d842015f3c7a0ba9aaff5275cf1eec0f232b3dbb501eea3d0a5149330dd4980ec0dd9ecaff982b4ffb5c374072076beff163572c2a14499f37f19f589"} build_url:https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011146 build_url: 'https://queue.taskcluster.net/v1/task/cK6kes9RQ5CtQkgP3wdjzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aebb22adf67c7c6b81a5d9a813141922eaf125083a68891aa723d4540438869560a056cdf25568731b6c50faa5e19e8e8a2659ccf8b419b8e17a1d7fce3a5694", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24db766d842015f3c7a0ba9aaff5275cf1eec0f232b3dbb501eea3d0a5149330dd4980ec0dd9ecaff982b4ffb5c374072076beff163572c2a14499f37f19f589"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:43:13.139192) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:43:13.139871) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461845599.80758-1329403972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:43:13.222830) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:43:13.223162) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:43:13.223463) ========= ========= Total master_lag: 0.17 =========