builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1465501814.49 results: success (0) buildid: 20160609095529 builduid: 50260888102748178194f2d93b146567 revision: a23a6103b9bef3d80874d74e2278ee47b458ed87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.490197) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.493520) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.493923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.536107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.536635) ========= 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=db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 12:50:14-- 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% 220M=0s 2016-06-09 12:50:14 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.631709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.632027) ========= 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=db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015072 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.680831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.681174) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a23a6103b9bef3d80874d74e2278ee47b458ed87 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a23a6103b9bef3d80874d74e2278ee47b458ed87 --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=db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 12:50:14,826 truncating revision to first 12 chars 2016-06-09 12:50:14,826 Setting DEBUG logging. 2016-06-09 12:50:14,826 attempt 1/10 2016-06-09 12:50:14,826 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a23a6103b9be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 12:50:15,179 unpacking tar archive at: mozilla-beta-a23a6103b9be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703148 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:15.400595) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:15.400976) ========= script_repo_revision: a23a6103b9bef3d80874d74e2278ee47b458ed87 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:15.401428) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:15.401706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:15.412490) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-09 12:50:15.412872) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:50:15 INFO - MultiFileLogger online at 20160609 12:50:15 in /builds/slave/test 12:50:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:50:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:15 INFO - {'append_to_log': False, 12:50:15 INFO - 'base_work_dir': '/builds/slave/test', 12:50:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:50:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:15 INFO - 'branch': 'Mozilla-Beta', 12:50:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:15 INFO - 'config_files': ('talos/linux_config.py',), 12:50:15 INFO - 'default_actions': ('clobber', 12:50:15 INFO - 'read-buildbot-config', 12:50:15 INFO - 'download-and-extract', 12:50:15 INFO - 'populate-webroot', 12:50:15 INFO - 'create-virtualenv', 12:50:15 INFO - 'install', 12:50:15 INFO - 'run-tests'), 12:50:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:15 INFO - 'download_minidump_stackwalk': True, 12:50:15 INFO - 'download_symbols': 'ondemand', 12:50:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:50:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:50:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:50:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:50:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:15 INFO - 'installer_path': 'installer.exe', 12:50:15 INFO - 'log_level': 'info', 12:50:15 INFO - 'log_name': 'talos', 12:50:15 INFO - 'log_to_console': True, 12:50:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:50:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:50:15 INFO - 'opt_config_files': (), 12:50:15 INFO - 'pip_index': False, 12:50:15 INFO - 'sps_profile': False, 12:50:15 INFO - 'sps_profile_interval': 0, 12:50:15 INFO - 'suite': 'dromaeojs', 12:50:15 INFO - 'system_bits': '32', 12:50:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:15 INFO - 'title': 'talos-linux64-ix-031', 12:50:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:15 INFO - 'use_talos_json': True, 12:50:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:15 INFO - 'work_dir': 'build'} 12:50:15 INFO - ##### 12:50:15 INFO - ##### Running clobber step. 12:50:15 INFO - ##### 12:50:15 INFO - Running pre-action listener: _resource_record_pre_action 12:50:15 INFO - Running main action method: clobber 12:50:15 INFO - rmtree: /builds/slave/test/build 12:50:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:16 INFO - Running post-action listener: _resource_record_post_action 12:50:16 INFO - ##### 12:50:16 INFO - ##### Running read-buildbot-config step. 12:50:16 INFO - ##### 12:50:16 INFO - Running pre-action listener: _resource_record_pre_action 12:50:16 INFO - Running main action method: read_buildbot_config 12:50:16 INFO - Using buildbot properties: 12:50:16 INFO - { 12:50:16 INFO - "project": "", 12:50:16 INFO - "product": "firefox", 12:50:16 INFO - "script_repo_revision": "production", 12:50:16 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:50:16 INFO - "repository": "", 12:50:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:50:16 INFO - "buildid": "20160609095529", 12:50:16 INFO - "pgo_build": "True", 12:50:16 INFO - "basedir": "/builds/slave/test", 12:50:16 INFO - "buildnumber": 126, 12:50:16 INFO - "slavename": "talos-linux64-ix-031", 12:50:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:50:16 INFO - "platform": "ubuntu64_hw", 12:50:16 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:50:16 INFO - "branch": "mozilla-beta", 12:50:16 INFO - "repo_path": "releases/mozilla-beta", 12:50:16 INFO - "revision": "a23a6103b9bef3d80874d74e2278ee47b458ed87", 12:50:16 INFO - "stage_platform": "linux64-pgo", 12:50:16 INFO - "builduid": "50260888102748178194f2d93b146567", 12:50:16 INFO - "slavebuilddir": "test" 12:50:16 INFO - } 12:50:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 12:50:16 INFO - Running post-action listener: _resource_record_post_action 12:50:16 INFO - ##### 12:50:16 INFO - ##### Running download-and-extract step. 12:50:16 INFO - ##### 12:50:16 INFO - Running pre-action listener: _resource_record_pre_action 12:50:16 INFO - Running main action method: download_and_extract 12:50:16 INFO - mkdir: /builds/slave/test/build/tests 12:50:16 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')]} 12:50:16 INFO - https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:50:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:50:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:50:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:50:29 INFO - Downloaded 1327 bytes. 12:50:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:50:29 INFO - Using the following test package requirements: 12:50:29 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:50:29 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:29 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:50:29 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:29 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 12:50:29 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:29 INFO - u'jsshell-linux-x86_64.zip'], 12:50:29 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:29 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:50:29 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:50:29 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:29 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 12:50:29 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:29 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 12:50:29 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:29 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:50:29 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:29 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:50:29 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:29 INFO - https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:50:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:50:39 INFO - Downloaded 24178211 bytes. 12:50:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:50:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:50:40 INFO - Return code: 0 12:50:40 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:40 INFO - https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:50:42 INFO - Downloaded 24178211 bytes. 12:50:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:50:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:50:43 INFO - Return code: 0 12:50: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')]} 12:50:43 INFO - https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:50:44 INFO - Downloaded 10840145 bytes. 12:50:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:50:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:50:44 INFO - Return code: 0 12:50:44 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')]} 12:50:44 INFO - https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:50:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:50:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:50:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:50:46 INFO - Downloaded 56011965 bytes. 12:50:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:50:46 INFO - mkdir: /builds/slave/test/properties 12:50:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:46 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:46 INFO - Contents: 12:50:46 INFO - build_url:https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:50:46 INFO - Running post-action listener: _resource_record_post_action 12:50:46 INFO - Running post-action listener: set_extra_try_arguments 12:50:46 INFO - ##### 12:50:46 INFO - ##### Running populate-webroot step. 12:50:46 INFO - ##### 12:50:46 INFO - Running pre-action listener: _resource_record_pre_action 12:50:46 INFO - Running main action method: populate_webroot 12:50:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:50:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:50:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:50:46 INFO - '--tppagecycles', 12:50:46 INFO - '7'], 12:50:46 INFO - 'tests': ['tsvgm']}}, 12:50:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:50:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:50:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:50:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:50:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:50:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:50:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:46 INFO - 'talos_options': ['--disable-e10s'], 12:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:46 INFO - 'talos_options': ['--disable-e10s'], 12:50:46 INFO - 'tests': ['damp', 'tps']}, 12:50:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:46 INFO - 'tests': ['damp', 'tps']}, 12:50:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:50:46 INFO - 'tests': ['dromaeo_dom']}, 12:50:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:50:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:50:46 INFO - 'tests': ['a11yr', 12:50:46 INFO - 'ts_paint', 12:50:46 INFO - 'tpaint', 12:50:46 INFO - 'sessionrestore', 12:50:46 INFO - 'sessionrestore_no_auto_restore', 12:50:46 INFO - 'tabpaint']}, 12:50:46 INFO - 'other-e10s': {'tests': ['a11yr', 12:50:46 INFO - 'ts_paint', 12:50:46 INFO - 'tpaint', 12:50:46 INFO - 'sessionrestore', 12:50:46 INFO - 'sessionrestore_no_auto_restore', 12:50:46 INFO - 'tabpaint']}, 12:50:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:50:46 INFO - 'ts_paint', 12:50:46 INFO - 'tpaint', 12:50:46 INFO - 'sessionrestore', 12:50:46 INFO - 'sessionrestore_no_auto_restore', 12:50:46 INFO - 'tabpaint']}, 12:50:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:50:46 INFO - 'ts_paint', 12:50:46 INFO - 'tpaint', 12:50:46 INFO - 'sessionrestore', 12:50:46 INFO - 'sessionrestore_no_auto_restore', 12:50:46 INFO - 'tabpaint']}, 12:50:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:50:46 INFO - 'tests': ['a11yr', 12:50:46 INFO - 'ts_paint', 12:50:46 INFO - 'tpaint', 12:50:46 INFO - 'sessionrestore', 12:50:46 INFO - 'sessionrestore_no_auto_restore', 12:50:46 INFO - 'tabpaint']}, 12:50:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:50:46 INFO - 'tests': ['a11yr', 12:50:46 INFO - 'ts_paint', 12:50:46 INFO - 'tpaint', 12:50:46 INFO - 'sessionrestore', 12:50:46 INFO - 'sessionrestore_no_auto_restore', 12:50:46 INFO - 'tabpaint']}, 12:50:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:50:46 INFO - 'tests': ['tsvgx', 12:50:46 INFO - 'tsvgr_opacity', 12:50:46 INFO - 'tart', 12:50:46 INFO - 'tscrollx', 12:50:46 INFO - 'cart']}, 12:50:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:50:46 INFO - 'tsvgr_opacity', 12:50:46 INFO - 'tart', 12:50:46 INFO - 'tscrollx', 12:50:46 INFO - 'cart']}, 12:50:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:46 INFO - 'talos_options': ['--disable-e10s'], 12:50:46 INFO - 'tests': ['tp5o']}, 12:50:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:46 INFO - 'tests': ['tp5o']}, 12:50:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:46 INFO - 'talos_options': ['--disable-e10s', 12:50:46 INFO - '--xperf_path', 12:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:46 INFO - 'tests': ['tp5n']}, 12:50:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:46 INFO - 'talos_options': ['--xperf_path', 12:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:46 INFO - 'tests': ['tp5n']}}, 12:50:46 INFO - 'talos.zip': {'path': '', 12:50:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:50:46 INFO - Running post-action listener: _resource_record_post_action 12:50:46 INFO - ##### 12:50:46 INFO - ##### Running create-virtualenv step. 12:50:46 INFO - ##### 12:50:46 INFO - Running pre-action listener: _resource_record_pre_action 12:50:46 INFO - Running main action method: create_virtualenv 12:50:46 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:46 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 12:50:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:50:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:46 INFO - Using real prefix '/usr' 12:50:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:49 INFO - Installing pip.................done. 12:50:49 INFO - Return code: 0 12:50:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:49 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 0x7f863acfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', '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 12:50:49 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 12:50:49 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 12:50:49 INFO - Using env: {'DISPLAY': ':0', 12:50:49 INFO - 'HOME': '/home/cltbld', 12:50:49 INFO - 'LANG': 'en_US.UTF-8', 12:50:49 INFO - 'LANGUAGE': 'en_US:en', 12:50:49 INFO - 'LOGNAME': 'cltbld', 12:50:49 INFO - 'MAIL': '/var/mail/cltbld', 12:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:49 INFO - 'MOZ_NO_REMOTE': '1', 12:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:49 INFO - 'NO_EM_RESTART': '1', 12:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:49 INFO - 'PWD': '/builds/slave/test', 12:50:49 INFO - 'SHELL': '/bin/bash', 12:50:49 INFO - 'SHLVL': '1', 12:50:49 INFO - 'TERM': 'linux', 12:50:49 INFO - 'TMOUT': '86400', 12:50:49 INFO - 'USER': 'cltbld', 12:50:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', 12:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:49 INFO - '_': '/tools/buildbot/bin/python'} 12:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:49 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 12:50:49 INFO - Cleaning up... 12:50:49 INFO - Return code: 0 12:50:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:49 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 0x7f863acfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', '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 12:50:49 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 12:50:49 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 12:50:49 INFO - Using env: {'DISPLAY': ':0', 12:50:49 INFO - 'HOME': '/home/cltbld', 12:50:49 INFO - 'LANG': 'en_US.UTF-8', 12:50:49 INFO - 'LANGUAGE': 'en_US:en', 12:50:49 INFO - 'LOGNAME': 'cltbld', 12:50:49 INFO - 'MAIL': '/var/mail/cltbld', 12:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:49 INFO - 'MOZ_NO_REMOTE': '1', 12:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:49 INFO - 'NO_EM_RESTART': '1', 12:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:49 INFO - 'PWD': '/builds/slave/test', 12:50:49 INFO - 'SHELL': '/bin/bash', 12:50:49 INFO - 'SHLVL': '1', 12:50:49 INFO - 'TERM': 'linux', 12:50:49 INFO - 'TMOUT': '86400', 12:50:49 INFO - 'USER': 'cltbld', 12:50:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', 12:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:49 INFO - '_': '/tools/buildbot/bin/python'} 12:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:49 INFO - Downloading/unpacking psutil>=0.7.1 12:50:49 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 12:50:49 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 12:50:49 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 12:50:49 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 12:50:49 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 12:50:49 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 12:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:51 INFO - Installing collected packages: psutil 12:50:51 INFO - Running setup.py install for psutil 12:50:51 INFO - building 'psutil._psutil_linux' extension 12:50:51 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 12:50:52 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 12:50:52 INFO - building 'psutil._psutil_posix' extension 12:50:52 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 12:50:52 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 12:50:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:52 INFO - Successfully installed psutil 12:50:52 INFO - Cleaning up... 12:50:52 INFO - Return code: 0 12:50:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:52 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 0x7f863acfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', '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 12:50:52 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 12:50:52 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 12:50:52 INFO - Using env: {'DISPLAY': ':0', 12:50:52 INFO - 'HOME': '/home/cltbld', 12:50:52 INFO - 'LANG': 'en_US.UTF-8', 12:50:52 INFO - 'LANGUAGE': 'en_US:en', 12:50:52 INFO - 'LOGNAME': 'cltbld', 12:50:52 INFO - 'MAIL': '/var/mail/cltbld', 12:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:52 INFO - 'MOZ_NO_REMOTE': '1', 12:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:52 INFO - 'NO_EM_RESTART': '1', 12:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:52 INFO - 'PWD': '/builds/slave/test', 12:50:52 INFO - 'SHELL': '/bin/bash', 12:50:52 INFO - 'SHLVL': '1', 12:50:52 INFO - 'TERM': 'linux', 12:50:52 INFO - 'TMOUT': '86400', 12:50:52 INFO - 'USER': 'cltbld', 12:50:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', 12:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:52 INFO - '_': '/tools/buildbot/bin/python'} 12:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:50:52 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 12:50:52 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 12:50:52 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 12:50:52 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 12:50:52 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 12:50:52 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 12:50:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:50:54 INFO - Installing collected packages: mozsystemmonitor 12:50:54 INFO - Running setup.py install for mozsystemmonitor 12:50:54 INFO - Successfully installed mozsystemmonitor 12:50:54 INFO - Cleaning up... 12:50:54 INFO - Return code: 0 12:50:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f863acfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', '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 12:50:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:50:54 INFO - Using env: {'DISPLAY': ':0', 12:50:54 INFO - 'HOME': '/home/cltbld', 12:50:54 INFO - 'LANG': 'en_US.UTF-8', 12:50:54 INFO - 'LANGUAGE': 'en_US:en', 12:50:54 INFO - 'LOGNAME': 'cltbld', 12:50:54 INFO - 'MAIL': '/var/mail/cltbld', 12:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:54 INFO - 'MOZ_NO_REMOTE': '1', 12:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:54 INFO - 'NO_EM_RESTART': '1', 12:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:54 INFO - 'PWD': '/builds/slave/test', 12:50:54 INFO - 'SHELL': '/bin/bash', 12:50:54 INFO - 'SHLVL': '1', 12:50:54 INFO - 'TERM': 'linux', 12:50:54 INFO - 'TMOUT': '86400', 12:50:54 INFO - 'USER': 'cltbld', 12:50:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', 12:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:54 INFO - '_': '/tools/buildbot/bin/python'} 12:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:54 INFO - Downloading/unpacking blobuploader==1.2.4 12:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:56 INFO - Downloading blobuploader-1.2.4.tar.gz 12:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:50:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:50:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50:57 INFO - Downloading docopt-0.6.1.tar.gz 12:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:50:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:50:57 INFO - Running setup.py install for blobuploader 12:50:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:50:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:50:57 INFO - Running setup.py install for requests 12:50:57 INFO - Running setup.py install for docopt 12:50:57 INFO - Successfully installed blobuploader requests docopt 12:50:57 INFO - Cleaning up... 12:50:58 INFO - Return code: 0 12:50:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:58 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 0x7f863acfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', '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 12:50:58 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 12:50:58 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 12:50:58 INFO - Using env: {'DISPLAY': ':0', 12:50:58 INFO - 'HOME': '/home/cltbld', 12:50:58 INFO - 'LANG': 'en_US.UTF-8', 12:50:58 INFO - 'LANGUAGE': 'en_US:en', 12:50:58 INFO - 'LOGNAME': 'cltbld', 12:50:58 INFO - 'MAIL': '/var/mail/cltbld', 12:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:58 INFO - 'MOZ_NO_REMOTE': '1', 12:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:58 INFO - 'NO_EM_RESTART': '1', 12:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:58 INFO - 'PWD': '/builds/slave/test', 12:50:58 INFO - 'SHELL': '/bin/bash', 12:50:58 INFO - 'SHLVL': '1', 12:50:58 INFO - 'TERM': 'linux', 12:50:58 INFO - 'TMOUT': '86400', 12:50:58 INFO - 'USER': 'cltbld', 12:50:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', 12:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:58 INFO - '_': '/tools/buildbot/bin/python'} 12:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:58 INFO - Running setup.py (path:/tmp/pip-eehdX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:58 INFO - Running setup.py (path:/tmp/pip-MX93FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:58 INFO - Running setup.py (path:/tmp/pip-AYGfGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:58 INFO - Running setup.py (path:/tmp/pip-sPXO0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:58 INFO - Running setup.py (path:/tmp/pip-Z39wSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:58 INFO - Running setup.py (path:/tmp/pip-Mgsgfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:58 INFO - Running setup.py (path:/tmp/pip-pV8W5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:58 INFO - Running setup.py (path:/tmp/pip-5lAnP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:58 INFO - Running setup.py (path:/tmp/pip-B2qsqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:58 INFO - Running setup.py (path:/tmp/pip-n19_5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:58 INFO - Running setup.py (path:/tmp/pip-IPSkOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:59 INFO - Running setup.py (path:/tmp/pip-wgITNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:50:59 INFO - Running setup.py (path:/tmp/pip-DlG0ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:50:59 INFO - Running setup.py (path:/tmp/pip-39x1DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:59 INFO - Running setup.py (path:/tmp/pip-tKxcWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:50:59 INFO - Running setup.py (path:/tmp/pip-szMhbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:50:59 INFO - Running setup.py (path:/tmp/pip-oxEjaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:50:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:50:59 INFO - Running setup.py install for manifestparser 12:50:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Running setup.py install for mozcrash 12:50:59 INFO - Running setup.py install for mozdebug 12:50:59 INFO - Running setup.py install for mozdevice 12:50:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Running setup.py install for mozfile 12:50:59 INFO - Running setup.py install for mozhttpd 12:51:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozinfo 12:51:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozInstall 12:51:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozleak 12:51:00 INFO - Running setup.py install for mozlog 12:51:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for moznetwork 12:51:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozprocess 12:51:00 INFO - Running setup.py install for mozprofile 12:51:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozrunner 12:51:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozscreenshot 12:51:01 INFO - Running setup.py install for moztest 12:51:01 INFO - Running setup.py install for mozversion 12:51:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:01 INFO - Cleaning up... 12:51:01 INFO - Return code: 0 12:51:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:01 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 0x7f863acfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', '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 12:51:01 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 12:51:01 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 12:51:01 INFO - Using env: {'DISPLAY': ':0', 12:51:01 INFO - 'HOME': '/home/cltbld', 12:51:01 INFO - 'LANG': 'en_US.UTF-8', 12:51:01 INFO - 'LANGUAGE': 'en_US:en', 12:51:01 INFO - 'LOGNAME': 'cltbld', 12:51:01 INFO - 'MAIL': '/var/mail/cltbld', 12:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:01 INFO - 'MOZ_NO_REMOTE': '1', 12:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:01 INFO - 'NO_EM_RESTART': '1', 12:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:01 INFO - 'PWD': '/builds/slave/test', 12:51:01 INFO - 'SHELL': '/bin/bash', 12:51:01 INFO - 'SHLVL': '1', 12:51:01 INFO - 'TERM': 'linux', 12:51:01 INFO - 'TMOUT': '86400', 12:51:01 INFO - 'USER': 'cltbld', 12:51:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', 12:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:01 INFO - '_': '/tools/buildbot/bin/python'} 12:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:01 INFO - Running setup.py (path:/tmp/pip-2EvU3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:01 INFO - Running setup.py (path:/tmp/pip-Ij8WmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:01 INFO - Running setup.py (path:/tmp/pip-N8b_zZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:01 INFO - Running setup.py (path:/tmp/pip-4tHHlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:01 INFO - Running setup.py (path:/tmp/pip-dvTZvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:01 INFO - Running setup.py (path:/tmp/pip-DsN6Tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:01 INFO - Running setup.py (path:/tmp/pip-XfOwnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:01 INFO - Running setup.py (path:/tmp/pip-FRvegl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:02 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)) 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:02 INFO - Running setup.py (path:/tmp/pip-UdUY3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:02 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)) 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:02 INFO - Running setup.py (path:/tmp/pip-hyMxOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:02 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)) 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:02 INFO - Running setup.py (path:/tmp/pip-4srvSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:02 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)) 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:02 INFO - Running setup.py (path:/tmp/pip-uGrMmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:02 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)) 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:02 INFO - Running setup.py (path:/tmp/pip-duu9kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:02 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)) 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:02 INFO - Running setup.py (path:/tmp/pip-vR40kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:02 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)) 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:02 INFO - Running setup.py (path:/tmp/pip-2rONiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:02 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)) 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:02 INFO - Running setup.py (path:/tmp/pip-eR4tzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:02 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)) 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:02 INFO - Running setup.py (path:/tmp/pip-jTDUSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:04 INFO - Downloading blessings-1.6.tar.gz 12:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:04 INFO - Installing collected packages: blessings 12:51:04 INFO - Running setup.py install for blessings 12:51:04 INFO - Successfully installed blessings 12:51:04 INFO - Cleaning up... 12:51:04 INFO - Return code: 0 12:51:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:05 INFO - Reading from file tmpfile_stdout 12:51:05 INFO - Current package versions: 12:51:05 INFO - argparse == 1.2.1 12:51:05 INFO - blessings == 1.6 12:51:05 INFO - blobuploader == 1.2.4 12:51:05 INFO - docopt == 0.6.1 12:51:05 INFO - manifestparser == 1.1 12:51:05 INFO - mozInstall == 1.12 12:51:05 INFO - mozcrash == 0.17 12:51:05 INFO - mozdebug == 0.1 12:51:05 INFO - mozdevice == 0.48 12:51:05 INFO - mozfile == 1.2 12:51:05 INFO - mozhttpd == 0.7 12:51:05 INFO - mozinfo == 0.9 12:51:05 INFO - mozleak == 0.1 12:51:05 INFO - mozlog == 3.1 12:51:05 INFO - moznetwork == 0.27 12:51:05 INFO - mozprocess == 0.22 12:51:05 INFO - mozprofile == 0.28 12:51:05 INFO - mozrunner == 6.11 12:51:05 INFO - mozscreenshot == 0.1 12:51:05 INFO - mozsystemmonitor == 0.0 12:51:05 INFO - moztest == 0.7 12:51:05 INFO - mozversion == 1.4 12:51:05 INFO - psutil == 3.1.1 12:51:05 INFO - requests == 1.2.3 12:51:05 INFO - wsgiref == 0.1.2 12:51:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:05 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')]} 12:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:05 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')]} 12:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:05 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 0x7f863acfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', '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 12:51:05 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 12:51:05 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 12:51:05 INFO - Using env: {'DISPLAY': ':0', 12:51:05 INFO - 'HOME': '/home/cltbld', 12:51:05 INFO - 'LANG': 'en_US.UTF-8', 12:51:05 INFO - 'LANGUAGE': 'en_US:en', 12:51:05 INFO - 'LOGNAME': 'cltbld', 12:51:05 INFO - 'MAIL': '/var/mail/cltbld', 12:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:05 INFO - 'MOZ_NO_REMOTE': '1', 12:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:05 INFO - 'NO_EM_RESTART': '1', 12:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:05 INFO - 'PWD': '/builds/slave/test', 12:51:05 INFO - 'SHELL': '/bin/bash', 12:51:05 INFO - 'SHLVL': '1', 12:51:05 INFO - 'TERM': 'linux', 12:51:05 INFO - 'TMOUT': '86400', 12:51:05 INFO - 'USER': 'cltbld', 12:51:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', 12:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:05 INFO - '_': '/tools/buildbot/bin/python'} 12:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:05 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)) 12:51:05 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)) 12:51:05 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)) 12:51:05 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)) 12:51:05 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)) 12:51:05 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)) 12:51:05 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)) 12:51:05 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)) 12:51:05 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)) 12:51:05 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)) 12:51:05 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)) 12:51:05 INFO - Cleaning up... 12:51:05 INFO - Return code: 0 12:51:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51:05 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')]} 12:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:05 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')]} 12:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:05 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 0x7f863acfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', '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 12:51:05 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 12:51:05 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 12:51:05 INFO - Using env: {'DISPLAY': ':0', 12:51:05 INFO - 'HOME': '/home/cltbld', 12:51:05 INFO - 'LANG': 'en_US.UTF-8', 12:51:05 INFO - 'LANGUAGE': 'en_US:en', 12:51:05 INFO - 'LOGNAME': 'cltbld', 12:51:05 INFO - 'MAIL': '/var/mail/cltbld', 12:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:05 INFO - 'MOZ_NO_REMOTE': '1', 12:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:05 INFO - 'NO_EM_RESTART': '1', 12:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:05 INFO - 'PWD': '/builds/slave/test', 12:51:05 INFO - 'SHELL': '/bin/bash', 12:51:05 INFO - 'SHLVL': '1', 12:51:05 INFO - 'TERM': 'linux', 12:51:05 INFO - 'TMOUT': '86400', 12:51:05 INFO - 'USER': 'cltbld', 12:51:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', 12:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:05 INFO - '_': '/tools/buildbot/bin/python'} 12:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:05 INFO - Downloading/unpacking jsonschema 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:51:07 INFO - Downloading/unpacking functools32 (from jsonschema) 12:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:07 INFO - Downloading functools32-3.2.3-2.tar.gz 12:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:51:07 INFO - warning: no files found matching '*.txt' 12:51:07 INFO - no previously-included directories found matching 'build' 12:51:07 INFO - no previously-included directories found matching 'dist' 12:51:07 INFO - no previously-included directories found matching '.git*' 12:51:07 INFO - Installing collected packages: jsonschema, functools32 12:51:07 INFO - Running setup.py install for functools32 12:51:07 INFO - warning: no files found matching '*.txt' 12:51:07 INFO - no previously-included directories found matching 'build' 12:51:07 INFO - no previously-included directories found matching 'dist' 12:51:07 INFO - no previously-included directories found matching '.git*' 12:51:07 INFO - Successfully installed jsonschema functools32 12:51:07 INFO - Cleaning up... 12:51:07 INFO - Return code: 0 12:51:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f863acfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', '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 12:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:51:07 INFO - Using env: {'DISPLAY': ':0', 12:51:07 INFO - 'HOME': '/home/cltbld', 12:51:07 INFO - 'LANG': 'en_US.UTF-8', 12:51:07 INFO - 'LANGUAGE': 'en_US:en', 12:51:07 INFO - 'LOGNAME': 'cltbld', 12:51:07 INFO - 'MAIL': '/var/mail/cltbld', 12:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:07 INFO - 'MOZ_NO_REMOTE': '1', 12:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:07 INFO - 'NO_EM_RESTART': '1', 12:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:07 INFO - 'PWD': '/builds/slave/test', 12:51:07 INFO - 'SHELL': '/bin/bash', 12:51:07 INFO - 'SHLVL': '1', 12:51:07 INFO - 'TERM': 'linux', 12:51:07 INFO - 'TMOUT': '86400', 12:51:07 INFO - 'USER': 'cltbld', 12:51:07 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', 12:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:07 INFO - '_': '/tools/buildbot/bin/python'} 12:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:08 INFO - Downloading/unpacking flake8 12:51:08 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 12:51:08 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 12:51:08 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 12:51:08 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 12:51:08 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 12:51:08 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 12:51:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:51:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:51:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:51:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:10 INFO - no previously-included directories found matching 'docs/_build' 12:51:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:51:10 INFO - Running setup.py install for pep8 12:51:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:10 INFO - no previously-included directories found matching 'docs/_build' 12:51:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:51:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:51:10 INFO - Cleaning up... 12:51:10 INFO - Return code: 0 12:51:10 INFO - Running post-action listener: _resource_record_post_action 12:51:10 INFO - Running post-action listener: _start_resource_monitoring 12:51:10 INFO - Starting resource monitoring. 12:51:10 INFO - ##### 12:51:10 INFO - ##### Running install step. 12:51:10 INFO - ##### 12:51:10 INFO - Running pre-action listener: _resource_record_pre_action 12:51:10 INFO - Running main action method: install 12:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:11 INFO - Reading from file tmpfile_stdout 12:51:11 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:11 INFO - Reading from file tmpfile_stdout 12:51:11 INFO - Output received: 12:51:11 INFO - Usage: mozinstall [options] installer 12:51:11 INFO - Options: 12:51:11 INFO - -h, --help show this help message and exit 12:51:11 INFO - -d DEST, --destination=DEST 12:51:11 INFO - Directory to install application into. [default: 12:51:11 INFO - "/builds/slave/test"] 12:51:11 INFO - --app=APP Application being installed. [default: firefox] 12:51:11 INFO - mkdir: /builds/slave/test/build/application 12:51:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:51:24 INFO - Reading from file tmpfile_stdout 12:51:24 INFO - Output received: 12:51:24 INFO - /builds/slave/test/build/application/firefox/firefox 12:51:24 INFO - Running post-action listener: _resource_record_post_action 12:51:24 INFO - ##### 12:51:24 INFO - ##### Running run-tests step. 12:51:24 INFO - ##### 12:51:24 INFO - Running pre-action listener: _resource_record_pre_action 12:51:24 INFO - Running main action method: run_tests 12:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:24 INFO - Python 2.7.3 12:51:24 INFO - Return code: 0 12:51:24 INFO - grabbing minidump binary from tooltool 12:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:24 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 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:24 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 12:51:24 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 12:51:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:24 INFO - Return code: 0 12:51:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:51:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:51:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:51:25 INFO - Return code: 0 12:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 12:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 12:51:25 INFO - Using env: {'DISPLAY': ':0', 12:51:25 INFO - 'HOME': '/home/cltbld', 12:51:25 INFO - 'LANG': 'en_US.UTF-8', 12:51:25 INFO - 'LANGUAGE': 'en_US:en', 12:51:25 INFO - 'LOGNAME': 'cltbld', 12:51:25 INFO - 'MAIL': '/var/mail/cltbld', 12:51:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:25 INFO - 'MOZ_NO_REMOTE': '1', 12:51:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:25 INFO - 'NO_EM_RESTART': '1', 12:51:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:25 INFO - 'PWD': '/builds/slave/test', 12:51:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:25 INFO - 'SHELL': '/bin/bash', 12:51:25 INFO - 'SHLVL': '1', 12:51:25 INFO - 'TERM': 'linux', 12:51:25 INFO - 'TMOUT': '86400', 12:51:25 INFO - 'USER': 'cltbld', 12:51:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024', 12:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:25 INFO - '_': '/tools/buildbot/bin/python'} 12:51:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 12:51:25 INFO - mozversion application_buildid: 20160609095529 12:51:25 INFO - mozversion application_changeset: a23a6103b9bef3d80874d74e2278ee47b458ed87 12:51:25 INFO - mozversion application_display_name: Firefox 12:51:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:25 INFO - mozversion application_name: Firefox 12:51:25 INFO - mozversion application_remotingname: firefox 12:51:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:51:25 INFO - mozversion application_vendor: Mozilla 12:51:25 INFO - mozversion application_version: 48.0 12:51:25 INFO - mozversion platform_buildid: 20160609095529 12:51:25 INFO - mozversion platform_changeset: a23a6103b9bef3d80874d74e2278ee47b458ed87 12:51:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:51:25 INFO - mozversion platform_version: 48.0 12:51:25 INFO - using testdate: 1465501885 12:51:25 INFO - actual date: 1465501885 12:51:25 INFO - starting webserver on 'localhost:60723' 12:51:25 INFO - SUITE-START | Running 2 tests 12:51:25 INFO - TEST-START | dromaeo_css 12:51:25 INFO - operating with platform_type : linux_ 12:51:25 INFO - Initialising browser for dromaeo_css test... 12:51:25 INFO - TEST-INFO | started process 28763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3nC1Ks/profile http://localhost:60723/getInfo.html) 12:51:29 INFO - PROCESS | 28763 | __metrics Screen width/height:1600/1200 12:51:29 INFO - PROCESS | 28763 | colorDepth:24 12:51:29 INFO - PROCESS | 28763 | Browser inner width/height: 1024/697 12:51:29 INFO - PROCESS | 28763 | __metrics 12:51:30 ERROR - PROCESS | 28763 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:51:31 INFO - TEST-INFO | 28763: exit 0 12:51:31 INFO - Browser initialized. 12:51:31 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:31 INFO - TEST-INFO | started process 28856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3nC1Ks/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:42 INFO - PROCESS | 28856 | RSS: Main: 141475840 12:51:42 INFO - PROCESS | 28856 | 12:52:33 INFO - PROCESS | 28856 | 1465501953976 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] 12:54:41 INFO - PROCESS | 28856 | Cycle 1(1): loaded http://localhost:60723/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60723/tests/dromaeo/cssquery-ext.html) 12:54:42 INFO - PROCESS | 28856 | RSS: Main: 251412480 12:54:42 INFO - PROCESS | 28856 | 12:57:44 INFO - PROCESS | 28856 | Cycle 1(1): loaded http://localhost:60723/tests/dromaeo/cssquery-ext.html (next: http://localhost:60723/tests/dromaeo/cssquery-jquery.html) 12:57:45 INFO - PROCESS | 28856 | RSS: Main: 224382976 12:57:45 INFO - PROCESS | 28856 | 13:00:46 INFO - PROCESS | 28856 | Cycle 1(1): loaded http://localhost:60723/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60723/tests/dromaeo/cssquery-mootools.html) 13:00:47 INFO - PROCESS | 28856 | RSS: Main: 221380608 13:00:47 INFO - PROCESS | 28856 | 13:03:49 INFO - PROCESS | 28856 | Cycle 1(1): loaded http://localhost:60723/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60723/tests/dromaeo/cssquery-prototype.html) 13:03:49 INFO - PROCESS | 28856 | RSS: Main: 226275328 13:03:49 INFO - PROCESS | 28856 | 13:06:52 INFO - PROCESS | 28856 | Cycle 1(1): loaded http://localhost:60723/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60723/tests/dromaeo/cssquery-yui.html) 13:06:52 INFO - PROCESS | 28856 | RSS: Main: 210247680 13:06:52 INFO - PROCESS | 28856 | 13:09:55 INFO - PROCESS | 28856 | Cycle 1(1): loaded http://localhost:60723/tests/dromaeo/cssquery-yui.html (next: http://localhost:60723/tests/dromaeo/cssquery-dojo.html) 13:09:55 INFO - PROCESS | 28856 | RSS: Main: 257613824 13:09:55 INFO - PROCESS | 28856 | 13:09:55 INFO - PROCESS | 28856 | __start_tp_report 13:09:55 INFO - PROCESS | 28856 | _x_x_mozilla_page_load 13:09:55 INFO - PROCESS | 28856 | _x_x_mozilla_page_load_details 13:09:55 INFO - PROCESS | 28856 | |i|pagename|runs| 13:09:55 INFO - PROCESS | 28856 | |0;dojo.html;3316.7014968652825;3352.7317814574853;3353.949690754638;3387.1532116970757;3407.7273818094554;5500.752466139023;5506.862328441791;5511.448855114487;5520.723963801814;5527.91708124378;5520.779168833242;5522.392536820947;5534.916976245359;5535.308086489189;5566.443355664432;4988.127077761377;5024.145895197807;5112.130937740574;5153.252778347138;5169.974150129263;5037.722925239111;5096.8470945871495;5139.691618502883;5139.820106296281;5146.974265128669;5080.720560369178;5113.411957624883;5180.715060671661;5201.323827902367;5205.9219111713355;5072.315237442935;5076.390833100052;5078.8476345709505;5083.110455670261;5109.054824857413;4959;4959.256111583255;4965.751712414365;5023.598112151019;5025.497450254945;5470.753816078286;5471.534919531845;5501.202325662796;5514.310711161105;5523.696196709179;5970.880582388328;6000.879982400327;6003.219581454427;6006.039033754579;6006.069059295816;6071.058985857199;6090.147379366892;6106.267247930276;6108.938910610881;6120.510359171256;5657.8585535361535;5688.118341657008;5714.685692286923;5745;5751.683657398841;5929.940700592939;6192.783252586138;6218.31598524162;6219;6225.750969961151;5805.419458054245;5881.823545293648;5893.587448878623;5901.498372638373;5906.084556893688;5913.615614985012;5915.349311575723;5916.970415147983;5921.644701317935;5928.911066334009;5842.912356314659;5885.882282354414;5887.264091988502;5900.1149827526215;5918.141869428909;5991.850203744942;6028.065649824284;6034.275886893601;6036.9698151508965;6074.331823499411;4571.81712731487;4585.839495617637;4588.174128656807;4592.8622141335145;4614.676972611885;4011.2779699654343;4043.4743483347565;4074.5110586729784;4106.897327566835;4114.053767633461;5638.295213098363;5658.660480371191;5659.773609055674;5662.518685911661;5697.715114244271;5969.582129250911;5971.9701401493585;5974.910376344358;5980.192673988956;5993.850153746104;5532.917006244909;5634.887302253932;5702.515286200636;5792.82621521355;5805.448482394166;4930.802767889244;4957.3307603473795;4957.90084198314;4961.206207006861;4976.303317535548;6111.84720381994;6111.96944015277;6122.265328160649;6122.6938653068055;6135.417135372222;5862.8534286642325;6034.39656034393;6125.295591007091;6125.632272693224;6141.578063794062;6119.541034422525;6121.4025061109405;6123.496151642784;6125.481123985487;6163.938360616516;5806.071028635398;5822.214001109796;5822.475977162076;5822.796202132905;5840.065589505659;5874.676892770939;5892.145638882424;5930.199423077829;5931.703414829155;5967.104934259895;5832.9708351457975;5860.531157507475;5881.588288819913;5884.735186916685;5888.528917686661;5736.397678243724;5807.970960145341;5866.120081987736;5918.496927761188;5931.584789064724;5769.480746732646;5789.247397838422;5791.305043394819;5794.420557944172;5829.941700583109;5900.911486327623;5902.675352855463;5904.468597826216;5909.5863289569315;5911.290645122613;5690.061139911868;5777.74000169985;5779;5823.563232757645;5858.677772722541 13:09:55 INFO - PROCESS | 28856 | |1;ext.html;653.3988730368061;686.6017709728358;687.9587224766515;746.4252525555322;765.9429986618466;33888.322233555315;34540.827295863484;34627.65372346276;34636.1340966476;40017.7999110004;44065;44627.77686111573;44681.77659111708;44707.329390059094;44744.3288350675;8791.164839340252;8967.596458159398;8986.505742184178;8993.550322483883;8994.640214391417;8739.213470787628;8855.557222138867;8855.645774169025;8856.822863542726;8869.467831930106;8833.293336533094;8899.866502002475;8918.821623567525;9135.817283654324;9141.817163656722;8861.069587693297;8865.202131808168;8890.911090889105;8897.599608017623;8902.910970890272;9002.27981761464;9082.545872706405;9112.908870911338;9117.635294588208;9118.635254589808;43572.346414803804;44382.33426498605;44436.11127777426;44575;44582;3777.225668737902;3836.4437156612134;3878.631530004645;3880.825362858678;3884.0484081399954;34006;34594.69171416302;34824.47763283553;35019.824900875334;35046.649533504846;4364.301711726109;4366.912661746779;4367.170237654836;4387.802548885308;4422.15978963999;333114;333875.99999999756;334195;334221;334314;39817.80091099584;60445.395546044856;61530.69234653798;61545;61568.69215653983;40106.799466002485;40519;40630.1873962525;40636.79681601632;40665;17821.198046087957;18109.36617218391;18150.727739083923;18169.7274540882;18174;14579.271036448135;14585.635359116108;14624;14638.048526845721;14645.560633181021;9467.905320946702;9471.337006409485;9563.665271715456;9572.808543829224;9575.281853860988;3635.8909232723063;3653.159773252167;3663;3665.450182472597;3770.7737535747942;1131.5813149134872;1134.5541401274018;1137.2721458266717;1178.4107946026986;1218.713602303458;34537;34647.55435189219;34859.477107843406;34946.30107397838;35158.64841351554;1265.8417697787777;1311.9868801311866;1356.7422189783908;1361.8706222908809;1409.26718106584;17677.55806104832;18241.814282071624;18369.448916532525;18378.540536486697;18410.81589184091;476747;481348;481664;482396;483158;63549.36450635527;64293.35706642874;64331.35668643347;64331.67834160799;64371.356286437476;1442.8052212951327;1527.2669118823028;1575.3304845440641;1619.7651340555553;1645.5968287769574;29878;30684.84657576698;30863.382732345675;32035;32122.839385802923;46712.76643616896;47044.7647761759;47345.76327118342;47470;47494;260646;262029;262129;262760;263144;28226.2943426416;31027.53458698076;31116.22209444782;31651.841740791147;31954.20114497156;43727.78136109426;44012;44200.55799441964;44670;44817.77591112023;41095.38356924589;41232;41858.58141418669;42034.369484458366;42539.57460425356;39643.405348920365;40343.596564033985;40390.17233602902;41351.58648413477;41515.37726934038;42800.78599606982;43041.354379684955;45046.0990780176;45055;45509.54490455053;32332.35335293328;34030.31939361149;34656.82671586626;37314.25371492609;38036.42945355877;28916.855415722788;29204;29207.269818254714;29375.090186244197;29410.852945735136 13:09:55 INFO - PROCESS | 28856 | |2;jquery.html;409.67635567901357;419.702011571784;430.70711915897175;441.94696636403637;446.265892606662;14673.559793206221;18277.26890924363;18812.811871881277;18847.71728424073;19570.21719131233;16257.23806811653;18408.171632276546;19130.234790608392;19635.90182049091;20450.181992720274;5759.913601295973;5878.265216847894;5894.145348924403;5905.645661260338;5915.822525324225;5917.408259174092;5961.374055724152;5965.970170149165;5969.074793407029;5972.283326000865;5936.109583562478;5938.52491800657;5941;6101.328853826098;6413.1342268793815;6460.806175814733;6469.223693156828;6484.027395890655;6502.869942601145;6504.544681872248;5702.429757024306;5753.856153596152;5784.334801497839;5861.677607731573;5880.7353669085;14091.647708807259;14439.855601443956;14473;14500.637484062878;14540.781888271684;2480.4790993891306;2492.2024952015363;2546.134314333117;2710.864456777173;3065.20304720772;10330.7417314567;10346.79306413875;10709.625163119254;10786.244962852603;10918;2145;2155.1594877997595;2165.631842586764;2171.7393912730417;2190.255313193506;78348.60825695835;78573.49985501017;79958;81571.5921420389;84750.72873906959;11099.667009989713;11706.824397634042;11805.232659877252;11854.288742675468;11902.345371004678;16607.3357065716;16779.664406711796;16785.91607041957;16786;16792.328306867832;9079.137481939206;9242.16820486146;9244.815103697889;9328.300377471582;9410.717678469657;9153.95423022894;9238.76903077415;9267.212286955684;9363.485008324471;9384.67153649619;4589;5043.773030213649;5141.460146684619;5182.818601348935;5195.402528709171;1989.637512603695;2074.802893725094;2136.2736669532433;2151.6234658934623;2156.3207589609224;1022.1260821997234;1036.6475398364591;1121.2263538158645;1134.7390100276982;1148.1102145837044;18696;18783.530411739543;18843.152058157415;18845.811541884406;19254.807451925302;1099.378850949211;1126.7295848996182;1127.2898074213192;1156.9826452603218;1164.7670465906851;10781.407022613676;10965.890341096487;11010.779784404267;11060.723481913017;11078.50440190564;494016;500905;510576;520058;520522;93920.53039734894;96037.5198124019;97226.51386743021;98275.50862245786;98563.13994868014;1089.2103225161695;1113.654767022242;1118.3904771899333;1121.394446998628;1141.5148561861342;16568.254428550987;16666.74999875027;16725.462740771276;16883.155842208085;16976.490705278862;38555;39844;40213.798931005156;40255.1948961025;40730;51138.23292650688;52012.73993630159;54523.72738136284;58365.70817146057;62339.37660623336;8223.583996324294;8561.143885611638;8661.52361620117;8757;8832.735017949472;11296.209265351346;12373.505059797508;12707.555235566711;12723.55467558668;12859.485620575073;10684.305520141166;10706.89293107059;10709;11160.665180044612;11325.830112548154;10827.891721083004;10851.457427128455;10853.782924341627;10906.072983796148;11009.339439633328;10969.890301096886;11382.089432845518;11490.253133546294;11524.94237528807;11602.361870097226;8613.69852055175;8613.870791938001;8694.304455643407;8732;8860.911390886009;8729.3889427742;11321;12038.277703337828;12149.514019439124;12261.14172007951 13:09:55 INFO - PROCESS | 28856 | |3;mootools.html;1407.8873690104792;1567.4043863331933;1587.4205914841084;1819.3359423810314;1923.8941858197793;8366;8555.743327700164;8578.828423431536;8588.699395521166;8601.655933762657;8525.57372131394;8582.184692454206;8673.045964943867;8689.956550217255;8700.303975681945;2438.573249681303;2457.287386657867;2462.5198086373166;2473.530029294437;2487.987560062197;2490.2155820916446;2545.338212064867;2553.246792196297;2563.0901030134314;2565.307367010906;2416.915407960722;2421.443068094339;2490.638857365681;2492.22740950306;2494.164454907608;2451.2891261534132;2472.258322503251;2478.479519300949;2484.2671411933525;2487.092211342865;2499.4376265340334;2525.8863351149243;2540.314115188907;2542.656741339914;2544.1349941019957;8377.916220837775;8546.31629469641;8875.73372798817;8881.156290152425;8935.508547029911;5546.556275497991;5612.15817627355;5625.6905870177125;5671.319441667027;5673.3475650299915;3671.9816400918094;3721.5720192177973;3758.718096142773;3788.1476667749534;3804.6766024887916;1125.983110253347;1204.915655904087;1218.1290377380217;1267.5943698016638;1299.2204677193702;12335.074869384833;12760.489580416772;12828.743425131539;12835.165714228639;12847.614571562868;4640.83757068501;4718.7168769873915;4767.521384464474;4793.832215872428;4857.611391088704;9958.502074896227;9962.103410693073;9990.100890919706;10026.498675066217;10039.749006274755;5440.129579267298;5464.836054918359;5470.261514695545;5472.863178420492;5482.588805839578;4537.410136682211;4971.055499455092;5023.34696489454;5091.032703786343;5138.871528211825;3964.4251583520227;3976.622220889011;4042.8989275268355;4055.391691246278;4094.5873673582564;1229.065909908458;1237.5111830826772;1245.2901845947904;1255.9623211303676;1256.6418570707306;974.3569244298728;1083.0685610375072;1085.375908852413;1087.1140020882956;1098.5056724474018;6270.2789179244055;6396;6522.641254731036;6530.869382612321;6534.4445722113205;1039.745262410699;1069.8074346617527;1085.2511766880828;1111.155521803419;1158.5713286084203;4389.18800021997;4414.483091931862;4453.1316393303;4487.708298960557;4505.053938672915;10852.511636976355;11071.114310855111;11165.609203677996;11180.10559155282;11184.161187910939;10908.290961087503;10973;10973.561057557768;10976.725581860517;10984.450777461096;8108.310793582612;8331.20853518927;8340.207680270365;8556.229939305493;8644.78388040304;6220.440160385587;6228.377162283736;6280.717367718555;6354.841128971812;6412.743490260524;9629.711108666752;9687.854682179914;9762.414255144715;9830.705078847646;9839.114479696575;9573.090556397132;9976.551055202388;10084;10282.640107596199;10286.897131028893;6843.452523797984;6852.725890964306;7899.921000789918;8020.238077382639;8077.919220807717;8463.195996380335;8588.914110858812;8590.91409085901;8596.398252122292;8603.870941936002;7572.39420846342;7807.297343239135;7838.255365740246;7923.286904178652;7975.003124609424;7347.448941329315;7458.813529661802;7476.663550140148;7483.139438964588;7533.886991695239;7116.43068554504;7135.072440582691;7178;7197.208307086321;7197.46019048563;5120.257562653469;5277.709725965109;5312.468753124656;5346.652467589594;5431.891362172813;5460.972695136499;5471.72641367938;5500.119980803052;5519.668819870821;5521.585881059017 13:09:55 INFO - PROCESS | 28856 | |4;prototype.html;352.9064797828575;354.9858005679773;356.7431449356462;360.5187075254537;362.20676717987624;6149.969250153748;6189.102580125885;6190.876182476348;6192.349803270659;6217.968910155454;6133.907991380132;6144.446999770031;6144.631322120676;6148.907766383508;6154.476869466101;4521.593056624912;4625.121226966882;4632.768361581908;4653.7440440775745;4654.511276315989;4721.716696998191;4726.929096063544;4756.096341695084;4756.524347565233;4773.307870358796;4685.976570117145;4692.929606055912;4704.929426058612;4714.4578373486975;4718.315844202589;4540.8637740867825;4569.702969306984;4709.152352576535;4712.387389639325;4722.1028004679;4147.398627199039;4155.397467367245;4157.854475093387;4168.7290326128705;4171.0615111599645;5902.6458412495385;5904.911426328608;5909.409059094056;5911.349751527328;5925.792597259076;5455.072637651609;5470;5472.2338872557875;5479.205515200274;5481.177823326493;6461.19235095613;6470.967645161792;6472.773452929172;6477.255115661665;6479.870402591969;4530.614897733697;4614.30785382192;4617.422822147231;4640.5127461616385;4649.907001859944;6730.125083739132;6752.257251702309;6753.392194702451;6753.898691519631;6755.594664320157;4728.3143944127905;4730.597899178609;4737.407824021997;4743.691660042086;4751.477337492873;4801.18379875422;4803.231482962709;4811.061842940663;4811.230203167476;4812.302216178635;5480.314960629921;5484.506394424521;5486.6982315973;5492.533134683516;5494.148406996922;6365.49076073913;6389.8722025560155;6478.481721462272;6514.4462720668325;6514.771982980573;1659.5353301075718;1663.7421199714063;1675.31312162013;1675.5057258108886;1677.8154403015658;1061.3313612424124;1106.303029091667;1116.4361997191365;1129.2095533126844;1132.2131118872305;6188.412100850412;6362.809115726535;6371.904421433682;6378.138951241615;6380.7447702091395;6671.39957403836;6702.899456508157;6723.865522689519;6741.685371352539;6745.763898263537;6296.937030629727;6300.527460440394;6338.080978258219;6353.174087368612;6361.363863613602;3576.91057723559;3591.06632275605;3596.2088340565033;3602.8919132426067;3614;6841.589504629738;6967.512274140761;6990.895136572955;7013.89479157813;7017.649117544102;6803.319668033256;6843.726250950006;6852.45180385568;6852.931470685329;6862.656867156622;6983.406410455066;6983.999999999898;6985.057017302701;6988.510804243654;6992.475564332695;6665.833354166185;6684.799456016327;6706.93293067063;6714.462842972648;6719.664016799238;6490.610563366213;6610.9669451652435;6624.205095388585;6634.170728658918;6641.468682505291;6942.652867356511;6985.1617805863625;6987.161540615159;6993.125859267591;6997.405220556309;4735.266033764772;4735.384400027974;4737.38414006177;4738.502457242078;4743.383360163157;6679.465642748665;6687.398134167948;6691.431228345645;6702.597844129368;6709.36261055199;6298.401651843067;6482.092507049111;6505.51208659343;6508.316626754312;6527;6449.871002579828;6460.515461340512;6468.579542329733;6469.676516174267;6474.773382931763;6300.873982520232;6356.141920840627;6360.554761166674;6362.172917520693;6444.097826304415;6538.574992625464;6550.508711846726;6556.409923106943;6567.9671601641685;6576.112224849584;6236.503239222463;6367.204099487564;6388.488920886225;6424.678766061772;6428.132202152837 13:09:55 INFO - PROCESS | 28856 | |5;yui.html;924.2790623313817;928.4800511713441;935.5602866652672;957.9521023948801;958.1759686669459;15187.164705941168;15550.922245388785;15613.68772624547;15648.295826687798;15649.843501564981;14392.49626263081;14469.204193769365;14501.49244776433;14507.637309067279;14883.553493395188;899.0335389456344;912.6303846941966;914.5884352041575;916.1983264643437;916.972490825273;902.1339514066505;918.9035151309116;919.6045700348848;919.7056941778634;920.1534588178858;960.3085778239691;960.4957397366404;963.3930623707055;963.5471328475605;964.2286171063156;956.5838860095846;958;958.4249450329781;958.750724811547;959.2997112108166;701.9684114214822;704.0214102397671;704.1761139466836;705.1643802094534;705.5343473307593;14692.338844752012;14701.1914344711;14717.55847324582;14746.11523308605;14769.33537990793;12524.311162886037;12694.873051269462;12725.745485090247;12807.06927832791;12907.290099044549;11633.36016519091;11827.231229970024;11880.287182769061;11930.164888457812;12007.639770806889;3918.5101862267215;3983.8008099594904;4007.939880901789;4053.5541090480024;4074.1444296697728;49756.50243497591;49963.25055124176;55285.72357138189;58797.412025879625;59626.701866490825;12122.818157727641;12225.755484890431;12450.688732781753;12671.619851404472;12737;21748.565028699337;21779.346619601438;21783.12867485283;21816.236431724814;21827.345179644635;8975.865362019575;9050.456972581665;9121.087891210958;9128.680496182602;9323.533823308808;4770.457289390417;5058.468860769566;5086.364204474441;5310.787568497217;5397.10947693634;3575.3921833288405;3624.873129440457;3625.510556074896;3627.4558816177782;3627.782333060025;668.4919461209419;672.862063277027;678.1794029224595;685.5372623479132;690.9412699920563;717.6878058044767;727.1201845766682;731.0658405028303;736.120336198238;763.3015790551583;9303.76740581491;9745.53491428224;9750.956242917899;9989.150922171551;10008.149307308815;663.2869665110026;699.930006999296;704.7110684619385;708.8121647763244;715.4955756191872;4393.121375724868;4478.798454069574;4486.730796152241;4513.729176249435;4652.906941861143;59429.108563371585;61310.69344653248;67403;67443.66278168578;67887.66056169687;57355.42644573501;57386.13920791192;58188.12717809236;58385.70807145937;58660.41339586635;52821.2076818848;52885.2067218992;52951.73524132355;53115;53545.73227133839;8871;8999.460032398078;9284.489353085644;9335.579898904702;9495.38280011797;39193.80403097966;40531.79734101311;40934;41903;41942.58057419387;51582.48417515927;51610.48389516207;52221.47778522318;52673.209901850736;52814;13042.54351097745;13075.738485230433;13089.738205235652;13263.32827112135;13292.40184191733;14253.928730356281;14777.630559236106;14994.625134371729;15045.322960467025;15489.690206195588;12698.619041428772;12739.29933853647;12744.61766147017;12808.423620936894;13044.608661740163;13255.270960096901;13294.800577991144;13440.462381505022;13707;13723.519676811264;12849.421776019915;13066.150700204456;13072.738545228853;13492.190468571916;13760.793588096387;11258.099352051653;11259.493322800658;11382.772344552897;11564.884351156381;12155.331456769962;10721.785564288515;11299.152563557931;11328.32030078198;11479.942600286946;11584 13:09:55 INFO - PROCESS | 28856 | __end_tp_report 13:09:55 INFO - PROCESS | 28856 | __start_cc_report 13:09:55 INFO - PROCESS | 28856 | _x_x_mozilla_cycle_collect,839 13:09:55 INFO - PROCESS | 28856 | __end_cc_report 13:09:55 INFO - PROCESS | 28856 | __startTimestamp1465502995353__endTimestamp 13:09:55 INFO - PROCESS | 28856 | 13:09:55 INFO - PROCESS | 28856 | ------- Summary: start ------- 13:09:55 INFO - PROCESS | 28856 | Number of tests: 6 13:09:55 INFO - PROCESS | 28856 | 13:09:55 INFO - PROCESS | 28856 | [#0] dojo.html Cycles:165 Average:5552.51 Median:5805.42 stddev:621.66 (10.7%) stddev-sans-first:598.31 13:09:55 INFO - PROCESS | 28856 | Values: 3316.7 3352.7 3353.9 3387.2 3407.7 5500.8 5506.9 5511.4 5520.7 5527.9 5520.8 5522.4 5534.9 5535.3 5566.4 4988.1 5024.1 5112.1 5153.3 5170.0 5037.7 5096.8 5139.7 5139.8 5147.0 5080.7 5113.4 5180.7 5201.3 5205.9 5072.3 5076.4 5078.8 5083.1 5109.1 4959.0 4959.3 4965.8 5023.6 5025.5 5470.8 5471.5 5501.2 5514.3 5523.7 5970.9 6000.9 6003.2 6006.0 6006.1 6071.1 6090.1 6106.3 6108.9 6120.5 5657.9 5688.1 5714.7 5745.0 5751.7 5929.9 6192.8 6218.3 6219.0 6225.8 5805.4 5881.8 5893.6 5901.5 5906.1 5913.6 5915.3 5917.0 5921.6 5928.9 5842.9 5885.9 5887.3 5900.1 5918.1 5991.9 6028.1 6034.3 6037.0 6074.3 4571.8 4585.8 4588.2 4592.9 4614.7 4011.3 4043.5 4074.5 4106.9 4114.1 5638.3 5658.7 5659.8 5662.5 5697.7 5969.6 5972.0 5974.9 5980.2 5993.9 5532.9 5634.9 5702.5 5792.8 5805.4 4930.8 4957.3 4957.9 4961.2 4976.3 6111.8 6112.0 6122.3 6122.7 6135.4 5862.9 6034.4 6125.3 6125.6 6141.6 6119.5 6121.4 6123.5 6125.5 6163.9 5806.1 5822.2 5822.5 5822.8 5840.1 5874.7 5892.1 5930.2 5931.7 5967.1 5833.0 5860.5 5881.6 5884.7 5888.5 5736.4 5808.0 5866.1 5918.5 5931.6 5769.5 5789.2 5791.3 5794.4 5829.9 5900.9 5902.7 5904.5 5909.6 5911.3 5690.1 5777.7 5779.0 5823.6 5858.7 13:09:55 INFO - PROCESS | 28856 | 13:09:55 INFO - PROCESS | 28856 | [#1] ext.html Cycles:180 Average:52756.30 Median:40574.59 stddev:97907.24 (241.3%) stddev-sans-first:98103.74 13:09:55 INFO - PROCESS | 28856 | Values: 653.4 686.6 688.0 746.4 765.9 33888.3 34540.8 34627.7 34636.1 40017.8 44065.0 44627.8 44681.8 44707.3 44744.3 8791.2 8967.6 8986.5 8993.6 8994.6 8739.2 8855.6 8855.6 8856.8 8869.5 8833.3 8899.9 8918.8 9135.8 9141.8 8861.1 8865.2 8890.9 8897.6 8902.9 9002.3 9082.5 9112.9 9117.6 9118.6 43572.3 44382.3 44436.1 44575.0 44582.0 3777.2 3836.4 3878.6 3880.8 3884.0 34006.0 34594.7 34824.5 35019.8 35046.6 4364.3 4366.9 4367.2 4387.8 4422.2 333114.0 333876.0 334195.0 334221.0 334314.0 39817.8 60445.4 61530.7 61545.0 61568.7 40106.8 40519.0 40630.2 40636.8 40665.0 17821.2 18109.4 18150.7 18169.7 18174.0 14579.3 14585.6 14624.0 14638.0 14645.6 9467.9 9471.3 9563.7 9572.8 9575.3 3635.9 3653.2 3663.0 3665.5 3770.8 1131.6 1134.6 1137.3 1178.4 1218.7 34537.0 34647.6 34859.5 34946.3 35158.6 1265.8 1312.0 1356.7 1361.9 1409.3 17677.6 18241.8 18369.4 18378.5 18410.8 476747.0 481348.0 481664.0 482396.0 483158.0 63549.4 64293.4 64331.4 64331.7 64371.4 1442.8 1527.3 1575.3 1619.8 1645.6 29878.0 30684.8 30863.4 32035.0 32122.8 46712.8 47044.8 47345.8 47470.0 47494.0 260646.0 262029.0 262129.0 262760.0 263144.0 28226.3 31027.5 31116.2 31651.8 31954.2 43727.8 44012.0 44200.6 44670.0 44817.8 41095.4 41232.0 41858.6 42034.4 42539.6 39643.4 40343.6 40390.2 41351.6 41515.4 42800.8 43041.4 45046.1 45055.0 45509.5 32332.4 34030.3 34656.8 37314.3 38036.4 28916.9 29204.0 29207.3 29375.1 29410.9 13:09:55 INFO - PROCESS | 28856 | 13:09:55 INFO - PROCESS | 28856 | [#2] jquery.html Cycles:180 Average:29383.33 Median:2160.98 stddev:83949.52 (3884.8%) stddev-sans-first:84156.83 13:09:55 INFO - PROCESS | 28856 | Values: 409.7 419.7 430.7 441.9 446.3 14673.6 18277.3 18812.8 18847.7 19570.2 16257.2 18408.2 19130.2 19635.9 20450.2 5759.9 5878.3 5894.1 5905.6 5915.8 5917.4 5961.4 5966.0 5969.1 5972.3 5936.1 5938.5 5941.0 6101.3 6413.1 6460.8 6469.2 6484.0 6502.9 6504.5 5702.4 5753.9 5784.3 5861.7 5880.7 14091.6 14439.9 14473.0 14500.6 14540.8 2480.5 2492.2 2546.1 2710.9 3065.2 10330.7 10346.8 10709.6 10786.2 10918.0 2145.0 2155.2 2165.6 2171.7 2190.3 78348.6 78573.5 79958.0 81571.6 84750.7 11099.7 11706.8 11805.2 11854.3 11902.3 16607.3 16779.7 16785.9 16786.0 16792.3 9079.1 9242.2 9244.8 9328.3 9410.7 9154.0 9238.8 9267.2 9363.5 9384.7 4589.0 5043.8 5141.5 5182.8 5195.4 1989.6 2074.8 2136.3 2151.6 2156.3 1022.1 1036.6 1121.2 1134.7 1148.1 18696.0 18783.5 18843.2 18845.8 19254.8 1099.4 1126.7 1127.3 1157.0 1164.8 10781.4 10965.9 11010.8 11060.7 11078.5 494016.0 500905.0 510576.0 520058.0 520522.0 93920.5 96037.5 97226.5 98275.5 98563.1 1089.2 1113.7 1118.4 1121.4 1141.5 16568.3 16666.7 16725.5 16883.2 16976.5 38555.0 39844.0 40213.8 40255.2 40730.0 51138.2 52012.7 54523.7 58365.7 62339.4 8223.6 8561.1 8661.5 8757.0 8832.7 11296.2 12373.5 12707.6 12723.6 12859.5 10684.3 10706.9 10709.0 11160.7 11325.8 10827.9 10851.5 10853.8 10906.1 11009.3 10969.9 11382.1 11490.3 11524.9 11602.4 8613.7 8613.9 8694.3 8732.0 8860.9 8729.4 11321.0 12038.3 12149.5 12261.1 13:09:55 INFO - PROCESS | 28856 | 13:09:55 INFO - PROCESS | 28856 | [#3] mootools.html Cycles:180 Average:5909.47 Median:4997.20 stddev:3233.87 (64.7%) stddev-sans-first:3225.24 13:09:55 INFO - PROCESS | 28856 | Values: 1407.9 1567.4 1587.4 1819.3 1923.9 8366.0 8555.7 8578.8 8588.7 8601.7 8525.6 8582.2 8673.0 8690.0 8700.3 2438.6 2457.3 2462.5 2473.5 2488.0 2490.2 2545.3 2553.2 2563.1 2565.3 2416.9 2421.4 2490.6 2492.2 2494.2 2451.3 2472.3 2478.5 2484.3 2487.1 2499.4 2525.9 2540.3 2542.7 2544.1 8377.9 8546.3 8875.7 8881.2 8935.5 5546.6 5612.2 5625.7 5671.3 5673.3 3672.0 3721.6 3758.7 3788.1 3804.7 1126.0 1204.9 1218.1 1267.6 1299.2 12335.1 12760.5 12828.7 12835.2 12847.6 4640.8 4718.7 4767.5 4793.8 4857.6 9958.5 9962.1 9990.1 10026.5 10039.7 5440.1 5464.8 5470.3 5472.9 5482.6 4537.4 4971.1 5023.3 5091.0 5138.9 3964.4 3976.6 4042.9 4055.4 4094.6 1229.1 1237.5 1245.3 1256.0 1256.6 974.4 1083.1 1085.4 1087.1 1098.5 6270.3 6396.0 6522.6 6530.9 6534.4 1039.7 1069.8 1085.3 1111.2 1158.6 4389.2 4414.5 4453.1 4487.7 4505.1 10852.5 11071.1 11165.6 11180.1 11184.2 10908.3 10973.0 10973.6 10976.7 10984.5 8108.3 8331.2 8340.2 8556.2 8644.8 6220.4 6228.4 6280.7 6354.8 6412.7 9629.7 9687.9 9762.4 9830.7 9839.1 9573.1 9976.6 10084.0 10282.6 10286.9 6843.5 6852.7 7899.9 8020.2 8077.9 8463.2 8588.9 8590.9 8596.4 8603.9 7572.4 7807.3 7838.3 7923.3 7975.0 7347.4 7458.8 7476.7 7483.1 7533.9 7116.4 7135.1 7178.0 7197.2 7197.5 5120.3 5277.7 5312.5 5346.7 5431.9 5461.0 5471.7 5500.1 5519.7 5521.6 13:09:55 INFO - PROCESS | 28856 | 13:09:55 INFO - PROCESS | 28856 | [#4] prototype.html Cycles:180 Average:5465.50 Median:6227.24 stddev:1630.74 (26.2%) stddev-sans-first:1589.52 13:09:55 INFO - PROCESS | 28856 | Values: 352.9 355.0 356.7 360.5 362.2 6150.0 6189.1 6190.9 6192.3 6218.0 6133.9 6144.4 6144.6 6148.9 6154.5 4521.6 4625.1 4632.8 4653.7 4654.5 4721.7 4726.9 4756.1 4756.5 4773.3 4686.0 4692.9 4704.9 4714.5 4718.3 4540.9 4569.7 4709.2 4712.4 4722.1 4147.4 4155.4 4157.9 4168.7 4171.1 5902.6 5904.9 5909.4 5911.3 5925.8 5455.1 5470.0 5472.2 5479.2 5481.2 6461.2 6471.0 6472.8 6477.3 6479.9 4530.6 4614.3 4617.4 4640.5 4649.9 6730.1 6752.3 6753.4 6753.9 6755.6 4728.3 4730.6 4737.4 4743.7 4751.5 4801.2 4803.2 4811.1 4811.2 4812.3 5480.3 5484.5 5486.7 5492.5 5494.1 6365.5 6389.9 6478.5 6514.4 6514.8 1659.5 1663.7 1675.3 1675.5 1677.8 1061.3 1106.3 1116.4 1129.2 1132.2 6188.4 6362.8 6371.9 6378.1 6380.7 6671.4 6702.9 6723.9 6741.7 6745.8 6296.9 6300.5 6338.1 6353.2 6361.4 3576.9 3591.1 3596.2 3602.9 3614.0 6841.6 6967.5 6990.9 7013.9 7017.6 6803.3 6843.7 6852.5 6852.9 6862.7 6983.4 6984.0 6985.1 6988.5 6992.5 6665.8 6684.8 6706.9 6714.5 6719.7 6490.6 6611.0 6624.2 6634.2 6641.5 6942.7 6985.2 6987.2 6993.1 6997.4 4735.3 4735.4 4737.4 4738.5 4743.4 6679.5 6687.4 6691.4 6702.6 6709.4 6298.4 6482.1 6505.5 6508.3 6527.0 6449.9 6460.5 6468.6 6469.7 6474.8 6300.9 6356.1 6360.6 6362.2 6444.1 6538.6 6550.5 6556.4 6568.0 6576.1 6236.5 6367.2 6388.5 6424.7 6428.1 13:09:55 INFO - PROCESS | 28856 | 13:09:55 INFO - PROCESS | 28856 | [#5] yui.html Cycles:180 Average:15844.31 Median:4711.68 stddev:18209.16 (386.5%) stddev-sans-first:18225.77 13:09:55 INFO - PROCESS | 28856 | Values: 924.3 928.5 935.6 958.0 958.2 15187.2 15550.9 15613.7 15648.3 15649.8 14392.5 14469.2 14501.5 14507.6 14883.6 899.0 912.6 914.6 916.2 917.0 902.1 918.9 919.6 919.7 920.2 960.3 960.5 963.4 963.5 964.2 956.6 958.0 958.4 958.8 959.3 702.0 704.0 704.2 705.2 705.5 14692.3 14701.2 14717.6 14746.1 14769.3 12524.3 12694.9 12725.7 12807.1 12907.3 11633.4 11827.2 11880.3 11930.2 12007.6 3918.5 3983.8 4007.9 4053.6 4074.1 49756.5 49963.3 55285.7 58797.4 59626.7 12122.8 12225.8 12450.7 12671.6 12737.0 21748.6 21779.3 21783.1 21816.2 21827.3 8975.9 9050.5 9121.1 9128.7 9323.5 4770.5 5058.5 5086.4 5310.8 5397.1 3575.4 3624.9 3625.5 3627.5 3627.8 668.5 672.9 678.2 685.5 690.9 717.7 727.1 731.1 736.1 763.3 9303.8 9745.5 9751.0 9989.2 10008.1 663.3 699.9 704.7 708.8 715.5 4393.1 4478.8 4486.7 4513.7 4652.9 59429.1 61310.7 67403.0 67443.7 67887.7 57355.4 57386.1 58188.1 58385.7 58660.4 52821.2 52885.2 52951.7 53115.0 53545.7 8871.0 8999.5 9284.5 9335.6 9495.4 39193.8 40531.8 40934.0 41903.0 41942.6 51582.5 51610.5 52221.5 52673.2 52814.0 13042.5 13075.7 13089.7 13263.3 13292.4 14253.9 14777.6 14994.6 15045.3 15489.7 12698.6 12739.3 12744.6 12808.4 13044.6 13255.3 13294.8 13440.5 13707.0 13723.5 12849.4 13066.2 13072.7 13492.2 13760.8 11258.1 11259.5 11382.8 11564.9 12155.3 10721.8 11299.2 11328.3 11479.9 11584.0 13:09:55 INFO - PROCESS | 28856 | -------- Summary: end -------- 13:09:55 INFO - PROCESS | 28856 | 13:09:56 INFO - TEST-INFO | 28856: exit 0 13:09:56 INFO - TEST-OK | dromaeo_css | took 1110420ms 13:09:56 INFO - TEST-START | kraken 13:09:56 INFO - operating with platform_type : linux_ 13:09:56 INFO - Initialising browser for kraken test... 13:09:56 INFO - TEST-INFO | started process 29046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVHajzk/profile http://localhost:60723/getInfo.html) 13:09:59 INFO - PROCESS | 29046 | __metrics Screen width/height:1600/1200 13:09:59 INFO - PROCESS | 29046 | colorDepth:24 13:09:59 INFO - PROCESS | 29046 | Browser inner width/height: 1024/697 13:09:59 INFO - PROCESS | 29046 | __metrics 13:10:00 ERROR - PROCESS | 29046 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:10:01 INFO - TEST-INFO | 29046: exit 0 13:10:01 INFO - Browser initialized. 13:10:01 INFO - Running cycle 1/1 for kraken test... 13:10:01 INFO - TEST-INFO | started process 29135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVHajzk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:13 INFO - PROCESS | 29135 | RSS: Main: 140869632 13:10:13 INFO - PROCESS | 29135 | 13:10:15 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60723/tests/kraken/driver.html?testName=audio-beat-detection) 13:10:16 INFO - PROCESS | 29135 | RSS: Main: 196947968 13:10:16 INFO - PROCESS | 29135 | 13:10:19 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60723/tests/kraken/driver.html?testName=audio-dft) 13:10:19 INFO - PROCESS | 29135 | RSS: Main: 183345152 13:10:19 INFO - PROCESS | 29135 | 13:10:22 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60723/tests/kraken/driver.html?testName=audio-fft) 13:10:23 INFO - PROCESS | 29135 | RSS: Main: 272637952 13:10:23 INFO - PROCESS | 29135 | 13:10:25 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60723/tests/kraken/driver.html?testName=audio-oscillator) 13:10:25 INFO - PROCESS | 29135 | RSS: Main: 178823168 13:10:25 INFO - PROCESS | 29135 | 13:10:27 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60723/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:10:28 INFO - PROCESS | 29135 | RSS: Main: 177479680 13:10:28 INFO - PROCESS | 29135 | 13:10:31 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60723/tests/kraken/driver.html?testName=imaging-darkroom) 13:10:32 INFO - PROCESS | 29135 | RSS: Main: 212111360 13:10:32 INFO - PROCESS | 29135 | 13:10:35 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60723/tests/kraken/driver.html?testName=imaging-desaturate) 13:10:35 INFO - PROCESS | 29135 | RSS: Main: 211955712 13:10:35 INFO - PROCESS | 29135 | 13:10:38 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60723/tests/kraken/driver.html?testName=json-parse-financial) 13:10:39 INFO - PROCESS | 29135 | RSS: Main: 211951616 13:10:39 INFO - PROCESS | 29135 | 13:10:40 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60723/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:10:41 INFO - PROCESS | 29135 | RSS: Main: 190980096 13:10:41 INFO - PROCESS | 29135 | 13:10:43 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60723/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:10:43 INFO - PROCESS | 29135 | RSS: Main: 194252800 13:10:43 INFO - PROCESS | 29135 | 13:10:45 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60723/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:10:46 INFO - PROCESS | 29135 | RSS: Main: 207962112 13:10:46 INFO - PROCESS | 29135 | 13:10:48 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:10:49 INFO - PROCESS | 29135 | RSS: Main: 216694784 13:10:49 INFO - PROCESS | 29135 | 13:10:51 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:10:52 INFO - PROCESS | 29135 | RSS: Main: 214323200 13:10:52 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | Cycle 1(1): loaded http://localhost:60723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60723/tests/kraken/driver.html?testName=ai-astar) 13:10:54 INFO - PROCESS | 29135 | RSS: Main: 275775488 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | __start_tp_report 13:10:54 INFO - PROCESS | 29135 | _x_x_mozilla_page_load 13:10:54 INFO - PROCESS | 29135 | _x_x_mozilla_page_load_details 13:10:54 INFO - PROCESS | 29135 | |i|pagename|runs| 13:10:54 INFO - PROCESS | 29135 | |0;ai-astar;110;111;111;112;110;111;106;108;109;110 13:10:54 INFO - PROCESS | 29135 | |1;audio-beat-detection;153;126;150;173;125;157;152;134;179;125 13:10:54 INFO - PROCESS | 29135 | |2;audio-dft;161;160;161;162;162;159;159;160;160;160 13:10:54 INFO - PROCESS | 29135 | |3;audio-fft;75;75;77;171;74;77;73;76;169;76 13:10:54 INFO - PROCESS | 29135 | |4;audio-oscillator;92;92;155;93;93;92;151;94;93;151 13:10:54 INFO - PROCESS | 29135 | |5;imaging-gaussian-blur;116;117;116;122;116;116;117;117;117;118 13:10:54 INFO - PROCESS | 29135 | |6;imaging-darkroom;146;146;146;147;145;145;146;147;145;145 13:10:54 INFO - PROCESS | 29135 | |7;imaging-desaturate;95;94;95;94;94;94;94;95;94;94 13:10:54 INFO - PROCESS | 29135 | |8;json-parse-financial;59;55;53;53;54;55;55;67;52;52 13:10:54 INFO - PROCESS | 29135 | |9;json-stringify-tinderbox;59;60;59;60;58;59;59;59;59;59 13:10:54 INFO - PROCESS | 29135 | |10;stanford-crypto-aes;72;72;70;71;73;73;74;73;80;72 13:10:54 INFO - PROCESS | 29135 | |11;stanford-crypto-ccm;114;114;111;112;118;112;111;111;130;114 13:10:54 INFO - PROCESS | 29135 | |12;stanford-crypto-pbkdf2;155;158;157;166;156;154;154;155;154;153 13:10:54 INFO - PROCESS | 29135 | |13;stanford-crypto-sha256-iterative;67;67;67;67;65;74;64;66;67;64 13:10:54 INFO - PROCESS | 29135 | __end_tp_report 13:10:54 INFO - PROCESS | 29135 | __start_cc_report 13:10:54 INFO - PROCESS | 29135 | _x_x_mozilla_cycle_collect,1560 13:10:54 INFO - PROCESS | 29135 | __end_cc_report 13:10:54 INFO - PROCESS | 29135 | __startTimestamp1465503054431__endTimestamp 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | ------- Summary: start ------- 13:10:54 INFO - PROCESS | 29135 | Number of tests: 14 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:1.75 (1.6%) stddev-sans-first:1.86 13:10:54 INFO - PROCESS | 29135 | Values: 110.0 111.0 111.0 112.0 110.0 111.0 106.0 108.0 109.0 110.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:152.50 stddev:19.57 (12.8%) stddev-sans-first:20.65 13:10:54 INFO - PROCESS | 29135 | Values: 153.0 126.0 150.0 173.0 125.0 157.0 152.0 134.0 179.0 125.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 13:10:54 INFO - PROCESS | 29135 | Values: 161.0 160.0 161.0 162.0 162.0 159.0 159.0 160.0 160.0 160.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:39.92 (52.9%) stddev-sans-first:41.73 13:10:54 INFO - PROCESS | 29135 | Values: 75.0 75.0 77.0 171.0 74.0 77.0 73.0 76.0 169.0 76.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:92.50 stddev:28.83 (31.2%) stddev-sans-first:29.78 13:10:54 INFO - PROCESS | 29135 | Values: 92.0 92.0 155.0 93.0 93.0 92.0 151.0 94.0 93.0 151.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:1.81 (1.6%) stddev-sans-first:1.87 13:10:54 INFO - PROCESS | 29135 | Values: 116.0 117.0 116.0 122.0 116.0 116.0 117.0 117.0 117.0 118.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 13:10:54 INFO - PROCESS | 29135 | Values: 146.0 146.0 146.0 147.0 145.0 145.0 146.0 147.0 145.0 145.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:10:54 INFO - PROCESS | 29135 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:4.53 (8.2%) stddev-sans-first:4.62 13:10:54 INFO - PROCESS | 29135 | Values: 59.0 55.0 53.0 53.0 54.0 55.0 55.0 67.0 52.0 52.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 13:10:54 INFO - PROCESS | 29135 | Values: 59.0 60.0 59.0 60.0 58.0 59.0 59.0 59.0 59.0 59.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:2.71 (3.7%) stddev-sans-first:2.85 13:10:54 INFO - PROCESS | 29135 | Values: 72.0 72.0 70.0 71.0 73.0 73.0 74.0 73.0 80.0 72.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#11] stanford-crypto-ccm Cycles:10 Average:114.70 Median:114.00 stddev:5.79 (5.1%) stddev-sans-first:6.14 13:10:54 INFO - PROCESS | 29135 | Values: 114.0 114.0 111.0 112.0 118.0 112.0 111.0 111.0 130.0 114.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:155.50 stddev:3.77 (2.4%) stddev-sans-first:3.97 13:10:54 INFO - PROCESS | 29135 | Values: 155.0 158.0 157.0 166.0 156.0 154.0 154.0 155.0 154.0 153.0 13:10:54 INFO - PROCESS | 29135 | 13:10:54 INFO - PROCESS | 29135 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:2.82 (4.2%) stddev-sans-first:2.99 13:10:54 INFO - PROCESS | 29135 | Values: 67.0 67.0 67.0 67.0 65.0 74.0 64.0 66.0 67.0 64.0 13:10:54 INFO - PROCESS | 29135 | -------- Summary: end -------- 13:10:54 INFO - PROCESS | 29135 | 13:10:55 INFO - TEST-INFO | 29135: exit 0 13:10:55 INFO - TEST-OK | kraken | took 59262ms 13:10:55 INFO - SUITE-END | took 1169s 13:10:55 INFO - Completed test suite (00:19:29) 13:10:55 INFO - javascript benchmark 13:10:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.7014968652825, 3352.7317814574853, 3353.949690754638, 3387.1532116970757, 3407.7273818094554, 5500.752466139023, 5506.862328441791, 5511.448855114487, 5520.723963801814, 5527.91708124378, 5520.779168833242, 5522.392536820947, 5534.916976245359, 5535.308086489189, 5566.443355664432, 4988.127077761377, 5024.145895197807, 5112.130937740574, 5153.252778347138, 5169.974150129263, 5037.722925239111, 5096.8470945871495, 5139.691618502883, 5139.820106296281, 5146.974265128669, 5080.720560369178, 5113.411957624883, 5180.715060671661, 5201.323827902367, 5205.9219111713355, 5072.315237442935, 5076.390833100052, 5078.8476345709505, 5083.110455670261, 5109.054824857413, 4959.0, 4959.256111583255, 4965.751712414365, 5023.598112151019, 5025.497450254945, 5470.753816078286, 5471.534919531845, 5501.202325662796, 5514.310711161105, 5523.696196709179, 5970.880582388328, 6000.879982400327, 6003.219581454427, 6006.039033754579, 6006.069059295816, 6071.058985857199, 6090.147379366892, 6106.267247930276, 6108.938910610881, 6120.510359171256, 5657.8585535361535, 5688.118341657008, 5714.685692286923, 5745.0, 5751.683657398841, 5929.940700592939, 6192.783252586138, 6218.31598524162, 6219.0, 6225.750969961151, 5805.419458054245, 5881.823545293648, 5893.587448878623, 5901.498372638373, 5906.084556893688, 5913.615614985012, 5915.349311575723, 5916.970415147983, 5921.644701317935, 5928.911066334009, 5842.912356314659, 5885.882282354414, 5887.264091988502, 5900.1149827526215, 5918.141869428909, 5991.850203744942, 6028.065649824284, 6034.275886893601, 6036.9698151508965, 6074.331823499411, 4571.81712731487, 4585.839495617637, 4588.174128656807, 4592.8622141335145, 4614.676972611885, 4011.2779699654343, 4043.4743483347565, 4074.5110586729784, 4106.897327566835, 4114.053767633461, 5638.295213098363, 5658.660480371191, 5659.773609055674, 5662.518685911661, 5697.715114244271, 5969.582129250911, 5971.9701401493585, 5974.910376344358, 5980.192673988956, 5993.850153746104, 5532.917006244909, 5634.887302253932, 5702.515286200636, 5792.82621521355, 5805.448482394166, 4930.802767889244, 4957.3307603473795, 4957.90084198314, 4961.206207006861, 4976.303317535548, 6111.84720381994, 6111.96944015277, 6122.265328160649, 6122.6938653068055, 6135.417135372222, 5862.8534286642325, 6034.39656034393, 6125.295591007091, 6125.632272693224, 6141.578063794062, 6119.541034422525, 6121.4025061109405, 6123.496151642784, 6125.481123985487, 6163.938360616516, 5806.071028635398, 5822.214001109796, 5822.475977162076, 5822.796202132905, 5840.065589505659, 5874.676892770939, 5892.145638882424, 5930.199423077829, 5931.703414829155, 5967.104934259895, 5832.9708351457975, 5860.531157507475, 5881.588288819913, 5884.735186916685, 5888.528917686661, 5736.397678243724, 5807.970960145341, 5866.120081987736, 5918.496927761188, 5931.584789064724, 5769.480746732646, 5789.247397838422, 5791.305043394819, 5794.420557944172, 5829.941700583109, 5900.911486327623, 5902.675352855463, 5904.468597826216, 5909.5863289569315, 5911.290645122613, 5690.061139911868, 5777.74000169985, 5779.0, 5823.563232757645, 5858.677772722541], "value": 5511.846790878728, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.3988730368061, 686.6017709728358, 687.9587224766515, 746.4252525555322, 765.9429986618466, 33888.322233555315, 34540.827295863484, 34627.65372346276, 34636.1340966476, 40017.7999110004, 44065.0, 44627.77686111573, 44681.77659111708, 44707.329390059094, 44744.3288350675, 8791.164839340252, 8967.596458159398, 8986.505742184178, 8993.550322483883, 8994.640214391417, 8739.213470787628, 8855.557222138867, 8855.645774169025, 8856.822863542726, 8869.467831930106, 8833.293336533094, 8899.866502002475, 8918.821623567525, 9135.817283654324, 9141.817163656722, 8861.069587693297, 8865.202131808168, 8890.911090889105, 8897.599608017623, 8902.910970890272, 9002.27981761464, 9082.545872706405, 9112.908870911338, 9117.635294588208, 9118.635254589808, 43572.346414803804, 44382.33426498605, 44436.11127777426, 44575.0, 44582.0, 3777.225668737902, 3836.4437156612134, 3878.631530004645, 3880.825362858678, 3884.0484081399954, 34006.0, 34594.69171416302, 34824.47763283553, 35019.824900875334, 35046.649533504846, 4364.301711726109, 4366.912661746779, 4367.170237654836, 4387.802548885308, 4422.15978963999, 333114.0, 333875.99999999756, 334195.0, 334221.0, 334314.0, 39817.80091099584, 60445.395546044856, 61530.69234653798, 61545.0, 61568.69215653983, 40106.799466002485, 40519.0, 40630.1873962525, 40636.79681601632, 40665.0, 17821.198046087957, 18109.36617218391, 18150.727739083923, 18169.7274540882, 18174.0, 14579.271036448135, 14585.635359116108, 14624.0, 14638.048526845721, 14645.560633181021, 9467.905320946702, 9471.337006409485, 9563.665271715456, 9572.808543829224, 9575.281853860988, 3635.8909232723063, 3653.159773252167, 3663.0, 3665.450182472597, 3770.7737535747942, 1131.5813149134872, 1134.5541401274018, 1137.2721458266717, 1178.4107946026986, 1218.713602303458, 34537.0, 34647.55435189219, 34859.477107843406, 34946.30107397838, 35158.64841351554, 1265.8417697787777, 1311.9868801311866, 1356.7422189783908, 1361.8706222908809, 1409.26718106584, 17677.55806104832, 18241.814282071624, 18369.448916532525, 18378.540536486697, 18410.81589184091, 476747.0, 481348.0, 481664.0, 482396.0, 483158.0, 63549.36450635527, 64293.35706642874, 64331.35668643347, 64331.67834160799, 64371.356286437476, 1442.8052212951327, 1527.2669118823028, 1575.3304845440641, 1619.7651340555553, 1645.5968287769574, 29878.0, 30684.84657576698, 30863.382732345675, 32035.0, 32122.839385802923, 46712.76643616896, 47044.7647761759, 47345.76327118342, 47470.0, 47494.0, 260646.0, 262029.0, 262129.0, 262760.0, 263144.0, 28226.2943426416, 31027.53458698076, 31116.22209444782, 31651.841740791147, 31954.20114497156, 43727.78136109426, 44012.0, 44200.55799441964, 44670.0, 44817.77591112023, 41095.38356924589, 41232.0, 41858.58141418669, 42034.369484458366, 42539.57460425356, 39643.405348920365, 40343.596564033985, 40390.17233602902, 41351.58648413477, 41515.37726934038, 42800.78599606982, 43041.354379684955, 45046.0990780176, 45055.0, 45509.54490455053, 32332.35335293328, 34030.31939361149, 34656.82671586626, 37314.25371492609, 38036.42945355877, 28916.855415722788, 29204.0, 29207.269818254714, 29375.090186244197, 29410.852945735136], "value": 19405.10632729609, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.67635567901357, 419.702011571784, 430.70711915897175, 441.94696636403637, 446.265892606662, 14673.559793206221, 18277.26890924363, 18812.811871881277, 18847.71728424073, 19570.21719131233, 16257.23806811653, 18408.171632276546, 19130.234790608392, 19635.90182049091, 20450.181992720274, 5759.913601295973, 5878.265216847894, 5894.145348924403, 5905.645661260338, 5915.822525324225, 5917.408259174092, 5961.374055724152, 5965.970170149165, 5969.074793407029, 5972.283326000865, 5936.109583562478, 5938.52491800657, 5941.0, 6101.328853826098, 6413.1342268793815, 6460.806175814733, 6469.223693156828, 6484.027395890655, 6502.869942601145, 6504.544681872248, 5702.429757024306, 5753.856153596152, 5784.334801497839, 5861.677607731573, 5880.7353669085, 14091.647708807259, 14439.855601443956, 14473.0, 14500.637484062878, 14540.781888271684, 2480.4790993891306, 2492.2024952015363, 2546.134314333117, 2710.864456777173, 3065.20304720772, 10330.7417314567, 10346.79306413875, 10709.625163119254, 10786.244962852603, 10918.0, 2145.0, 2155.1594877997595, 2165.631842586764, 2171.7393912730417, 2190.255313193506, 78348.60825695835, 78573.49985501017, 79958.0, 81571.5921420389, 84750.72873906959, 11099.667009989713, 11706.824397634042, 11805.232659877252, 11854.288742675468, 11902.345371004678, 16607.3357065716, 16779.664406711796, 16785.91607041957, 16786.0, 16792.328306867832, 9079.137481939206, 9242.16820486146, 9244.815103697889, 9328.300377471582, 9410.717678469657, 9153.95423022894, 9238.76903077415, 9267.212286955684, 9363.485008324471, 9384.67153649619, 4589.0, 5043.773030213649, 5141.460146684619, 5182.818601348935, 5195.402528709171, 1989.637512603695, 2074.802893725094, 2136.2736669532433, 2151.6234658934623, 2156.3207589609224, 1022.1260821997234, 1036.6475398364591, 1121.2263538158645, 1134.7390100276982, 1148.1102145837044, 18696.0, 18783.530411739543, 18843.152058157415, 18845.811541884406, 19254.807451925302, 1099.378850949211, 1126.7295848996182, 1127.2898074213192, 1156.9826452603218, 1164.7670465906851, 10781.407022613676, 10965.890341096487, 11010.779784404267, 11060.723481913017, 11078.50440190564, 494016.0, 500905.0, 510576.0, 520058.0, 520522.0, 93920.53039734894, 96037.5198124019, 97226.51386743021, 98275.50862245786, 98563.13994868014, 1089.2103225161695, 1113.654767022242, 1118.3904771899333, 1121.394446998628, 1141.5148561861342, 16568.254428550987, 16666.74999875027, 16725.462740771276, 16883.155842208085, 16976.490705278862, 38555.0, 39844.0, 40213.798931005156, 40255.1948961025, 40730.0, 51138.23292650688, 52012.73993630159, 54523.72738136284, 58365.70817146057, 62339.37660623336, 8223.583996324294, 8561.143885611638, 8661.52361620117, 8757.0, 8832.735017949472, 11296.209265351346, 12373.505059797508, 12707.555235566711, 12723.55467558668, 12859.485620575073, 10684.305520141166, 10706.89293107059, 10709.0, 11160.665180044612, 11325.830112548154, 10827.891721083004, 10851.457427128455, 10853.782924341627, 10906.072983796148, 11009.339439633328, 10969.890301096886, 11382.089432845518, 11490.253133546294, 11524.94237528807, 11602.361870097226, 8613.69852055175, 8613.870791938001, 8694.304455643407, 8732.0, 8860.911390886009, 8729.3889427742, 11321.0, 12038.277703337828, 12149.514019439124, 12261.14172007951], "value": 9406.08802296107, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.8873690104792, 1567.4043863331933, 1587.4205914841084, 1819.3359423810314, 1923.8941858197793, 8366.0, 8555.743327700164, 8578.828423431536, 8588.699395521166, 8601.655933762657, 8525.57372131394, 8582.184692454206, 8673.045964943867, 8689.956550217255, 8700.303975681945, 2438.573249681303, 2457.287386657867, 2462.5198086373166, 2473.530029294437, 2487.987560062197, 2490.2155820916446, 2545.338212064867, 2553.246792196297, 2563.0901030134314, 2565.307367010906, 2416.915407960722, 2421.443068094339, 2490.638857365681, 2492.22740950306, 2494.164454907608, 2451.2891261534132, 2472.258322503251, 2478.479519300949, 2484.2671411933525, 2487.092211342865, 2499.4376265340334, 2525.8863351149243, 2540.314115188907, 2542.656741339914, 2544.1349941019957, 8377.916220837775, 8546.31629469641, 8875.73372798817, 8881.156290152425, 8935.508547029911, 5546.556275497991, 5612.15817627355, 5625.6905870177125, 5671.319441667027, 5673.3475650299915, 3671.9816400918094, 3721.5720192177973, 3758.718096142773, 3788.1476667749534, 3804.6766024887916, 1125.983110253347, 1204.915655904087, 1218.1290377380217, 1267.5943698016638, 1299.2204677193702, 12335.074869384833, 12760.489580416772, 12828.743425131539, 12835.165714228639, 12847.614571562868, 4640.83757068501, 4718.7168769873915, 4767.521384464474, 4793.832215872428, 4857.611391088704, 9958.502074896227, 9962.103410693073, 9990.100890919706, 10026.498675066217, 10039.749006274755, 5440.129579267298, 5464.836054918359, 5470.261514695545, 5472.863178420492, 5482.588805839578, 4537.410136682211, 4971.055499455092, 5023.34696489454, 5091.032703786343, 5138.871528211825, 3964.4251583520227, 3976.622220889011, 4042.8989275268355, 4055.391691246278, 4094.5873673582564, 1229.065909908458, 1237.5111830826772, 1245.2901845947904, 1255.9623211303676, 1256.6418570707306, 974.3569244298728, 1083.0685610375072, 1085.375908852413, 1087.1140020882956, 1098.5056724474018, 6270.2789179244055, 6396.0, 6522.641254731036, 6530.869382612321, 6534.4445722113205, 1039.745262410699, 1069.8074346617527, 1085.2511766880828, 1111.155521803419, 1158.5713286084203, 4389.18800021997, 4414.483091931862, 4453.1316393303, 4487.708298960557, 4505.053938672915, 10852.511636976355, 11071.114310855111, 11165.609203677996, 11180.10559155282, 11184.161187910939, 10908.290961087503, 10973.0, 10973.561057557768, 10976.725581860517, 10984.450777461096, 8108.310793582612, 8331.20853518927, 8340.207680270365, 8556.229939305493, 8644.78388040304, 6220.440160385587, 6228.377162283736, 6280.717367718555, 6354.841128971812, 6412.743490260524, 9629.711108666752, 9687.854682179914, 9762.414255144715, 9830.705078847646, 9839.114479696575, 9573.090556397132, 9976.551055202388, 10084.0, 10282.640107596199, 10286.897131028893, 6843.452523797984, 6852.725890964306, 7899.921000789918, 8020.238077382639, 8077.919220807717, 8463.195996380335, 8588.914110858812, 8590.91409085901, 8596.398252122292, 8603.870941936002, 7572.39420846342, 7807.297343239135, 7838.255365740246, 7923.286904178652, 7975.003124609424, 7347.448941329315, 7458.813529661802, 7476.663550140148, 7483.139438964588, 7533.886991695239, 7116.43068554504, 7135.072440582691, 7178.0, 7197.208307086321, 7197.46019048563, 5120.257562653469, 5277.709725965109, 5312.468753124656, 5346.652467589594, 5431.891362172813, 5460.972695136499, 5471.72641367938, 5500.119980803052, 5519.668819870821, 5521.585881059017], "value": 4810.719970594304, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.9064797828575, 354.9858005679773, 356.7431449356462, 360.5187075254537, 362.20676717987624, 6149.969250153748, 6189.102580125885, 6190.876182476348, 6192.349803270659, 6217.968910155454, 6133.907991380132, 6144.446999770031, 6144.631322120676, 6148.907766383508, 6154.476869466101, 4521.593056624912, 4625.121226966882, 4632.768361581908, 4653.7440440775745, 4654.511276315989, 4721.716696998191, 4726.929096063544, 4756.096341695084, 4756.524347565233, 4773.307870358796, 4685.976570117145, 4692.929606055912, 4704.929426058612, 4714.4578373486975, 4718.315844202589, 4540.8637740867825, 4569.702969306984, 4709.152352576535, 4712.387389639325, 4722.1028004679, 4147.398627199039, 4155.397467367245, 4157.854475093387, 4168.7290326128705, 4171.0615111599645, 5902.6458412495385, 5904.911426328608, 5909.409059094056, 5911.349751527328, 5925.792597259076, 5455.072637651609, 5470.0, 5472.2338872557875, 5479.205515200274, 5481.177823326493, 6461.19235095613, 6470.967645161792, 6472.773452929172, 6477.255115661665, 6479.870402591969, 4530.614897733697, 4614.30785382192, 4617.422822147231, 4640.5127461616385, 4649.907001859944, 6730.125083739132, 6752.257251702309, 6753.392194702451, 6753.898691519631, 6755.594664320157, 4728.3143944127905, 4730.597899178609, 4737.407824021997, 4743.691660042086, 4751.477337492873, 4801.18379875422, 4803.231482962709, 4811.061842940663, 4811.230203167476, 4812.302216178635, 5480.314960629921, 5484.506394424521, 5486.6982315973, 5492.533134683516, 5494.148406996922, 6365.49076073913, 6389.8722025560155, 6478.481721462272, 6514.4462720668325, 6514.771982980573, 1659.5353301075718, 1663.7421199714063, 1675.31312162013, 1675.5057258108886, 1677.8154403015658, 1061.3313612424124, 1106.303029091667, 1116.4361997191365, 1129.2095533126844, 1132.2131118872305, 6188.412100850412, 6362.809115726535, 6371.904421433682, 6378.138951241615, 6380.7447702091395, 6671.39957403836, 6702.899456508157, 6723.865522689519, 6741.685371352539, 6745.763898263537, 6296.937030629727, 6300.527460440394, 6338.080978258219, 6353.174087368612, 6361.363863613602, 3576.91057723559, 3591.06632275605, 3596.2088340565033, 3602.8919132426067, 3614.0, 6841.589504629738, 6967.512274140761, 6990.895136572955, 7013.89479157813, 7017.649117544102, 6803.319668033256, 6843.726250950006, 6852.45180385568, 6852.931470685329, 6862.656867156622, 6983.406410455066, 6983.999999999898, 6985.057017302701, 6988.510804243654, 6992.475564332695, 6665.833354166185, 6684.799456016327, 6706.93293067063, 6714.462842972648, 6719.664016799238, 6490.610563366213, 6610.9669451652435, 6624.205095388585, 6634.170728658918, 6641.468682505291, 6942.652867356511, 6985.1617805863625, 6987.161540615159, 6993.125859267591, 6997.405220556309, 4735.266033764772, 4735.384400027974, 4737.38414006177, 4738.502457242078, 4743.383360163157, 6679.465642748665, 6687.398134167948, 6691.431228345645, 6702.597844129368, 6709.36261055199, 6298.401651843067, 6482.092507049111, 6505.51208659343, 6508.316626754312, 6527.0, 6449.871002579828, 6460.515461340512, 6468.579542329733, 6469.676516174267, 6474.773382931763, 6300.873982520232, 6356.141920840627, 6360.554761166674, 6362.172917520693, 6444.097826304415, 6538.574992625464, 6550.508711846726, 6556.409923106943, 6567.9671601641685, 6576.112224849584, 6236.503239222463, 6367.204099487564, 6388.488920886225, 6424.678766061772, 6428.132202152837], "value": 4938.030069024962, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [924.2790623313817, 928.4800511713441, 935.5602866652672, 957.9521023948801, 958.1759686669459, 15187.164705941168, 15550.922245388785, 15613.68772624547, 15648.295826687798, 15649.843501564981, 14392.49626263081, 14469.204193769365, 14501.49244776433, 14507.637309067279, 14883.553493395188, 899.0335389456344, 912.6303846941966, 914.5884352041575, 916.1983264643437, 916.972490825273, 902.1339514066505, 918.9035151309116, 919.6045700348848, 919.7056941778634, 920.1534588178858, 960.3085778239691, 960.4957397366404, 963.3930623707055, 963.5471328475605, 964.2286171063156, 956.5838860095846, 958.0, 958.4249450329781, 958.750724811547, 959.2997112108166, 701.9684114214822, 704.0214102397671, 704.1761139466836, 705.1643802094534, 705.5343473307593, 14692.338844752012, 14701.1914344711, 14717.55847324582, 14746.11523308605, 14769.33537990793, 12524.311162886037, 12694.873051269462, 12725.745485090247, 12807.06927832791, 12907.290099044549, 11633.36016519091, 11827.231229970024, 11880.287182769061, 11930.164888457812, 12007.639770806889, 3918.5101862267215, 3983.8008099594904, 4007.939880901789, 4053.5541090480024, 4074.1444296697728, 49756.50243497591, 49963.25055124176, 55285.72357138189, 58797.412025879625, 59626.701866490825, 12122.818157727641, 12225.755484890431, 12450.688732781753, 12671.619851404472, 12737.0, 21748.565028699337, 21779.346619601438, 21783.12867485283, 21816.236431724814, 21827.345179644635, 8975.865362019575, 9050.456972581665, 9121.087891210958, 9128.680496182602, 9323.533823308808, 4770.457289390417, 5058.468860769566, 5086.364204474441, 5310.787568497217, 5397.10947693634, 3575.3921833288405, 3624.873129440457, 3625.510556074896, 3627.4558816177782, 3627.782333060025, 668.4919461209419, 672.862063277027, 678.1794029224595, 685.5372623479132, 690.9412699920563, 717.6878058044767, 727.1201845766682, 731.0658405028303, 736.120336198238, 763.3015790551583, 9303.76740581491, 9745.53491428224, 9750.956242917899, 9989.150922171551, 10008.149307308815, 663.2869665110026, 699.930006999296, 704.7110684619385, 708.8121647763244, 715.4955756191872, 4393.121375724868, 4478.798454069574, 4486.730796152241, 4513.729176249435, 4652.906941861143, 59429.108563371585, 61310.69344653248, 67403.0, 67443.66278168578, 67887.66056169687, 57355.42644573501, 57386.13920791192, 58188.12717809236, 58385.70807145937, 58660.41339586635, 52821.2076818848, 52885.2067218992, 52951.73524132355, 53115.0, 53545.73227133839, 8871.0, 8999.460032398078, 9284.489353085644, 9335.579898904702, 9495.38280011797, 39193.80403097966, 40531.79734101311, 40934.0, 41903.0, 41942.58057419387, 51582.48417515927, 51610.48389516207, 52221.47778522318, 52673.209901850736, 52814.0, 13042.54351097745, 13075.738485230433, 13089.738205235652, 13263.32827112135, 13292.40184191733, 14253.928730356281, 14777.630559236106, 14994.625134371729, 15045.322960467025, 15489.690206195588, 12698.619041428772, 12739.29933853647, 12744.61766147017, 12808.423620936894, 13044.608661740163, 13255.270960096901, 13294.800577991144, 13440.462381505022, 13707.0, 13723.519676811264, 12849.421776019915, 13066.150700204456, 13072.738545228853, 13492.190468571916, 13760.793588096387, 11258.099352051653, 11259.493322800658, 11382.772344552897, 11564.884351156381, 12155.331456769962, 10721.785564288515, 11299.152563557931, 11328.32030078198, 11479.942600286946, 11584.0], "value": 7243.3874920708395, "unit": "score"}], "name": "dromaeo_css", "value": 7465.5309680242135, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 112.0, 110.0, 111.0, 106.0, 108.0, 109.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 150.0, 173.0, 125.0, 157.0, 152.0, 134.0, 179.0, 125.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 162.0, 159.0, 159.0, 160.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 171.0, 74.0, 77.0, 73.0, 76.0, 169.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 155.0, 93.0, 93.0, 92.0, 151.0, 94.0, 93.0, 151.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 122.0, 116.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 146.0, 147.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 53.0, 53.0, 54.0, 55.0, 55.0, 67.0, 52.0, 52.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 70.0, 71.0, 73.0, 73.0, 74.0, 73.0, 80.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 111.0, 112.0, 118.0, 112.0, 111.0, 111.0, 130.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 158.0, 157.0, 166.0, 156.0, 154.0, 154.0, 155.0, 154.0, 153.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 65.0, 74.0, 64.0, 66.0, 67.0, 64.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1505.1, "alertThreshold": 2.0}]} 13:10:55 INFO - Return code: 0 13:10:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:10:55 ERROR - # TBPL SUCCESS # 13:10:55 INFO - Running post-action listener: _resource_record_post_action 13:10:55 INFO - Running post-run listener: _resource_record_post_run 13:10:56 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 453574656; Read time: 12; Write time: 562964 13:10:56 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 242556928; Read time: 0; Write time: 434428 13:10:56 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 211017728; Read time: 12; Write time: 128536 13:10:56 INFO - Running post-run listener: _upload_blobber_files 13:10:56 INFO - Blob upload gear active. 13:10:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:10:56 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 13:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:10:57 INFO - (blobuploader) - INFO - Open directory for files ... 13:10:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:10:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:10:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:57 INFO - (blobuploader) - INFO - Done attempting. 13:10:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:10:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:10:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:58 INFO - (blobuploader) - INFO - Done attempting. 13:10:58 INFO - (blobuploader) - INFO - Iteration through files over. 13:10:58 INFO - Return code: 0 13:10:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:10:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:10:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d26c8254bd6d076b05b765e92fb85137936c58fad0fe1d93ee58d6da02b787bbd64ec28de79ca5ec3fe929249035bdea260f013a2a829a339e26bc77878107e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da5af01572c9258f066db99b83cbd4cf87fc1f965f079c842064c3815eb34c20ad8906c3f389a13189c342765dc2fd0ba065adff188c1d25871768ce06d6763c"} 13:10:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:10:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:10:58 INFO - Contents: 13:10:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d26c8254bd6d076b05b765e92fb85137936c58fad0fe1d93ee58d6da02b787bbd64ec28de79ca5ec3fe929249035bdea260f013a2a829a339e26bc77878107e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da5af01572c9258f066db99b83cbd4cf87fc1f965f079c842064c3815eb34c20ad8906c3f389a13189c342765dc2fd0ba065adff188c1d25871768ce06d6763c"} 13:10:58 INFO - Running post-run listener: copy_logs_to_upload_dir 13:10:58 INFO - Copying logs to upload dir... 13:10:58 INFO - mkdir: /builds/slave/test/build/upload/logs 13:10:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.256646 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-09 13:10:58.700568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 13:10:58.703980) ========= 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=db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d26c8254bd6d076b05b765e92fb85137936c58fad0fe1d93ee58d6da02b787bbd64ec28de79ca5ec3fe929249035bdea260f013a2a829a339e26bc77878107e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da5af01572c9258f066db99b83cbd4cf87fc1f965f079c842064c3815eb34c20ad8906c3f389a13189c342765dc2fd0ba065adff188c1d25871768ce06d6763c"} build_url:https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d26c8254bd6d076b05b765e92fb85137936c58fad0fe1d93ee58d6da02b787bbd64ec28de79ca5ec3fe929249035bdea260f013a2a829a339e26bc77878107e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da5af01572c9258f066db99b83cbd4cf87fc1f965f079c842064c3815eb34c20ad8906c3f389a13189c342765dc2fd0ba065adff188c1d25871768ce06d6763c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 13:10:58.730406) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:10:58.730757) ========= 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=db0483c52d987ecb441a263b000001ad-1465501445.883514-687753024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:10:58.816183) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 13:10:58.816769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 13:10:58.817326) ========= ========= Total master_lag: 0.19 =========