builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1461315193.65 results: success (0) buildid: 20160422011505 builduid: 86c382d736c74b0e8cd844e8d18f07cc revision: 6d26d2099e1a38a39f3010bd4d6abc79d63312ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:13.650306) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:13.650799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:13.651133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:13.692718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:13.693053) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 01:53:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-04-22 01:53:13 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169750 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:13.883458) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:13.883875) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021574 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:13.947662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:13.948031) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6d26d2099e1a38a39f3010bd4d6abc79d63312ba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6d26d2099e1a38a39f3010bd4d6abc79d63312ba --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 01:53:13,959 truncating revision to first 12 chars 2016-04-22 01:53:13,959 Setting DEBUG logging. 2016-04-22 01:53:13,959 attempt 1/10 2016-04-22 01:53:13,959 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6d26d2099e1a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 01:53:14,210 unpacking tar archive at: fx-team-6d26d2099e1a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516714 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:14.477663) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:14.477972) ========= script_repo_revision: 6d26d2099e1a38a39f3010bd4d6abc79d63312ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:14.478411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:14.478696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 01:53:14.486060) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 58 secs) (at 2016-04-22 01:53:14.486412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:53:14 INFO - MultiFileLogger online at 20160422 01:53:14 in /builds/slave/test 01:53:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:53:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:53:14 INFO - {'append_to_log': False, 01:53:14 INFO - 'base_work_dir': '/builds/slave/test', 01:53:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:53:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:53:14 INFO - 'branch': 'Fx-Team-Non-PGO', 01:53:14 INFO - 'buildbot_json_path': 'buildprops.json', 01:53:14 INFO - 'config_files': ('talos/linux_config.py',), 01:53:14 INFO - 'default_actions': ('clobber', 01:53:14 INFO - 'read-buildbot-config', 01:53:14 INFO - 'download-and-extract', 01:53:14 INFO - 'populate-webroot', 01:53:14 INFO - 'create-virtualenv', 01:53:14 INFO - 'install', 01:53:14 INFO - 'run-tests'), 01:53:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:53:14 INFO - 'download_minidump_stackwalk': True, 01:53:14 INFO - 'download_symbols': 'ondemand', 01:53:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:53:14 INFO - 'tooltool.py': '/tools/tooltool.py', 01:53:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:53:14 INFO - '/tools/misc-python/virtualenv.py')}, 01:53:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:53:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:53:14 INFO - 'installer_path': 'installer.exe', 01:53:14 INFO - 'log_level': 'info', 01:53:14 INFO - 'log_name': 'talos', 01:53:14 INFO - 'log_to_console': True, 01:53:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:53:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:53:14 INFO - 'opt_config_files': (), 01:53:14 INFO - 'pip_index': False, 01:53:14 INFO - 'sps_profile': False, 01:53:14 INFO - 'sps_profile_interval': 0, 01:53:14 INFO - 'suite': 'dromaeojs', 01:53:14 INFO - 'system_bits': '32', 01:53:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:53:14 INFO - 'title': 'talos-linux64-ix-042', 01:53:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:53:14 INFO - 'use_talos_json': True, 01:53:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:53:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:53:14 INFO - 'work_dir': 'build'} 01:53:14 INFO - ##### 01:53:14 INFO - ##### Running clobber step. 01:53:14 INFO - ##### 01:53:14 INFO - Running pre-action listener: _resource_record_pre_action 01:53:14 INFO - Running main action method: clobber 01:53:14 INFO - rmtree: /builds/slave/test/build 01:53:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:53:15 INFO - Running post-action listener: _resource_record_post_action 01:53:15 INFO - ##### 01:53:15 INFO - ##### Running read-buildbot-config step. 01:53:15 INFO - ##### 01:53:15 INFO - Running pre-action listener: _resource_record_pre_action 01:53:15 INFO - Running main action method: read_buildbot_config 01:53:15 INFO - Using buildbot properties: 01:53:15 INFO - { 01:53:15 INFO - "project": "", 01:53:15 INFO - "product": "firefox", 01:53:15 INFO - "script_repo_revision": "production", 01:53:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:53:15 INFO - "repository": "", 01:53:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:53:15 INFO - "buildid": "20160422011505", 01:53:15 INFO - "pgo_build": "False", 01:53:15 INFO - "basedir": "/builds/slave/test", 01:53:15 INFO - "buildnumber": 2860, 01:53:15 INFO - "slavename": "talos-linux64-ix-042", 01:53:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:53:15 INFO - "platform": "ubuntu64_hw", 01:53:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:53:15 INFO - "branch": "fx-team", 01:53:15 INFO - "repo_path": "integration/fx-team", 01:53:15 INFO - "revision": "6d26d2099e1a38a39f3010bd4d6abc79d63312ba", 01:53:15 INFO - "stage_platform": "linux64", 01:53:15 INFO - "builduid": "86c382d736c74b0e8cd844e8d18f07cc", 01:53:15 INFO - "slavebuilddir": "test" 01:53:15 INFO - } 01:53:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 01:53:15 INFO - Running post-action listener: _resource_record_post_action 01:53:15 INFO - ##### 01:53:15 INFO - ##### Running download-and-extract step. 01:53:15 INFO - ##### 01:53:15 INFO - Running pre-action listener: _resource_record_pre_action 01:53:15 INFO - Running main action method: download_and_extract 01:53:15 INFO - mkdir: /builds/slave/test/build/tests 01:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:15 INFO - https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:53:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:53:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:53:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:53:16 INFO - Downloaded 1361 bytes. 01:53:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:53:16 INFO - Using the following test package requirements: 01:53:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:53:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:53:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:53:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:16 INFO - u'jsshell-linux-x86_64.zip'], 01:53:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:53:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:53:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:53:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:53:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:53:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:53:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:53: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')]} 01:53:16 INFO - https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:53:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:53:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:53:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:53:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:53:17 INFO - Downloaded 22281373 bytes. 01:53:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:53:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:53:19 INFO - Return code: 0 01:53:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:53:19 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')]} 01:53:19 INFO - https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:53:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:53:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:53:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:53:22 INFO - Downloaded 22281373 bytes. 01:53:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:53:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:53:23 INFO - Return code: 0 01:53:23 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')]} 01:53:23 INFO - https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:53:24 INFO - Downloaded 10845952 bytes. 01:53:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:53:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:53:25 INFO - Return code: 0 01:53:25 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')]} 01:53:25 INFO - https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:53:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:53:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:53:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:53:27 INFO - Downloaded 54633091 bytes. 01:53:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:53:27 INFO - mkdir: /builds/slave/test/properties 01:53:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:53:27 INFO - Writing to file /builds/slave/test/properties/build_url 01:53:27 INFO - Contents: 01:53:27 INFO - build_url:https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:53:27 INFO - Running post-action listener: _resource_record_post_action 01:53:27 INFO - Running post-action listener: set_extra_try_arguments 01:53:27 INFO - ##### 01:53:27 INFO - ##### Running populate-webroot step. 01:53:27 INFO - ##### 01:53:27 INFO - Running pre-action listener: _resource_record_pre_action 01:53:27 INFO - Running main action method: populate_webroot 01:53:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:53:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:53:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:53:27 INFO - '--tppagecycles', 01:53:27 INFO - '7'], 01:53:27 INFO - 'tests': ['tsvgm']}}, 01:53:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:53:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:53:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:53:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:53:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:53:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:53:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:27 INFO - 'talos_options': ['--disable-e10s'], 01:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:53:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:53:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:27 INFO - 'talos_options': ['--disable-e10s'], 01:53:27 INFO - 'tests': ['damp', 'tps']}, 01:53:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:27 INFO - 'tests': ['damp', 'tps']}, 01:53:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:53:27 INFO - 'tests': ['dromaeo_dom']}, 01:53:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:53:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:53:27 INFO - 'tests': ['a11yr', 01:53:27 INFO - 'ts_paint', 01:53:27 INFO - 'tpaint', 01:53:27 INFO - 'sessionrestore', 01:53:27 INFO - 'sessionrestore_no_auto_restore', 01:53:27 INFO - 'tabpaint']}, 01:53:27 INFO - 'other-e10s': {'tests': ['a11yr', 01:53:27 INFO - 'ts_paint', 01:53:27 INFO - 'tpaint', 01:53:27 INFO - 'sessionrestore', 01:53:27 INFO - 'sessionrestore_no_auto_restore', 01:53:27 INFO - 'tabpaint']}, 01:53:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:53:27 INFO - 'ts_paint', 01:53:27 INFO - 'tpaint', 01:53:27 INFO - 'sessionrestore', 01:53:27 INFO - 'sessionrestore_no_auto_restore', 01:53:27 INFO - 'tabpaint']}, 01:53:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:53:27 INFO - 'ts_paint', 01:53:27 INFO - 'tpaint', 01:53:27 INFO - 'sessionrestore', 01:53:27 INFO - 'sessionrestore_no_auto_restore', 01:53:27 INFO - 'tabpaint']}, 01:53:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:53:27 INFO - 'tests': ['a11yr', 01:53:27 INFO - 'ts_paint', 01:53:27 INFO - 'tpaint', 01:53:27 INFO - 'sessionrestore', 01:53:27 INFO - 'sessionrestore_no_auto_restore', 01:53:27 INFO - 'tabpaint']}, 01:53:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:53:27 INFO - 'tests': ['a11yr', 01:53:27 INFO - 'ts_paint', 01:53:27 INFO - 'tpaint', 01:53:27 INFO - 'sessionrestore', 01:53:27 INFO - 'sessionrestore_no_auto_restore', 01:53:27 INFO - 'tabpaint']}, 01:53:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:53:27 INFO - 'tests': ['tsvgx', 01:53:27 INFO - 'tsvgr_opacity', 01:53:27 INFO - 'tart', 01:53:27 INFO - 'tscrollx', 01:53:27 INFO - 'cart']}, 01:53:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:53:27 INFO - 'tsvgr_opacity', 01:53:27 INFO - 'tart', 01:53:27 INFO - 'tscrollx', 01:53:27 INFO - 'cart']}, 01:53:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:27 INFO - 'talos_options': ['--disable-e10s'], 01:53:27 INFO - 'tests': ['tp5o']}, 01:53:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:27 INFO - 'tests': ['tp5o']}, 01:53:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:27 INFO - 'talos_options': ['--disable-e10s', 01:53:27 INFO - '--xperf_path', 01:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:53:27 INFO - 'tests': ['tp5n']}, 01:53:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:27 INFO - 'talos_options': ['--xperf_path', 01:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:53:27 INFO - 'tests': ['tp5n']}}, 01:53:27 INFO - 'talos.zip': {'path': '', 01:53:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:53:27 INFO - Running post-action listener: _resource_record_post_action 01:53:27 INFO - ##### 01:53:27 INFO - ##### Running create-virtualenv step. 01:53:27 INFO - ##### 01:53:27 INFO - Running pre-action listener: _resource_record_pre_action 01:53:27 INFO - Running main action method: create_virtualenv 01:53:27 INFO - Creating virtualenv /builds/slave/test/build/venv 01:53:27 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 01:53:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:53:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:53:28 INFO - Using real prefix '/usr' 01:53:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:53:28 INFO - Installing distribute.............................................................................................................................................................................................done. 01:53:31 INFO - Installing pip.................done. 01:53:31 INFO - Return code: 0 01:53:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:31 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 0x7faefd2d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b8410>, '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 0x25b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', '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 01:53:31 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 01:53:31 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 01:53:31 INFO - Using env: {'DISPLAY': ':0', 01:53:31 INFO - 'HOME': '/home/cltbld', 01:53:31 INFO - 'LANG': 'en_US.UTF-8', 01:53:31 INFO - 'LANGUAGE': 'en_US:en', 01:53:31 INFO - 'LOGNAME': 'cltbld', 01:53:31 INFO - 'MAIL': '/var/mail/cltbld', 01:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:31 INFO - 'MOZ_NO_REMOTE': '1', 01:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:31 INFO - 'NO_EM_RESTART': '1', 01:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:31 INFO - 'PWD': '/builds/slave/test', 01:53:31 INFO - 'SHELL': '/bin/bash', 01:53:31 INFO - 'SHLVL': '1', 01:53:31 INFO - 'TERM': 'linux', 01:53:31 INFO - 'TMOUT': '86400', 01:53:31 INFO - 'USER': 'cltbld', 01:53:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', 01:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:31 INFO - '_': '/tools/buildbot/bin/python'} 01:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:32 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 01:53:32 INFO - Cleaning up... 01:53:32 INFO - Return code: 0 01:53:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:32 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 0x7faefd2d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b8410>, '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 0x25b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', '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 01:53:32 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 01:53:32 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 01:53:32 INFO - Using env: {'DISPLAY': ':0', 01:53:32 INFO - 'HOME': '/home/cltbld', 01:53:32 INFO - 'LANG': 'en_US.UTF-8', 01:53:32 INFO - 'LANGUAGE': 'en_US:en', 01:53:32 INFO - 'LOGNAME': 'cltbld', 01:53:32 INFO - 'MAIL': '/var/mail/cltbld', 01:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:32 INFO - 'MOZ_NO_REMOTE': '1', 01:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:32 INFO - 'NO_EM_RESTART': '1', 01:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:32 INFO - 'PWD': '/builds/slave/test', 01:53:32 INFO - 'SHELL': '/bin/bash', 01:53:32 INFO - 'SHLVL': '1', 01:53:32 INFO - 'TERM': 'linux', 01:53:32 INFO - 'TMOUT': '86400', 01:53:32 INFO - 'USER': 'cltbld', 01:53:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', 01:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:32 INFO - '_': '/tools/buildbot/bin/python'} 01:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:32 INFO - Downloading/unpacking psutil>=0.7.1 01:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:53:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:53:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:53:34 INFO - Installing collected packages: psutil 01:53:34 INFO - Running setup.py install for psutil 01:53:34 INFO - building 'psutil._psutil_linux' extension 01:53:34 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 01:53:35 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 01:53:35 INFO - building 'psutil._psutil_posix' extension 01:53:35 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 01:53:36 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 01:53:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:53:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:53:36 INFO - Successfully installed psutil 01:53:36 INFO - Cleaning up... 01:53:36 INFO - Return code: 0 01:53:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:36 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 0x7faefd2d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b8410>, '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 0x25b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', '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 01:53:36 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 01:53:36 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 01:53:36 INFO - Using env: {'DISPLAY': ':0', 01:53:36 INFO - 'HOME': '/home/cltbld', 01:53:36 INFO - 'LANG': 'en_US.UTF-8', 01:53:36 INFO - 'LANGUAGE': 'en_US:en', 01:53:36 INFO - 'LOGNAME': 'cltbld', 01:53:36 INFO - 'MAIL': '/var/mail/cltbld', 01:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:36 INFO - 'MOZ_NO_REMOTE': '1', 01:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:36 INFO - 'NO_EM_RESTART': '1', 01:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:36 INFO - 'PWD': '/builds/slave/test', 01:53:36 INFO - 'SHELL': '/bin/bash', 01:53:36 INFO - 'SHLVL': '1', 01:53:36 INFO - 'TERM': 'linux', 01:53:36 INFO - 'TMOUT': '86400', 01:53:36 INFO - 'USER': 'cltbld', 01:53:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', 01:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:36 INFO - '_': '/tools/buildbot/bin/python'} 01:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:53:36 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 01:53:36 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 01:53:36 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 01:53:36 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 01:53:36 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 01:53:36 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 01:53:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:53:38 INFO - Installing collected packages: mozsystemmonitor 01:53:38 INFO - Running setup.py install for mozsystemmonitor 01:53:38 INFO - Successfully installed mozsystemmonitor 01:53:38 INFO - Cleaning up... 01:53:38 INFO - Return code: 0 01:53:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faefd2d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b8410>, '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 0x25b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', '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 01:53:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:53:38 INFO - Using env: {'DISPLAY': ':0', 01:53:38 INFO - 'HOME': '/home/cltbld', 01:53:38 INFO - 'LANG': 'en_US.UTF-8', 01:53:38 INFO - 'LANGUAGE': 'en_US:en', 01:53:38 INFO - 'LOGNAME': 'cltbld', 01:53:38 INFO - 'MAIL': '/var/mail/cltbld', 01:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:38 INFO - 'MOZ_NO_REMOTE': '1', 01:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:38 INFO - 'NO_EM_RESTART': '1', 01:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:38 INFO - 'PWD': '/builds/slave/test', 01:53:38 INFO - 'SHELL': '/bin/bash', 01:53:38 INFO - 'SHLVL': '1', 01:53:38 INFO - 'TERM': 'linux', 01:53:38 INFO - 'TMOUT': '86400', 01:53:38 INFO - 'USER': 'cltbld', 01:53:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', 01:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:38 INFO - '_': '/tools/buildbot/bin/python'} 01:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:38 INFO - Downloading/unpacking blobuploader==1.2.4 01:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:40 INFO - Downloading blobuploader-1.2.4.tar.gz 01:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:53:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:53:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:41 INFO - Downloading docopt-0.6.1.tar.gz 01:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:53:41 INFO - Installing collected packages: blobuploader, requests, docopt 01:53:41 INFO - Running setup.py install for blobuploader 01:53:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:53:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:53:41 INFO - Running setup.py install for requests 01:53:42 INFO - Running setup.py install for docopt 01:53:42 INFO - Successfully installed blobuploader requests docopt 01:53:42 INFO - Cleaning up... 01:53:42 INFO - Return code: 0 01:53:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:53:42 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')]} 01:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:42 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')]} 01:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:42 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 0x7faefd2d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b8410>, '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 0x25b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', '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 01:53:42 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 01:53:42 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 01:53:42 INFO - Using env: {'DISPLAY': ':0', 01:53:42 INFO - 'HOME': '/home/cltbld', 01:53:42 INFO - 'LANG': 'en_US.UTF-8', 01:53:42 INFO - 'LANGUAGE': 'en_US:en', 01:53:42 INFO - 'LOGNAME': 'cltbld', 01:53:42 INFO - 'MAIL': '/var/mail/cltbld', 01:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:42 INFO - 'MOZ_NO_REMOTE': '1', 01:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:42 INFO - 'NO_EM_RESTART': '1', 01:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:42 INFO - 'PWD': '/builds/slave/test', 01:53:42 INFO - 'SHELL': '/bin/bash', 01:53:42 INFO - 'SHLVL': '1', 01:53:42 INFO - 'TERM': 'linux', 01:53:42 INFO - 'TMOUT': '86400', 01:53:42 INFO - 'USER': 'cltbld', 01:53:42 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', 01:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:42 INFO - '_': '/tools/buildbot/bin/python'} 01:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:53:42 INFO - Running setup.py (path:/tmp/pip-3SEaQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:53:42 INFO - Running setup.py (path:/tmp/pip-uKzdgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:53:42 INFO - Running setup.py (path:/tmp/pip-GfPJfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:53:42 INFO - Running setup.py (path:/tmp/pip-lcu4R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:53:42 INFO - Running setup.py (path:/tmp/pip-anMBuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:53:42 INFO - Running setup.py (path:/tmp/pip-aN7i9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:53:42 INFO - Running setup.py (path:/tmp/pip-_6aDRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:53:42 INFO - Running setup.py (path:/tmp/pip-D14EIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:53:43 INFO - Running setup.py (path:/tmp/pip-rPHtYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:53:43 INFO - Running setup.py (path:/tmp/pip-CCibjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:53:43 INFO - Running setup.py (path:/tmp/pip-HvkuX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:53:43 INFO - Running setup.py (path:/tmp/pip-vajjZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:53:43 INFO - Running setup.py (path:/tmp/pip-aHpJ9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:53:43 INFO - Running setup.py (path:/tmp/pip-fSsKip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:53:43 INFO - Running setup.py (path:/tmp/pip-5JUAoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:53:43 INFO - Running setup.py (path:/tmp/pip-gktFYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:53:43 INFO - Running setup.py (path:/tmp/pip-SiCaQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:53:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:53:43 INFO - Running setup.py install for manifestparser 01:53:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:53:43 INFO - Running setup.py install for mozcrash 01:53:43 INFO - Running setup.py install for mozdebug 01:53:44 INFO - Running setup.py install for mozdevice 01:53:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:53:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:53:44 INFO - Running setup.py install for mozfile 01:53:44 INFO - Running setup.py install for mozhttpd 01:53:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:53:44 INFO - Running setup.py install for mozinfo 01:53:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:53:44 INFO - Running setup.py install for mozInstall 01:53:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:53:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:53:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:53:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:53:44 INFO - Running setup.py install for mozleak 01:53:44 INFO - Running setup.py install for mozlog 01:53:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:53:44 INFO - Running setup.py install for moznetwork 01:53:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:53:44 INFO - Running setup.py install for mozprocess 01:53:44 INFO - Running setup.py install for mozprofile 01:53:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:53:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:53:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:53:45 INFO - Running setup.py install for mozrunner 01:53:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:53:45 INFO - Running setup.py install for mozscreenshot 01:53:45 INFO - Running setup.py install for moztest 01:53:45 INFO - Running setup.py install for mozversion 01:53:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:53:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:53:45 INFO - Cleaning up... 01:53:45 INFO - Return code: 0 01:53:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:45 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 0x7faefd2d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b8410>, '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 0x25b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', '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 01:53:45 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 01:53:45 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 01:53:45 INFO - Using env: {'DISPLAY': ':0', 01:53:45 INFO - 'HOME': '/home/cltbld', 01:53:45 INFO - 'LANG': 'en_US.UTF-8', 01:53:45 INFO - 'LANGUAGE': 'en_US:en', 01:53:45 INFO - 'LOGNAME': 'cltbld', 01:53:45 INFO - 'MAIL': '/var/mail/cltbld', 01:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:45 INFO - 'MOZ_NO_REMOTE': '1', 01:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:45 INFO - 'NO_EM_RESTART': '1', 01:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:45 INFO - 'PWD': '/builds/slave/test', 01:53:45 INFO - 'SHELL': '/bin/bash', 01:53:45 INFO - 'SHLVL': '1', 01:53:45 INFO - 'TERM': 'linux', 01:53:45 INFO - 'TMOUT': '86400', 01:53:45 INFO - 'USER': 'cltbld', 01:53:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', 01:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:45 INFO - '_': '/tools/buildbot/bin/python'} 01:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:53:45 INFO - Running setup.py (path:/tmp/pip-Uaguig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:53:45 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)) 01:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:53:45 INFO - Running setup.py (path:/tmp/pip-_0S6JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:53:45 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)) 01:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:53:45 INFO - Running setup.py (path:/tmp/pip-M_qp8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:53:45 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)) 01:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:53:45 INFO - Running setup.py (path:/tmp/pip-7LtA53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:53:46 INFO - Running setup.py (path:/tmp/pip-OoW62M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:53:46 INFO - Running setup.py (path:/tmp/pip-_SJ9Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:53:46 INFO - Running setup.py (path:/tmp/pip-Iekrre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:53:46 INFO - Running setup.py (path:/tmp/pip-taXmNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:53:46 INFO - Running setup.py (path:/tmp/pip-CJBahY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:53:46 INFO - Running setup.py (path:/tmp/pip-fUCfFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:53:46 INFO - Running setup.py (path:/tmp/pip-ZeLt06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:53:46 INFO - Running setup.py (path:/tmp/pip-yDa2B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:53:46 INFO - Running setup.py (path:/tmp/pip-xHyqjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:53:46 INFO - Running setup.py (path:/tmp/pip-4CYh1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:53:46 INFO - Running setup.py (path:/tmp/pip-SqNF4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:53:46 INFO - Running setup.py (path:/tmp/pip-gS3JqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:53:46 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)) 01:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:53:46 INFO - Running setup.py (path:/tmp/pip-RSl6cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:53:46 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)) 01:53:46 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)) 01:53:46 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)) 01:53:46 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)) 01:53:46 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)) 01:53:46 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)) 01:53:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:48 INFO - Downloading blessings-1.6.tar.gz 01:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:53:48 INFO - Installing collected packages: blessings 01:53:48 INFO - Running setup.py install for blessings 01:53:49 INFO - Successfully installed blessings 01:53:49 INFO - Cleaning up... 01:53:49 INFO - Return code: 0 01:53:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:53:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:53:49 INFO - Reading from file tmpfile_stdout 01:53:49 INFO - Current package versions: 01:53:49 INFO - argparse == 1.2.1 01:53:49 INFO - blessings == 1.6 01:53:49 INFO - blobuploader == 1.2.4 01:53:49 INFO - docopt == 0.6.1 01:53:49 INFO - manifestparser == 1.1 01:53:49 INFO - mozInstall == 1.12 01:53:49 INFO - mozcrash == 0.17 01:53:49 INFO - mozdebug == 0.1 01:53:49 INFO - mozdevice == 0.48 01:53:49 INFO - mozfile == 1.2 01:53:49 INFO - mozhttpd == 0.7 01:53:49 INFO - mozinfo == 0.9 01:53:49 INFO - mozleak == 0.1 01:53:49 INFO - mozlog == 3.1 01:53:49 INFO - moznetwork == 0.27 01:53:49 INFO - mozprocess == 0.22 01:53:49 INFO - mozprofile == 0.28 01:53:49 INFO - mozrunner == 6.11 01:53:49 INFO - mozscreenshot == 0.1 01:53:49 INFO - mozsystemmonitor == 0.0 01:53:49 INFO - moztest == 0.7 01:53:49 INFO - mozversion == 1.4 01:53:49 INFO - psutil == 3.1.1 01:53:49 INFO - requests == 1.2.3 01:53:49 INFO - wsgiref == 0.1.2 01:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:53: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')]} 01:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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')]} 01:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:49 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 0x7faefd2d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b8410>, '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 0x25b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', '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 01:53:49 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 01:53:49 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 01:53:49 INFO - Using env: {'DISPLAY': ':0', 01:53:49 INFO - 'HOME': '/home/cltbld', 01:53:49 INFO - 'LANG': 'en_US.UTF-8', 01:53:49 INFO - 'LANGUAGE': 'en_US:en', 01:53:49 INFO - 'LOGNAME': 'cltbld', 01:53:49 INFO - 'MAIL': '/var/mail/cltbld', 01:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:49 INFO - 'MOZ_NO_REMOTE': '1', 01:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:49 INFO - 'NO_EM_RESTART': '1', 01:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:49 INFO - 'PWD': '/builds/slave/test', 01:53:49 INFO - 'SHELL': '/bin/bash', 01:53:49 INFO - 'SHLVL': '1', 01:53:49 INFO - 'TERM': 'linux', 01:53:49 INFO - 'TMOUT': '86400', 01:53:49 INFO - 'USER': 'cltbld', 01:53:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', 01:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:49 INFO - '_': '/tools/buildbot/bin/python'} 01:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:49 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)) 01:53:49 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)) 01:53:49 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)) 01:53:49 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)) 01:53:49 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)) 01:53:49 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)) 01:53:49 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)) 01:53:49 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)) 01:53:49 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)) 01:53:49 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)) 01:53:49 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)) 01:53:49 INFO - Cleaning up... 01:53:49 INFO - Return code: 0 01:53:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:53: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')]} 01:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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')]} 01:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faefd2d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b8410>, '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 0x25b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', '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 01:53: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', 'jsonschema'] in /builds/slave/test/build 01:53: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 jsonschema 01:53:49 INFO - Using env: {'DISPLAY': ':0', 01:53:49 INFO - 'HOME': '/home/cltbld', 01:53:49 INFO - 'LANG': 'en_US.UTF-8', 01:53:49 INFO - 'LANGUAGE': 'en_US:en', 01:53:49 INFO - 'LOGNAME': 'cltbld', 01:53:49 INFO - 'MAIL': '/var/mail/cltbld', 01:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:49 INFO - 'MOZ_NO_REMOTE': '1', 01:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:49 INFO - 'NO_EM_RESTART': '1', 01:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:49 INFO - 'PWD': '/builds/slave/test', 01:53:49 INFO - 'SHELL': '/bin/bash', 01:53:49 INFO - 'SHLVL': '1', 01:53:49 INFO - 'TERM': 'linux', 01:53:49 INFO - 'TMOUT': '86400', 01:53:49 INFO - 'USER': 'cltbld', 01:53:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', 01:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:49 INFO - '_': '/tools/buildbot/bin/python'} 01:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:49 INFO - Downloading/unpacking jsonschema 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:53:51 INFO - Downloading/unpacking functools32 (from jsonschema) 01:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:51 INFO - Downloading functools32-3.2.3-2.tar.gz 01:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:53:51 INFO - warning: no files found matching '*.txt' 01:53:51 INFO - no previously-included directories found matching 'build' 01:53:51 INFO - no previously-included directories found matching 'dist' 01:53:51 INFO - no previously-included directories found matching '.git*' 01:53:51 INFO - Installing collected packages: jsonschema, functools32 01:53:52 INFO - Running setup.py install for functools32 01:53:52 INFO - warning: no files found matching '*.txt' 01:53:52 INFO - no previously-included directories found matching 'build' 01:53:52 INFO - no previously-included directories found matching 'dist' 01:53:52 INFO - no previously-included directories found matching '.git*' 01:53:52 INFO - Successfully installed jsonschema functools32 01:53:52 INFO - Cleaning up... 01:53:52 INFO - Return code: 0 01:53:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:53: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')]} 01:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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')]} 01:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faefd2d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b8410>, '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 0x25b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', '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 01:53: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', 'flake8'] in /builds/slave/test/build 01:53: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 flake8 01:53:52 INFO - Using env: {'DISPLAY': ':0', 01:53:52 INFO - 'HOME': '/home/cltbld', 01:53:52 INFO - 'LANG': 'en_US.UTF-8', 01:53:52 INFO - 'LANGUAGE': 'en_US:en', 01:53:52 INFO - 'LOGNAME': 'cltbld', 01:53:52 INFO - 'MAIL': '/var/mail/cltbld', 01:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:52 INFO - 'MOZ_NO_REMOTE': '1', 01:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:52 INFO - 'NO_EM_RESTART': '1', 01:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:52 INFO - 'PWD': '/builds/slave/test', 01:53:52 INFO - 'SHELL': '/bin/bash', 01:53:52 INFO - 'SHLVL': '1', 01:53:52 INFO - 'TERM': 'linux', 01:53:52 INFO - 'TMOUT': '86400', 01:53:52 INFO - 'USER': 'cltbld', 01:53:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', 01:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:52 INFO - '_': '/tools/buildbot/bin/python'} 01:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:52 INFO - Downloading/unpacking flake8 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:53:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:53:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:53:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:53:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:53:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:53:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:53:54 INFO - no previously-included directories found matching 'docs/_build' 01:53:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:53:55 INFO - Running setup.py install for pep8 01:53:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:53:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:53:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:53:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:53:55 INFO - no previously-included directories found matching 'docs/_build' 01:53:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:53:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:53:55 INFO - Cleaning up... 01:53:55 INFO - Return code: 0 01:53:55 INFO - Running post-action listener: _resource_record_post_action 01:53:55 INFO - Running post-action listener: _start_resource_monitoring 01:53:55 INFO - Starting resource monitoring. 01:53:55 INFO - ##### 01:53:55 INFO - ##### Running install step. 01:53:55 INFO - ##### 01:53:55 INFO - Running pre-action listener: _resource_record_pre_action 01:53:55 INFO - Running main action method: install 01:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:53:55 INFO - Reading from file tmpfile_stdout 01:53:55 INFO - Detecting whether we're running mozinstall >=1.0... 01:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:53:55 INFO - Reading from file tmpfile_stdout 01:53:55 INFO - Output received: 01:53:55 INFO - Usage: mozinstall [options] installer 01:53:55 INFO - Options: 01:53:55 INFO - -h, --help show this help message and exit 01:53:55 INFO - -d DEST, --destination=DEST 01:53:55 INFO - Directory to install application into. [default: 01:53:55 INFO - "/builds/slave/test"] 01:53:55 INFO - --app=APP Application being installed. [default: firefox] 01:53:55 INFO - mkdir: /builds/slave/test/build/application 01:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:54:11 INFO - Reading from file tmpfile_stdout 01:54:11 INFO - Output received: 01:54:11 INFO - /builds/slave/test/build/application/firefox/firefox 01:54:11 INFO - Running post-action listener: _resource_record_post_action 01:54:11 INFO - ##### 01:54:11 INFO - ##### Running run-tests step. 01:54:11 INFO - ##### 01:54:11 INFO - Running pre-action listener: _resource_record_pre_action 01:54:11 INFO - Running main action method: run_tests 01:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:54:11 INFO - Python 2.7.3 01:54:11 INFO - Return code: 0 01:54:11 INFO - grabbing minidump binary from tooltool 01:54:11 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')]} 01:54:11 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 0x25b8410>, '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 0x25b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:54:11 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 01:54:11 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 01:54:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:54:11 INFO - Return code: 0 01:54:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:54:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:54:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:54:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:54:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:54:12 INFO - Return code: 0 01:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:54:12 INFO - Using env: {'DISPLAY': ':0', 01:54:12 INFO - 'HOME': '/home/cltbld', 01:54:12 INFO - 'LANG': 'en_US.UTF-8', 01:54:12 INFO - 'LANGUAGE': 'en_US:en', 01:54:12 INFO - 'LOGNAME': 'cltbld', 01:54:12 INFO - 'MAIL': '/var/mail/cltbld', 01:54:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:54:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:12 INFO - 'MOZ_NO_REMOTE': '1', 01:54:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:12 INFO - 'NO_EM_RESTART': '1', 01:54:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:12 INFO - 'PWD': '/builds/slave/test', 01:54:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:54:12 INFO - 'SHELL': '/bin/bash', 01:54:12 INFO - 'SHLVL': '1', 01:54:12 INFO - 'TERM': 'linux', 01:54:12 INFO - 'TMOUT': '86400', 01:54:12 INFO - 'USER': 'cltbld', 01:54:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157', 01:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:12 INFO - '_': '/tools/buildbot/bin/python'} 01:54:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:54:13 INFO - mozversion application_buildid: 20160422011505 01:54:13 INFO - mozversion application_changeset: 6d26d2099e1a38a39f3010bd4d6abc79d63312ba 01:54:13 INFO - mozversion application_display_name: Nightly 01:54:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:54:13 INFO - mozversion application_name: Firefox 01:54:13 INFO - mozversion application_remotingname: firefox 01:54:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:54:13 INFO - mozversion application_vendor: Mozilla 01:54:13 INFO - mozversion application_version: 48.0a1 01:54:13 INFO - mozversion platform_buildid: 20160422011505 01:54:13 INFO - mozversion platform_changeset: 6d26d2099e1a38a39f3010bd4d6abc79d63312ba 01:54:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:54:13 INFO - mozversion platform_version: 48.0a1 01:54:13 INFO - using testdate: 1461315253 01:54:13 INFO - actual date: 1461315253 01:54:13 INFO - starting webserver on 'localhost:50633' 01:54:13 INFO - SUITE-START | Running 2 tests 01:54:13 INFO - TEST-START | dromaeo_css 01:54:13 INFO - operating with platform_type : linux_ 01:54:13 INFO - Initialising browser for dromaeo_css test... 01:54:13 INFO - TEST-INFO | started process 3301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpopKsDQ/profile http://localhost:50633/getInfo.html) 01:54:20 INFO - PROCESS | 3301 | __metrics Screen width/height:1600/1200 01:54:20 INFO - PROCESS | 3301 | colorDepth:24 01:54:20 INFO - PROCESS | 3301 | Browser inner width/height: 1024/697 01:54:20 INFO - PROCESS | 3301 | __metrics 01:54:21 ERROR - PROCESS | 3301 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:54:22 INFO - TEST-INFO | 3301: exit 0 01:54:22 INFO - Browser initialized. 01:54:22 INFO - Running cycle 1/1 for dromaeo_css test... 01:54:22 INFO - TEST-INFO | started process 3384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpopKsDQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:34 INFO - PROCESS | 3384 | RSS: Main: 155111424 01:54:34 INFO - PROCESS | 3384 | 01:55:26 INFO - PROCESS | 3384 | 1461315326032 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] 01:57:37 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:50633/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50633/tests/dromaeo/cssquery-ext.html) 01:57:38 INFO - PROCESS | 3384 | RSS: Main: 261005312 01:57:38 INFO - PROCESS | 3384 | 02:00:41 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:50633/tests/dromaeo/cssquery-ext.html (next: http://localhost:50633/tests/dromaeo/cssquery-jquery.html) 02:00:42 INFO - PROCESS | 3384 | RSS: Main: 235364352 02:00:42 INFO - PROCESS | 3384 | 02:03:44 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:50633/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50633/tests/dromaeo/cssquery-mootools.html) 02:03:44 INFO - PROCESS | 3384 | RSS: Main: 237920256 02:03:44 INFO - PROCESS | 3384 | 02:06:46 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:50633/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50633/tests/dromaeo/cssquery-prototype.html) 02:06:47 INFO - PROCESS | 3384 | RSS: Main: 231202816 02:06:47 INFO - PROCESS | 3384 | 02:09:50 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:50633/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50633/tests/dromaeo/cssquery-yui.html) 02:09:51 INFO - PROCESS | 3384 | RSS: Main: 214405120 02:09:51 INFO - PROCESS | 3384 | 02:12:53 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:50633/tests/dromaeo/cssquery-yui.html (next: http://localhost:50633/tests/dromaeo/cssquery-dojo.html) 02:12:54 INFO - PROCESS | 3384 | RSS: Main: 284418048 02:12:54 INFO - PROCESS | 3384 | 02:12:54 INFO - PROCESS | 3384 | __start_tp_report 02:12:54 INFO - PROCESS | 3384 | _x_x_mozilla_page_load 02:12:54 INFO - PROCESS | 3384 | _x_x_mozilla_page_load_details 02:12:54 INFO - PROCESS | 3384 | |i|pagename|runs| 02:12:54 INFO - PROCESS | 3384 | |0;dojo.html;2594.5718956372198;2670.1455534229053;2672.3645307957963;2681.973180268198;2704.3509557706143;4533.7053091549105;4621.260598304272;4633.791479383427;4646.860594182172;4649.674522783406;4693.131770622429;4696.765161741916;4722.031983443395;4770.713757174572;4790.856274311776;4253.8723838284905;4306.418633484479;4338.652907767387;4362.040351122764;4426.336049592571;4341.044970106587;4367.628751556122;4383.846565370212;4394.989152494928;4448.110377924428;4188.47644044496;4252.213340532012;4260.893477663052;4278.593533614302;4344.02259491615;4282.42187304713;4311.28863737483;4316.6546676265825;4317.244482215599;4367.126574685044;4294.592013758688;4298.226319262531;4306;4331.588499092612;4344.522102568715;4458.286674132156;4534.977325113353;4565.292379681155;4605.102005109005;4661.953380466186;5037.5718063964605;5038.521340472649;5039.21892106724;5060.038592667382;5108.897822043576;4945.530174633404;5057.595392368638;5078.6698864574055;5083.720395378253;5091.389033315989;4688.765561721901;4760.7619619018915;4769.974455492086;4771.33201351811;4774.594159496482;5085.923711144335;5107.004134193797;5109.821156259513;5111.361079865017;5116.923246151311;4893.0458560581055;4893.779779909913;4895.926561101586;4903.338049363361;4949.529794669501;4906.484819094015;4942.950570494249;4987.800487980513;5008.799648014038;5027.271045698426;4888.02239552091;4898.608111351084;4903.901921961541;4915.680480768739;4969.552740253394;4826.0589185108565;4900.240462728283;4900.436449808247;4902.803887844518;4963.057019166346;4205.095904380573;4214.789260536961;4228.894277643022;4229.090745489734;4230.61924426803;3674.614165512636;3704.6665800077585;3705.444183372516;3745.1760612665717;3755.549334079928;4259.2759230930815;4263.914721705549;4269.509006464296;4269.996550810557;4302.075053863435;4904.901901962012;4952.678075925053;4989.351384320015;5024.321716568216;5050.797968081309;4280.101178752497;4299.871003869889;4320.740755554677;4327.394164816928;4328.567143285709;4420.071784925138;4451.998300382388;4452.732836029849;4456.598906098402;4497.752623605667;4605.309203619484;4694.765261736968;4694.859154225379;4695.647826413101;4733.384659994179;4996.525330093636;5016.573591244639;5055.823046193365;5089.3638295213095;5100.974495127649;4721.197396442544;4723.031778485333;4723.173444647242;4726.8109275628585;4777.784999675093;4797.928031079467;4893.559579637849;4901.264810278487;4931.556159945622;4986.626003049713;4935.62982776286;4969.055879382906;4969.776360063734;4982.177940639754;5008.949910500848;4787.880302992453;4800.95199048019;4813.470518242921;4815.374001379798;4851.587615052619;4779.95220047809;4811.302361157543;4855.95144048555;4875.975620121877;4973.055119527278;4741.075490279362;4749.572538471554;4764.475907650087;4807.134715751198;4813.663043586916;4871.171900776805;4872.853814385574;4877.585405240594;4880.46314905353;4920.6801557898625;4715.552022557851;4753.714777113384;4813.470518242921;4824.517548245288;4828.61371090319 02:12:54 INFO - PROCESS | 3384 | |1;ext.html;567.4013915319339;598.0640297933734;601.5037593984962;607.1136141233799;620.587309439223;33715.49426758598;34703.132421689435;34799.13002174947;34808.30383392337;34826.65173348263;38762;39979.80010099953;40082.39876401849;40148.397774033416;40170.19659606806;7222.74720384784;7782.805429864256;7990.640421181031;9436.292278079138;9734.41593504392;9605.90394096057;9742.366746161477;9748.951255243714;9776.413415195075;9777.462239576857;9722.270829687766;9786.314957952945;9788.21694264457;9803.362781419184;9823.852642210373;7452.217517160701;9770.609175632966;10076.798464030751;10131;10180.592776288939;9613.663521776703;9785.461799601018;9802.9509852451;9809.21526277896;9831.90168098317;33731.15672108193;34241;34334.82832585821;34336.48495272573;34356.48465273023;2676.317539027555;2821.548552231633;3138.4350816852957;3251.493032514923;3327.73378129749;27456.725432745618;27972.160835174775;27974;28610;29005.12984610444;3297.5713157289397;3321.4519604265265;3354.26206234628;3413.846376913045;3428.5200071989693;251477;253467;253799;253937;254014;32170.839145804122;33185.502217466754;33189;49656.75171624119;50456.49543504518;31328.21679457986;31480.05559833209;31488.527672084478;31521.21196970094;31556.842215788773;10135.391876487287;11124.443777811077;11241.71895702614;11243.550257989753;11253.831192532118;8785.912140878509;8920.197182253498;8936.553172341486;9505.477198753997;9858.556364963593;7944.9205507945335;7977.760667179994;7984.96195494582;8035.638396272182;8051;3124.9687603090924;3133.185371803302;3165.8100513969234;3181.3637272545584;3188.776785624984;883.7403714098114;895.9641614335484;908.5139450394007;945.5083356654638;983.7540614846289;25783.355416114373;25994.87002565013;26788.59817102745;26789.732102679114;26841;963.5856581669809;967.9032096790405;970.5486948568949;989.8069876374182;1022.4018948914968;13959.441622334993;14055.43778248879;14290.714185716435;14490.492832751013;14550.708985820436;338493;341944;345701;346065;349260;47283.76358118256;48089;48195.75902120537;48200.5179948196;48250;1077.2297807067985;1120.6918097523082;1124.3591153042687;1185.962283002373;1234.0621127942827;25320.366990825376;26916.327091822863;27242.72757272402;27314.453710926067;27511.58732619052;37241.441378378804;37712.24575508529;37755;37812.43281350837;37839.24321513609;234992;236424;236494;236863.5254589866;237002;22174.55650886941;23395.181168659015;24328;24342.51314973726;24434.144804932454;35878.820605896806;35998.820005899805;36143.81928090448;36799.26401471902;37147.628523715495;33384.49923251202;33558;33846.492302614985;33850.32299354048;34295;33206.16984575405;33631.81498460989;33686;33766.66233337635;33980.83009585035;33172.834135829165;33390.49914251337;33474.832625836716;33559.66440335663;33790.49314260239;28683.56974645424;29791.25521861884;29901.850490747405;30136.24659383533;30219.09342719722;23406.531869362178;23676.88161559181;23969.28092157238;24088.638670420307;24092.63861042051 02:12:54 INFO - PROCESS | 3384 | |2;jquery.html;375.1390558667858;375.91353988582625;379.11854937270846;387.80609695152424;396.20758483033933;15957.601059973493;16191.190440477973;17000.319987200528;17012.574685632866;17022;13130.737385252289;14510.274486275697;14521.92739036306;14546.781798273008;14558.781618275709;4372.693911426193;4702.153612349775;4704.811807527712;4705.106029854333;4707.741074240916;3462.809545474998;3635.0912271932016;6453.419192272694;6829.93170068298;6842.931570684279;6748.797536073926;6806.3874251317375;6827.249002609709;6834.897476537856;6907.13660792401;6739.393454589086;6847.897281540781;6855.280195579442;6900.102986611759;6906.689198986058;6430.356964303579;6819.488538359643;6822.692978815916;6823.283555226729;6831.829204269883;21927.12291508338;21934.232301869517;22156.22453214146;22945;22982.425439363982;1969.4091772468203;1991.6415045291842;2063.47381417739;2127.500037491204;2131.5630295789483;13558.186508809504;14043.22762248076;14242.572722818331;14314.928425357806;14917;1909.2935613822835;1917.5493758966632;1925.3357591630865;1961.8430525557922;1994.9601007979759;80050;80058.19941800565;80565;82066.58966705189;82495.5875220626;15289.311980960883;16152;16264;16419.5895102621;16642;29163.270918227216;29220.269493262414;29284.41431171365;29468.705312947026;29613.85193074021;8038.8794168087525;8228.341732661373;8360.958195208985;8510.74467765968;8559.914400856036;6815.352541508648;6830.112085428863;6904.4821638377325;6957.443404527626;7044.260352662999;7202.855942881113;8288.093738440193;8317.750467485985;8404;8427.915720842835;2645.579294945104;3252.284497410566;3324.6176689680997;3389.322135572895;3505.4216054351255;793.9761807145795;861.67687117331;886.6542048601051;916.6002642897048;919.935604507678;16336.836631633769;16443.83556164447;16491.34034638601;16674.33302667904;17104.315827366765;819.1439945257101;851.9574021298911;856.208007592974;870.0820634230947;870.5951732444317;8926.776830579287;9051.637934482678;9311.813763724824;9492.382995105296;9507.42955422663;410763;412140;413432.3852134897;415950;416414;44794.32808507875;48846.755766220944;59369.10946335809;70612;71631.6418417915;843.9915600843913;852.7441767469734;855.5850412549909;863.9827203456022;884.6328773558901;14409.42362305496;14534.927325363305;14663.853361466248;14686.192259425834;15028.549143525712;31610.525842111925;32763.34473310568;34706.479402809484;35751.10969565481;36747.99999999893;43106.353404699585;44355.55644443514;46108.769456152506;47530.76234618805;48133;7700.922990770021;7881.802954926173;7939.523628582073;8071;8231.835363292821;10961.945190273998;11997.520099195934;12143.878561214275;12215.9500658993;12304.938475307566;10518.316309439862;10562.630307939186;10645.095166910589;10712.678619641423;10748.301360411548;7624.69501219945;10419.895801041892;10566.101881340172;10727.249092563447;10957.616483423042;5847.210626565359;8423.652215645467;10643.733906652396;10850.131989440668;10864.076553493042;7718.459707820399;7743.225677432211;7852.882206767017;7895.447318687867;7989.960050199712;10477.790444190921;10525.526351314056;10556.208284378856;10623.043926046694;10653.254272200871 02:12:54 INFO - PROCESS | 3384 | |3;mootools.html;1263.4440846027742;1438.8345340285866;1475.0780762023735;1603.2705119170778;1745.3280487012496;7610.429217808666;7884.80287992799;7913;7916.40626952978;7917.04995400552;7699.461037727361;7758.767236982885;7762.728304509344;7775.922240777591;7855.25375089367;1921.7117432385114;2202.1081462007915;2215.822734181266;2241.618924782791;2268.591653502369;2226.4990377165173;2299.344686764264;2302.470431800687;2303.2284184798114;2305.0203663443053;2232.475368288451;2276.089564174335;2285.2572913802996;2286.7827556382117;2287.542491501698;1958.6866101423775;2108.39910625471;2154.5690861827698;2156.299202759094;2162.13514594162;2062.742157230346;2082.5106100066473;2090.6654935210445;2092.8116469517818;2121.469632591852;7760.689572417096;7835.0989636191425;7961.562114083723;7984.8403031939615;8017;4500.617447516932;4640.257558790611;4648.790804413776;4657.022025374676;4682.040181762731;2914.883404663811;2954.1875984104327;2959.6448426188995;3010.71398217169;3021.456137895178;953.6328513522344;1819.7452356670076;1829.1494455078453;1851.9721554537227;1893.7916829148783;10273.589056437733;10375.84436233457;10376.273660843744;10393.79212415755;10394.324368916072;4049.372347286175;4095.28332541804;4237.067845074079;4257.638100761408;4295.634871035997;8190;8192.631331590093;8201.425900187049;8206.548639824747;8208.548529830798;4079.9592004079577;4647.86056418308;4658.510856360102;4667;4667.556582124693;4056.6551843093075;4125.278076336629;4132.008318003657;4147.564505726916;4169.833206671759;3397.7281817454545;3409.147713071732;3493.7554371194283;3515.9472607910902;3520;1051.6161601015574;1092.093562343253;1093.6937657455926;1103.3214573037685;1106.253279036647;635.2694401438383;718.192033961793;769.2922511289627;773.97678069658;796.5738329993542;5001.499850015042;5125.205593133071;5189.714565698923;5225.843224703265;5245.370555533361;398.25128757935477;403.67705835331617;408.236597562554;410.8089738271658;413.32421490862055;3363.6131844838155;3365.1250674824723;3388.610309814403;3422.691957723767;3446.2418267981;9623.182029527568;9921.454320012324;10081.798364032678;10147.9492602538;10149.188064954933;9298.767530811649;9889.06053924876;9918.752031199134;9976.700698979042;9988.550515226832;7347.37547308474;7437.479376443705;7504.137024242282;7525.059367579052;7525.360344370681;4995.350604421402;5077.136886729191;5169.172932330809;5198.4801519847715;5232.267482552522;8795.560221989002;8796.428232164888;8837.337199709918;8837.381383303107;8886;8852.822943540965;8970.37207395476;9085.636574536944;9125.361224714472;9235.445873247627;6576.638284894377;7072.398846098139;7195;7271.527350722186;7278.7816365507;7333.193348731742;7338.633068346455;7390.187079421152;7394.926050739424;7398.371138453292;6631.436327912182;6725.663716814238;6732.932670673426;6837.965810170917;6845.315468453314;6385.776497822554;6476.384743449365;6622.238442579165;6667.366600172976;6671.33286671329;5830.53355731549;5866.5893387462465;5879.559033072622;5891.675957822361;5899.882002360015;4301.784910754513;4405.036600891142;4453.220686379806;4496.7077139985795;4560.771961401983;4521.208788462071;4530.614897733598;4580.564846339593;4628.537146285479;4632.004119114406 02:12:54 INFO - PROCESS | 3384 | |4;prototype.html;314.872476646958;318.87723226557785;325.7117451055815;325.92829577492944;327.6477786379642;5105.387353517578;5154.896902061966;5156.278121063054;5186.662866913653;5187.170052791555;5080.542751152396;5086.33877595913;5092.185250359943;5107.693538387699;5114.820981265657;3817.3892177251646;3926.175503144343;3947.1118998225456;4034.354503279476;4036.9798151009204;4010.278149933011;4010.69919756018;4022.617851304136;4026.1947610477873;4029.415734718464;3788.6590206881374;3999.7202294118833;3999.920021594168;4000.7799571023584;4007.138465229975;3876.612338766129;4012.378081397388;4013.177298653769;4017.296973029708;4022;3559.4660800879815;3560.1099725068734;3564.32277867207;3567.6432356764376;3570.553680789901;4890.144224760688;4892.975535122301;4903.63222758291;4907.2639104134305;4910.656254062217;4376.912461750747;4624.676272660915;4632.235681112612;4636.397268355126;4647.790849411751;5361.276227709248;5376.220448035052;5379.677219366811;5379.799019583342;5384.569234461273;3898.4542164097047;3900.843966241347;3904.6485816276386;3906.902327441808;3908.7850168240734;5513.476219759116;5550.306211723535;5596.4403559644115;5632.436756324376;5633.211350410946;4000.8399664013696;4016.116454380032;4017.0961533655277;4036.2129384770274;4041.535223449282;4076.3477843544892;4084.81618327176;4089.161721847014;4103.4050062740735;4104.0970986382945;4390.714603550759;4601.562851529099;4604.401427814362;4619;4624.127228472474;5389.703566303812;5398.703071331036;5406.729663516809;5417.214503896992;5427.29445172133;1397.8392484864166;1415.1367665723901;1418.666613345863;1422.8363738170242;1426.8715815576647;916.1937495004487;962.9470379129075;977.9951100244596;995.6863587969766;997.1374760831828;4669.4396672399525;4683.531646835289;4683.8360657376825;4690.132325519789;4711.45818230901;5508.283923089973;5508.724563771795;5515.393306736256;5536.141898005735;5543.61194716366;4580.152671755736;4713.481517033124;4713.9764301178275;4719.362886010414;4831.73425461596;2994.5358469437274;3004;3009.593704849817;3018.849057547158;3021.471242532548;5254.894902101936;5268.446813084647;5275.7362131894015;5276.445973172838;5287.920681189786;5549.778008879681;5766.769329226868;5786.855328616818;5788.392218817048;5811.099279611667;5277.1292736698015;5279.709615971158;5287.101192797234;5289.391719952255;5312.707801070978;5324.494173053554;5587.832365029056;5627.577931655224;5641;5657.632253903483;5493.121100623881;5513.972430137984;5523.309586301712;5529.253550770594;5529.889402212014;5251.501107394792;5262.447443018581;5264.73676316175;5265.868353291198;5267.130923397596;3831.425286207091;3872.322343589804;3886.5336159661024;3891.8248678810087;3916.804159792056;5552.583556233218;5560.388357280615;5570.749316280858;5582.274304340573;5584.413636568264;5397.190421436816;5400.729963501888;5416.702081385404;5427.972860135674;5432.375276843213;5246.3704355477585;5404.216388623706;5406.918896216481;5423.9186412204635;5435.945640543544;5077.8730531737;5289.6826190427155;5318.627696061239;5325.786968521371;5335.1730481775385;5252.9737351313;5416.83749487516;5437.238786569963;5467.72661366938;5489.39616642177;5293.338332708411;5303.761330740049;5306.708131052829;5311.575073993994;5311.840644780663 02:12:54 INFO - PROCESS | 3384 | |5;yui.html;624.5378419969223;638.4477427025624;713.5968177979441;729.5221629832458;733.9486235963485;10779.676609701712;11320.207585469021;11735.882641173597;11854.703632409193;12007.939960300208;12276.202046866969;12278.938605306961;12395.38023098846;12406.193597416162;12435.689107772288;625.1872565664618;765.4679997401807;777.7316825695154;786.5831109511968;787.1498781316164;754.5962909843234;789.3842802613971;790.7034861926777;793.972210972616;794.2573693596477;822.3667775812621;822.4859462835727;824.9422540422173;825.8183199696057;825.84721826462;641.5573254454458;788.1724189600897;822.3010441125026;822.9876551851727;824.1470078468786;592.7421571616361;593.1902952469891;594.447164137352;594.551113908996;594.7115648910275;11812.763744725144;11876.643700688994;11889.464974076187;11903.880961190363;11906.34515101669;12205.877941220562;12706.475222973302;12728.872711272861;12957;13011.154274972192;9582;9752.561134748954;9779.951100244525;9812.754681132958;9936.205103591696;3157.6368717597543;3178.7457003439667;3181.3955348483714;3223.8065716057113;3251.7886337387995;47845.28232076522;49940.50059499359;50552.74723626358;50618.493815061745;50757;9182.127697868691;9213.12475314844;9221.538923053955;9416.293777966679;9451.385659932082;16401.42595009169;16494.34022639081;16497.587560311087;16541.58646033835;16551.91724041372;6693.364130407604;6703.262641109474;6780.186377634715;6808.8978665320055;6931.653417329113;3585.695215906625;3617.5116359291687;3667.3032123896373;3726.1988672435014;3751.343514884939;2693.7440943110373;2724.741149590786;2734.5214587447517;2735.548634475329;2737.1925282041843;461.88452886778305;465.1000314391663;467.13813014987295;473.22155054935126;473.97393143377445;500.432009669021;563.5463451921161;569.7037540478927;578.1876463568609;586.4663156527539;7109.324614161646;7210.783676489714;7522.623868806538;7619.4556677611145;7849.193141326452;489.83835334339585;533.7277988226033;553.914143307788;556.3935310511481;558.7290164270325;3315.469386341229;3425.880094196691;3431.3480438716565;3520.190356218084;3526.947095793565;48907;49768.75115624399;50709.23936140961;50890.236646450336;51377.74311128495;42143;43316.78341608272;44024;44451.55548444539;44877;36300.27399452049;36378.45432318517;36697;36950.445743313874;38238;6444.806655800334;6502.252240992158;6510.088587597835;6851.143607049119;7059.5764254144915;24392.26823195307;26897.731022690306;27569.448611027266;27646.44707105887;27748.44503109967;34551.82724086363;36224;37283.25433491369;37585;37601;9792.951035244778;9842;10088.596456141671;10125.139363154214;10197.490125493547;10676.89323106759;10731.517081731185;10927.562897484011;11022.614208502664;11067.778644426906;7892.447528672938;8423.578821059045;10223.1821454282;10272.537735801758;10323.277370584288;9693.70918872435;10086.29395942277;10201.081902628799;10312.071913527818;10387.948060259952;9995.850062249217;10104.848427273744;10420.635277765241;10658.25392222568;10675.412852293199;8726.563671816257;8815.911840881508;8880.289576833968;9085.227755640844;9235.492047937429;8363.525513850062;8762.430442021248;8909.866352004854;8935.776605584653;8947.776305592151 02:12:54 INFO - PROCESS | 3384 | __end_tp_report 02:12:54 INFO - PROCESS | 3384 | __start_cc_report 02:12:54 INFO - PROCESS | 3384 | _x_x_mozilla_cycle_collect,1010 02:12:54 INFO - PROCESS | 3384 | __end_cc_report 02:12:54 INFO - PROCESS | 3384 | __startTimestamp1461316374114__endTimestamp 02:12:54 INFO - PROCESS | 3384 | 02:12:54 INFO - PROCESS | 3384 | ------- Summary: start ------- 02:12:54 INFO - PROCESS | 3384 | Number of tests: 6 02:12:54 INFO - PROCESS | 3384 | 02:12:54 INFO - PROCESS | 3384 | [#0] dojo.html Cycles:165 Average:4615.08 Median:4760.76 stddev:472.07 (9.9%) stddev-sans-first:446.11 02:12:54 INFO - PROCESS | 3384 | Values: 2594.6 2670.1 2672.4 2682.0 2704.4 4533.7 4621.3 4633.8 4646.9 4649.7 4693.1 4696.8 4722.0 4770.7 4790.9 4253.9 4306.4 4338.7 4362.0 4426.3 4341.0 4367.6 4383.8 4395.0 4448.1 4188.5 4252.2 4260.9 4278.6 4344.0 4282.4 4311.3 4316.7 4317.2 4367.1 4294.6 4298.2 4306.0 4331.6 4344.5 4458.3 4535.0 4565.3 4605.1 4662.0 5037.6 5038.5 5039.2 5060.0 5108.9 4945.5 5057.6 5078.7 5083.7 5091.4 4688.8 4760.8 4770.0 4771.3 4774.6 5085.9 5107.0 5109.8 5111.4 5116.9 4893.0 4893.8 4895.9 4903.3 4949.5 4906.5 4943.0 4987.8 5008.8 5027.3 4888.0 4898.6 4903.9 4915.7 4969.6 4826.1 4900.2 4900.4 4902.8 4963.1 4205.1 4214.8 4228.9 4229.1 4230.6 3674.6 3704.7 3705.4 3745.2 3755.5 4259.3 4263.9 4269.5 4270.0 4302.1 4904.9 4952.7 4989.4 5024.3 5050.8 4280.1 4299.9 4320.7 4327.4 4328.6 4420.1 4452.0 4452.7 4456.6 4497.8 4605.3 4694.8 4694.9 4695.6 4733.4 4996.5 5016.6 5055.8 5089.4 5101.0 4721.2 4723.0 4723.2 4726.8 4777.8 4797.9 4893.6 4901.3 4931.6 4986.6 4935.6 4969.1 4969.8 4982.2 5008.9 4787.9 4801.0 4813.5 4815.4 4851.6 4780.0 4811.3 4856.0 4876.0 4973.1 4741.1 4749.6 4764.5 4807.1 4813.7 4871.2 4872.9 4877.6 4880.5 4920.7 4715.6 4753.7 4813.5 4824.5 4828.6 02:12:54 INFO - PROCESS | 3384 | 02:12:54 INFO - PROCESS | 3384 | [#1] ext.html Cycles:180 Average:41626.12 Median:33748.91 stddev:74076.59 (219.5%) stddev-sans-first:74220.25 02:12:54 INFO - PROCESS | 3384 | Values: 567.4 598.1 601.5 607.1 620.6 33715.5 34703.1 34799.1 34808.3 34826.7 38762.0 39979.8 40082.4 40148.4 40170.2 7222.7 7782.8 7990.6 9436.3 9734.4 9605.9 9742.4 9749.0 9776.4 9777.5 9722.3 9786.3 9788.2 9803.4 9823.9 7452.2 9770.6 10076.8 10131.0 10180.6 9613.7 9785.5 9803.0 9809.2 9831.9 33731.2 34241.0 34334.8 34336.5 34356.5 2676.3 2821.5 3138.4 3251.5 3327.7 27456.7 27972.2 27974.0 28610.0 29005.1 3297.6 3321.5 3354.3 3413.8 3428.5 251477.0 253467.0 253799.0 253937.0 254014.0 32170.8 33185.5 33189.0 49656.8 50456.5 31328.2 31480.1 31488.5 31521.2 31556.8 10135.4 11124.4 11241.7 11243.6 11253.8 8785.9 8920.2 8936.6 9505.5 9858.6 7944.9 7977.8 7985.0 8035.6 8051.0 3125.0 3133.2 3165.8 3181.4 3188.8 883.7 896.0 908.5 945.5 983.8 25783.4 25994.9 26788.6 26789.7 26841.0 963.6 967.9 970.5 989.8 1022.4 13959.4 14055.4 14290.7 14490.5 14550.7 338493.0 341944.0 345701.0 346065.0 349260.0 47283.8 48089.0 48195.8 48200.5 48250.0 1077.2 1120.7 1124.4 1186.0 1234.1 25320.4 26916.3 27242.7 27314.5 27511.6 37241.4 37712.2 37755.0 37812.4 37839.2 234992.0 236424.0 236494.0 236863.5 237002.0 22174.6 23395.2 24328.0 24342.5 24434.1 35878.8 35998.8 36143.8 36799.3 37147.6 33384.5 33558.0 33846.5 33850.3 34295.0 33206.2 33631.8 33686.0 33766.7 33980.8 33172.8 33390.5 33474.8 33559.7 33790.5 28683.6 29791.3 29901.9 30136.2 30219.1 23406.5 23676.9 23969.3 24088.6 24092.6 02:12:54 INFO - PROCESS | 3384 | 02:12:54 INFO - PROCESS | 3384 | [#2] jquery.html Cycles:180 Average:25553.52 Median:412786.19 stddev:67911.34 (16.5%) stddev-sans-first:68075.54 02:12:54 INFO - PROCESS | 3384 | Values: 375.1 375.9 379.1 387.8 396.2 15957.6 16191.2 17000.3 17012.6 17022.0 13130.7 14510.3 14521.9 14546.8 14558.8 4372.7 4702.2 4704.8 4705.1 4707.7 3462.8 3635.1 6453.4 6829.9 6842.9 6748.8 6806.4 6827.2 6834.9 6907.1 6739.4 6847.9 6855.3 6900.1 6906.7 6430.4 6819.5 6822.7 6823.3 6831.8 21927.1 21934.2 22156.2 22945.0 22982.4 1969.4 1991.6 2063.5 2127.5 2131.6 13558.2 14043.2 14242.6 14314.9 14917.0 1909.3 1917.5 1925.3 1961.8 1995.0 80050.0 80058.2 80565.0 82066.6 82495.6 15289.3 16152.0 16264.0 16419.6 16642.0 29163.3 29220.3 29284.4 29468.7 29613.9 8038.9 8228.3 8361.0 8510.7 8559.9 6815.4 6830.1 6904.5 6957.4 7044.3 7202.9 8288.1 8317.8 8404.0 8427.9 2645.6 3252.3 3324.6 3389.3 3505.4 794.0 861.7 886.7 916.6 919.9 16336.8 16443.8 16491.3 16674.3 17104.3 819.1 852.0 856.2 870.1 870.6 8926.8 9051.6 9311.8 9492.4 9507.4 410763.0 412140.0 413432.4 415950.0 416414.0 44794.3 48846.8 59369.1 70612.0 71631.6 844.0 852.7 855.6 864.0 884.6 14409.4 14534.9 14663.9 14686.2 15028.5 31610.5 32763.3 34706.5 35751.1 36748.0 43106.4 44355.6 46108.8 47530.8 48133.0 7700.9 7881.8 7939.5 8071.0 8231.8 10961.9 11997.5 12143.9 12216.0 12304.9 10518.3 10562.6 10645.1 10712.7 10748.3 7624.7 10419.9 10566.1 10727.2 10957.6 5847.2 8423.7 10643.7 10850.1 10864.1 7718.5 7743.2 7852.9 7895.4 7990.0 10477.8 10525.5 10556.2 10623.0 10653.3 02:12:54 INFO - PROCESS | 3384 | 02:12:54 INFO - PROCESS | 3384 | [#3] mootools.html Cycles:180 Average:5107.23 Median:4648.33 stddev:2864.04 (61.6%) stddev-sans-first:2857.50 02:12:54 INFO - PROCESS | 3384 | Values: 1263.4 1438.8 1475.1 1603.3 1745.3 7610.4 7884.8 7913.0 7916.4 7917.0 7699.5 7758.8 7762.7 7775.9 7855.3 1921.7 2202.1 2215.8 2241.6 2268.6 2226.5 2299.3 2302.5 2303.2 2305.0 2232.5 2276.1 2285.3 2286.8 2287.5 1958.7 2108.4 2154.6 2156.3 2162.1 2062.7 2082.5 2090.7 2092.8 2121.5 7760.7 7835.1 7961.6 7984.8 8017.0 4500.6 4640.3 4648.8 4657.0 4682.0 2914.9 2954.2 2959.6 3010.7 3021.5 953.6 1819.7 1829.1 1852.0 1893.8 10273.6 10375.8 10376.3 10393.8 10394.3 4049.4 4095.3 4237.1 4257.6 4295.6 8190.0 8192.6 8201.4 8206.5 8208.5 4080.0 4647.9 4658.5 4667.0 4667.6 4056.7 4125.3 4132.0 4147.6 4169.8 3397.7 3409.1 3493.8 3515.9 3520.0 1051.6 1092.1 1093.7 1103.3 1106.3 635.3 718.2 769.3 774.0 796.6 5001.5 5125.2 5189.7 5225.8 5245.4 398.3 403.7 408.2 410.8 413.3 3363.6 3365.1 3388.6 3422.7 3446.2 9623.2 9921.5 10081.8 10147.9 10149.2 9298.8 9889.1 9918.8 9976.7 9988.6 7347.4 7437.5 7504.1 7525.1 7525.4 4995.4 5077.1 5169.2 5198.5 5232.3 8795.6 8796.4 8837.3 8837.4 8886.0 8852.8 8970.4 9085.6 9125.4 9235.4 6576.6 7072.4 7195.0 7271.5 7278.8 7333.2 7338.6 7390.2 7394.9 7398.4 6631.4 6725.7 6732.9 6838.0 6845.3 6385.8 6476.4 6622.2 6667.4 6671.3 5830.5 5866.6 5879.6 5891.7 5899.9 4301.8 4405.0 4453.2 4496.7 4560.8 4521.2 4530.6 4580.6 4628.5 4632.0 02:12:54 INFO - PROCESS | 3384 | 02:12:54 INFO - PROCESS | 3384 | [#4] prototype.html Cycles:180 Average:4491.81 Median:5111.26 stddev:1295.02 (25.3%) stddev-sans-first:1260.13 02:12:54 INFO - PROCESS | 3384 | Values: 314.9 318.9 325.7 325.9 327.6 5105.4 5154.9 5156.3 5186.7 5187.2 5080.5 5086.3 5092.2 5107.7 5114.8 3817.4 3926.2 3947.1 4034.4 4037.0 4010.3 4010.7 4022.6 4026.2 4029.4 3788.7 3999.7 3999.9 4000.8 4007.1 3876.6 4012.4 4013.2 4017.3 4022.0 3559.5 3560.1 3564.3 3567.6 3570.6 4890.1 4893.0 4903.6 4907.3 4910.7 4376.9 4624.7 4632.2 4636.4 4647.8 5361.3 5376.2 5379.7 5379.8 5384.6 3898.5 3900.8 3904.6 3906.9 3908.8 5513.5 5550.3 5596.4 5632.4 5633.2 4000.8 4016.1 4017.1 4036.2 4041.5 4076.3 4084.8 4089.2 4103.4 4104.1 4390.7 4601.6 4604.4 4619.0 4624.1 5389.7 5398.7 5406.7 5417.2 5427.3 1397.8 1415.1 1418.7 1422.8 1426.9 916.2 962.9 978.0 995.7 997.1 4669.4 4683.5 4683.8 4690.1 4711.5 5508.3 5508.7 5515.4 5536.1 5543.6 4580.2 4713.5 4714.0 4719.4 4831.7 2994.5 3004.0 3009.6 3018.8 3021.5 5254.9 5268.4 5275.7 5276.4 5287.9 5549.8 5766.8 5786.9 5788.4 5811.1 5277.1 5279.7 5287.1 5289.4 5312.7 5324.5 5587.8 5627.6 5641.0 5657.6 5493.1 5514.0 5523.3 5529.3 5529.9 5251.5 5262.4 5264.7 5265.9 5267.1 3831.4 3872.3 3886.5 3891.8 3916.8 5552.6 5560.4 5570.7 5582.3 5584.4 5397.2 5400.7 5416.7 5428.0 5432.4 5246.4 5404.2 5406.9 5423.9 5435.9 5077.9 5289.7 5318.6 5325.8 5335.2 5253.0 5416.8 5437.2 5467.7 5489.4 5293.3 5303.8 5306.7 5311.6 5311.8 02:12:54 INFO - PROCESS | 3384 | 02:12:54 INFO - PROCESS | 3384 | [#5] yui.html Cycles:180 Average:12139.36 Median:24698.42 stddev:13966.93 (56.5%) stddev-sans-first:13979.34 02:12:54 INFO - PROCESS | 3384 | Values: 624.5 638.4 713.6 729.5 733.9 10779.7 11320.2 11735.9 11854.7 12007.9 12276.2 12278.9 12395.4 12406.2 12435.7 625.2 765.5 777.7 786.6 787.1 754.6 789.4 790.7 794.0 794.3 822.4 822.5 824.9 825.8 825.8 641.6 788.2 822.3 823.0 824.1 592.7 593.2 594.4 594.6 594.7 11812.8 11876.6 11889.5 11903.9 11906.3 12205.9 12706.5 12728.9 12957.0 13011.2 9582.0 9752.6 9780.0 9812.8 9936.2 3157.6 3178.7 3181.4 3223.8 3251.8 47845.3 49940.5 50552.7 50618.5 50757.0 9182.1 9213.1 9221.5 9416.3 9451.4 16401.4 16494.3 16497.6 16541.6 16551.9 6693.4 6703.3 6780.2 6808.9 6931.7 3585.7 3617.5 3667.3 3726.2 3751.3 2693.7 2724.7 2734.5 2735.5 2737.2 461.9 465.1 467.1 473.2 474.0 500.4 563.5 569.7 578.2 586.5 7109.3 7210.8 7522.6 7619.5 7849.2 489.8 533.7 553.9 556.4 558.7 3315.5 3425.9 3431.3 3520.2 3526.9 48907.0 49768.8 50709.2 50890.2 51377.7 42143.0 43316.8 44024.0 44451.6 44877.0 36300.3 36378.5 36697.0 36950.4 38238.0 6444.8 6502.3 6510.1 6851.1 7059.6 24392.3 26897.7 27569.4 27646.4 27748.4 34551.8 36224.0 37283.3 37585.0 37601.0 9793.0 9842.0 10088.6 10125.1 10197.5 10676.9 10731.5 10927.6 11022.6 11067.8 7892.4 8423.6 10223.2 10272.5 10323.3 9693.7 10086.3 10201.1 10312.1 10387.9 9995.9 10104.8 10420.6 10658.3 10675.4 8726.6 8815.9 8880.3 9085.2 9235.5 8363.5 8762.4 8909.9 8935.8 8947.8 02:12:54 INFO - PROCESS | 3384 | -------- Summary: end -------- 02:12:54 INFO - PROCESS | 3384 | 02:12:54 INFO - TEST-INFO | 3384: exit 0 02:12:54 INFO - TEST-OK | dromaeo_css | took 1121848ms 02:12:54 INFO - TEST-START | kraken 02:12:54 INFO - operating with platform_type : linux_ 02:12:54 INFO - Initialising browser for kraken test... 02:12:54 INFO - TEST-INFO | started process 3563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp1SkFN/profile http://localhost:50633/getInfo.html) 02:12:59 INFO - PROCESS | 3563 | __metrics Screen width/height:1600/1200 02:12:59 INFO - PROCESS | 3563 | colorDepth:24 02:12:59 INFO - PROCESS | 3563 | Browser inner width/height: 1024/697 02:12:59 INFO - PROCESS | 3563 | __metrics 02:13:00 ERROR - PROCESS | 3563 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:13:01 INFO - TEST-INFO | 3563: exit 0 02:13:01 INFO - Browser initialized. 02:13:01 INFO - Running cycle 1/1 for kraken test... 02:13:01 INFO - TEST-INFO | started process 3645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp1SkFN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:13 INFO - PROCESS | 3645 | RSS: Main: 155308032 02:13:13 INFO - PROCESS | 3645 | 02:13:16 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50633/tests/kraken/driver.html?testName=audio-beat-detection) 02:13:17 INFO - PROCESS | 3645 | RSS: Main: 209989632 02:13:17 INFO - PROCESS | 3645 | 02:13:19 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50633/tests/kraken/driver.html?testName=audio-dft) 02:13:20 INFO - PROCESS | 3645 | RSS: Main: 195231744 02:13:20 INFO - PROCESS | 3645 | 02:13:23 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50633/tests/kraken/driver.html?testName=audio-fft) 02:13:24 INFO - PROCESS | 3645 | RSS: Main: 267124736 02:13:24 INFO - PROCESS | 3645 | 02:13:26 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50633/tests/kraken/driver.html?testName=audio-oscillator) 02:13:27 INFO - PROCESS | 3645 | RSS: Main: 175030272 02:13:27 INFO - PROCESS | 3645 | 02:13:29 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50633/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:13:30 INFO - PROCESS | 3645 | RSS: Main: 179200000 02:13:30 INFO - PROCESS | 3645 | 02:13:33 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50633/tests/kraken/driver.html?testName=imaging-darkroom) 02:13:33 INFO - PROCESS | 3645 | RSS: Main: 215105536 02:13:33 INFO - PROCESS | 3645 | 02:13:37 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50633/tests/kraken/driver.html?testName=imaging-desaturate) 02:13:37 INFO - PROCESS | 3645 | RSS: Main: 215715840 02:13:37 INFO - PROCESS | 3645 | 02:13:40 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50633/tests/kraken/driver.html?testName=json-parse-financial) 02:13:41 INFO - PROCESS | 3645 | RSS: Main: 215826432 02:13:41 INFO - PROCESS | 3645 | 02:13:42 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50633/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:13:43 INFO - PROCESS | 3645 | RSS: Main: 200597504 02:13:43 INFO - PROCESS | 3645 | 02:13:45 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50633/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:13:46 INFO - PROCESS | 3645 | RSS: Main: 203751424 02:13:46 INFO - PROCESS | 3645 | 02:13:48 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50633/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:13:48 INFO - PROCESS | 3645 | RSS: Main: 219295744 02:13:48 INFO - PROCESS | 3645 | 02:13:51 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:13:52 INFO - PROCESS | 3645 | RSS: Main: 225488896 02:13:52 INFO - PROCESS | 3645 | 02:13:55 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:13:55 INFO - PROCESS | 3645 | RSS: Main: 220311552 02:13:55 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:50633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50633/tests/kraken/driver.html?testName=ai-astar) 02:13:57 INFO - PROCESS | 3645 | RSS: Main: 283979776 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | __start_tp_report 02:13:57 INFO - PROCESS | 3645 | _x_x_mozilla_page_load 02:13:57 INFO - PROCESS | 3645 | _x_x_mozilla_page_load_details 02:13:57 INFO - PROCESS | 3645 | |i|pagename|runs| 02:13:57 INFO - PROCESS | 3645 | |0;ai-astar;112;114;108;113;113;113;102;113;113;113 02:13:57 INFO - PROCESS | 3645 | |1;audio-beat-detection;155;135;163;187;136;157;163;135;195;140 02:13:57 INFO - PROCESS | 3645 | |2;audio-dft;161;161;160;162;161;160;162;162;162;160 02:13:57 INFO - PROCESS | 3645 | |3;audio-fft;77;77;110;108;74;73;73;127;98;77 02:13:57 INFO - PROCESS | 3645 | |4;audio-oscillator;95;96;151;93;92;93;146;93;93;149 02:13:57 INFO - PROCESS | 3645 | |5;imaging-gaussian-blur;117;117;116;117;117;119;117;117;116;116 02:13:57 INFO - PROCESS | 3645 | |6;imaging-darkroom;147;146;146;145;145;146;145;145;145;146 02:13:57 INFO - PROCESS | 3645 | |7;imaging-desaturate;94;95;94;95;95;95;95;94;94;95 02:13:57 INFO - PROCESS | 3645 | |8;json-parse-financial;65;65;66;66;65;64;64;89;62;63 02:13:57 INFO - PROCESS | 3645 | |9;json-stringify-tinderbox;64;64;63;64;63;64;63;64;63;64 02:13:57 INFO - PROCESS | 3645 | |10;stanford-crypto-aes;82;79;78;88;79;80;81;79;79;80 02:13:57 INFO - PROCESS | 3645 | |11;stanford-crypto-ccm;135;136;146;133;129;132;130;130;174;137 02:13:57 INFO - PROCESS | 3645 | |12;stanford-crypto-pbkdf2;192;172;178;184;179;179;183;183;175;177 02:13:57 INFO - PROCESS | 3645 | |13;stanford-crypto-sha256-iterative;75;73;73;72;74;71;71;72;74;73 02:13:57 INFO - PROCESS | 3645 | __end_tp_report 02:13:57 INFO - PROCESS | 3645 | __start_cc_report 02:13:57 INFO - PROCESS | 3645 | _x_x_mozilla_cycle_collect,1903 02:13:57 INFO - PROCESS | 3645 | __end_cc_report 02:13:57 INFO - PROCESS | 3645 | __startTimestamp1461316437823__endTimestamp 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | ------- Summary: start ------- 02:13:57 INFO - PROCESS | 3645 | Number of tests: 14 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.69 (3.3%) stddev-sans-first:3.91 02:13:57 INFO - PROCESS | 3645 | Values: 112.0 114.0 108.0 113.0 113.0 113.0 102.0 113.0 113.0 113.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#1] audio-beat-detection Cycles:10 Average:156.60 Median:160.00 stddev:21.39 (13.4%) stddev-sans-first:22.68 02:13:57 INFO - PROCESS | 3645 | Values: 155.0 135.0 163.0 187.0 136.0 157.0 163.0 135.0 195.0 140.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 02:13:57 INFO - PROCESS | 3645 | Values: 161.0 161.0 160.0 162.0 161.0 160.0 162.0 162.0 162.0 160.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#3] audio-fft Cycles:10 Average:89.40 Median:75.50 stddev:19.70 (26.1%) stddev-sans-first:20.38 02:13:57 INFO - PROCESS | 3645 | Values: 77.0 77.0 110.0 108.0 74.0 73.0 73.0 127.0 98.0 77.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:26.66 (28.7%) stddev-sans-first:27.72 02:13:57 INFO - PROCESS | 3645 | Values: 95.0 96.0 151.0 93.0 92.0 93.0 146.0 93.0 93.0 149.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 02:13:57 INFO - PROCESS | 3645 | Values: 117.0 117.0 116.0 117.0 117.0 119.0 117.0 117.0 116.0 116.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 02:13:57 INFO - PROCESS | 3645 | Values: 147.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:13:57 INFO - PROCESS | 3645 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:65.00 stddev:7.87 (12.1%) stddev-sans-first:8.31 02:13:57 INFO - PROCESS | 3645 | Values: 65.0 65.0 66.0 66.0 65.0 64.0 64.0 89.0 62.0 63.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 02:13:57 INFO - PROCESS | 3645 | Values: 64.0 64.0 63.0 64.0 63.0 64.0 63.0 64.0 63.0 64.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:2.88 (3.6%) stddev-sans-first:3.00 02:13:57 INFO - PROCESS | 3645 | Values: 82.0 79.0 78.0 88.0 79.0 80.0 81.0 79.0 79.0 80.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:135.50 stddev:13.51 (10.0%) stddev-sans-first:14.28 02:13:57 INFO - PROCESS | 3645 | Values: 135.0 136.0 146.0 133.0 129.0 132.0 130.0 130.0 174.0 137.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:181.00 stddev:5.59 (3.1%) stddev-sans-first:3.98 02:13:57 INFO - PROCESS | 3645 | Values: 192.0 172.0 178.0 184.0 179.0 179.0 183.0 183.0 175.0 177.0 02:13:57 INFO - PROCESS | 3645 | 02:13:57 INFO - PROCESS | 3645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:1.32 (1.8%) stddev-sans-first:1.13 02:13:57 INFO - PROCESS | 3645 | Values: 75.0 73.0 73.0 72.0 74.0 71.0 71.0 72.0 74.0 73.0 02:13:57 INFO - PROCESS | 3645 | -------- Summary: end -------- 02:13:57 INFO - PROCESS | 3645 | 02:13:58 INFO - TEST-INFO | 3645: exit 0 02:13:58 INFO - TEST-OK | kraken | took 63994ms 02:13:58 INFO - SUITE-END | took 1185s 02:13:58 INFO - Completed test suite (00:19:45) 02:13:58 INFO - javascript benchmark 02:13:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.5718956372198, 2670.1455534229053, 2672.3645307957963, 2681.973180268198, 2704.3509557706143, 4533.7053091549105, 4621.260598304272, 4633.791479383427, 4646.860594182172, 4649.674522783406, 4693.131770622429, 4696.765161741916, 4722.031983443395, 4770.713757174572, 4790.856274311776, 4253.8723838284905, 4306.418633484479, 4338.652907767387, 4362.040351122764, 4426.336049592571, 4341.044970106587, 4367.628751556122, 4383.846565370212, 4394.989152494928, 4448.110377924428, 4188.47644044496, 4252.213340532012, 4260.893477663052, 4278.593533614302, 4344.02259491615, 4282.42187304713, 4311.28863737483, 4316.6546676265825, 4317.244482215599, 4367.126574685044, 4294.592013758688, 4298.226319262531, 4306.0, 4331.588499092612, 4344.522102568715, 4458.286674132156, 4534.977325113353, 4565.292379681155, 4605.102005109005, 4661.953380466186, 5037.5718063964605, 5038.521340472649, 5039.21892106724, 5060.038592667382, 5108.897822043576, 4945.530174633404, 5057.595392368638, 5078.6698864574055, 5083.720395378253, 5091.389033315989, 4688.765561721901, 4760.7619619018915, 4769.974455492086, 4771.33201351811, 4774.594159496482, 5085.923711144335, 5107.004134193797, 5109.821156259513, 5111.361079865017, 5116.923246151311, 4893.0458560581055, 4893.779779909913, 4895.926561101586, 4903.338049363361, 4949.529794669501, 4906.484819094015, 4942.950570494249, 4987.800487980513, 5008.799648014038, 5027.271045698426, 4888.02239552091, 4898.608111351084, 4903.901921961541, 4915.680480768739, 4969.552740253394, 4826.0589185108565, 4900.240462728283, 4900.436449808247, 4902.803887844518, 4963.057019166346, 4205.095904380573, 4214.789260536961, 4228.894277643022, 4229.090745489734, 4230.61924426803, 3674.614165512636, 3704.6665800077585, 3705.444183372516, 3745.1760612665717, 3755.549334079928, 4259.2759230930815, 4263.914721705549, 4269.509006464296, 4269.996550810557, 4302.075053863435, 4904.901901962012, 4952.678075925053, 4989.351384320015, 5024.321716568216, 5050.797968081309, 4280.101178752497, 4299.871003869889, 4320.740755554677, 4327.394164816928, 4328.567143285709, 4420.071784925138, 4451.998300382388, 4452.732836029849, 4456.598906098402, 4497.752623605667, 4605.309203619484, 4694.765261736968, 4694.859154225379, 4695.647826413101, 4733.384659994179, 4996.525330093636, 5016.573591244639, 5055.823046193365, 5089.3638295213095, 5100.974495127649, 4721.197396442544, 4723.031778485333, 4723.173444647242, 4726.8109275628585, 4777.784999675093, 4797.928031079467, 4893.559579637849, 4901.264810278487, 4931.556159945622, 4986.626003049713, 4935.62982776286, 4969.055879382906, 4969.776360063734, 4982.177940639754, 5008.949910500848, 4787.880302992453, 4800.95199048019, 4813.470518242921, 4815.374001379798, 4851.587615052619, 4779.95220047809, 4811.302361157543, 4855.95144048555, 4875.975620121877, 4973.055119527278, 4741.075490279362, 4749.572538471554, 4764.475907650087, 4807.134715751198, 4813.663043586916, 4871.171900776805, 4872.853814385574, 4877.585405240594, 4880.46314905353, 4920.6801557898625, 4715.552022557851, 4753.714777113384, 4813.470518242921, 4824.517548245288, 4828.61371090319], "value": 4585.88560735537, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.4013915319339, 598.0640297933734, 601.5037593984962, 607.1136141233799, 620.587309439223, 33715.49426758598, 34703.132421689435, 34799.13002174947, 34808.30383392337, 34826.65173348263, 38762.0, 39979.80010099953, 40082.39876401849, 40148.397774033416, 40170.19659606806, 7222.74720384784, 7782.805429864256, 7990.640421181031, 9436.292278079138, 9734.41593504392, 9605.90394096057, 9742.366746161477, 9748.951255243714, 9776.413415195075, 9777.462239576857, 9722.270829687766, 9786.314957952945, 9788.21694264457, 9803.362781419184, 9823.852642210373, 7452.217517160701, 9770.609175632966, 10076.798464030751, 10131.0, 10180.592776288939, 9613.663521776703, 9785.461799601018, 9802.9509852451, 9809.21526277896, 9831.90168098317, 33731.15672108193, 34241.0, 34334.82832585821, 34336.48495272573, 34356.48465273023, 2676.317539027555, 2821.548552231633, 3138.4350816852957, 3251.493032514923, 3327.73378129749, 27456.725432745618, 27972.160835174775, 27974.0, 28610.0, 29005.12984610444, 3297.5713157289397, 3321.4519604265265, 3354.26206234628, 3413.846376913045, 3428.5200071989693, 251477.0, 253467.0, 253799.0, 253937.0, 254014.0, 32170.839145804122, 33185.502217466754, 33189.0, 49656.75171624119, 50456.49543504518, 31328.21679457986, 31480.05559833209, 31488.527672084478, 31521.21196970094, 31556.842215788773, 10135.391876487287, 11124.443777811077, 11241.71895702614, 11243.550257989753, 11253.831192532118, 8785.912140878509, 8920.197182253498, 8936.553172341486, 9505.477198753997, 9858.556364963593, 7944.9205507945335, 7977.760667179994, 7984.96195494582, 8035.638396272182, 8051.0, 3124.9687603090924, 3133.185371803302, 3165.8100513969234, 3181.3637272545584, 3188.776785624984, 883.7403714098114, 895.9641614335484, 908.5139450394007, 945.5083356654638, 983.7540614846289, 25783.355416114373, 25994.87002565013, 26788.59817102745, 26789.732102679114, 26841.0, 963.5856581669809, 967.9032096790405, 970.5486948568949, 989.8069876374182, 1022.4018948914968, 13959.441622334993, 14055.43778248879, 14290.714185716435, 14490.492832751013, 14550.708985820436, 338493.0, 341944.0, 345701.0, 346065.0, 349260.0, 47283.76358118256, 48089.0, 48195.75902120537, 48200.5179948196, 48250.0, 1077.2297807067985, 1120.6918097523082, 1124.3591153042687, 1185.962283002373, 1234.0621127942827, 25320.366990825376, 26916.327091822863, 27242.72757272402, 27314.453710926067, 27511.58732619052, 37241.441378378804, 37712.24575508529, 37755.0, 37812.43281350837, 37839.24321513609, 234992.0, 236424.0, 236494.0, 236863.5254589866, 237002.0, 22174.55650886941, 23395.181168659015, 24328.0, 24342.51314973726, 24434.144804932454, 35878.820605896806, 35998.820005899805, 36143.81928090448, 36799.26401471902, 37147.628523715495, 33384.49923251202, 33558.0, 33846.492302614985, 33850.32299354048, 34295.0, 33206.16984575405, 33631.81498460989, 33686.0, 33766.66233337635, 33980.83009585035, 33172.834135829165, 33390.49914251337, 33474.832625836716, 33559.66440335663, 33790.49314260239, 28683.56974645424, 29791.25521861884, 29901.850490747405, 30136.24659383533, 30219.09342719722, 23406.531869362178, 23676.88161559181, 23969.28092157238, 24088.638670420307, 24092.63861042051], "value": 15903.787663545636, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.1390558667858, 375.91353988582625, 379.11854937270846, 387.80609695152424, 396.20758483033933, 15957.601059973493, 16191.190440477973, 17000.319987200528, 17012.574685632866, 17022.0, 13130.737385252289, 14510.274486275697, 14521.92739036306, 14546.781798273008, 14558.781618275709, 4372.693911426193, 4702.153612349775, 4704.811807527712, 4705.106029854333, 4707.741074240916, 3462.809545474998, 3635.0912271932016, 6453.419192272694, 6829.93170068298, 6842.931570684279, 6748.797536073926, 6806.3874251317375, 6827.249002609709, 6834.897476537856, 6907.13660792401, 6739.393454589086, 6847.897281540781, 6855.280195579442, 6900.102986611759, 6906.689198986058, 6430.356964303579, 6819.488538359643, 6822.692978815916, 6823.283555226729, 6831.829204269883, 21927.12291508338, 21934.232301869517, 22156.22453214146, 22945.0, 22982.425439363982, 1969.4091772468203, 1991.6415045291842, 2063.47381417739, 2127.500037491204, 2131.5630295789483, 13558.186508809504, 14043.22762248076, 14242.572722818331, 14314.928425357806, 14917.0, 1909.2935613822835, 1917.5493758966632, 1925.3357591630865, 1961.8430525557922, 1994.9601007979759, 80050.0, 80058.19941800565, 80565.0, 82066.58966705189, 82495.5875220626, 15289.311980960883, 16152.0, 16264.0, 16419.5895102621, 16642.0, 29163.270918227216, 29220.269493262414, 29284.41431171365, 29468.705312947026, 29613.85193074021, 8038.8794168087525, 8228.341732661373, 8360.958195208985, 8510.74467765968, 8559.914400856036, 6815.352541508648, 6830.112085428863, 6904.4821638377325, 6957.443404527626, 7044.260352662999, 7202.855942881113, 8288.093738440193, 8317.750467485985, 8404.0, 8427.915720842835, 2645.579294945104, 3252.284497410566, 3324.6176689680997, 3389.322135572895, 3505.4216054351255, 793.9761807145795, 861.67687117331, 886.6542048601051, 916.6002642897048, 919.935604507678, 16336.836631633769, 16443.83556164447, 16491.34034638601, 16674.33302667904, 17104.315827366765, 819.1439945257101, 851.9574021298911, 856.208007592974, 870.0820634230947, 870.5951732444317, 8926.776830579287, 9051.637934482678, 9311.813763724824, 9492.382995105296, 9507.42955422663, 410763.0, 412140.0, 413432.3852134897, 415950.0, 416414.0, 44794.32808507875, 48846.755766220944, 59369.10946335809, 70612.0, 71631.6418417915, 843.9915600843913, 852.7441767469734, 855.5850412549909, 863.9827203456022, 884.6328773558901, 14409.42362305496, 14534.927325363305, 14663.853361466248, 14686.192259425834, 15028.549143525712, 31610.525842111925, 32763.34473310568, 34706.479402809484, 35751.10969565481, 36747.99999999893, 43106.353404699585, 44355.55644443514, 46108.769456152506, 47530.76234618805, 48133.0, 7700.922990770021, 7881.802954926173, 7939.523628582073, 8071.0, 8231.835363292821, 10961.945190273998, 11997.520099195934, 12143.878561214275, 12215.9500658993, 12304.938475307566, 10518.316309439862, 10562.630307939186, 10645.095166910589, 10712.678619641423, 10748.301360411548, 7624.69501219945, 10419.895801041892, 10566.101881340172, 10727.249092563447, 10957.616483423042, 5847.210626565359, 8423.652215645467, 10643.733906652396, 10850.131989440668, 10864.076553493042, 7718.459707820399, 7743.225677432211, 7852.882206767017, 7895.447318687867, 7989.960050199712, 10477.790444190921, 10525.526351314056, 10556.208284378856, 10623.043926046694, 10653.254272200871], "value": 9010.331147373014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.4440846027742, 1438.8345340285866, 1475.0780762023735, 1603.2705119170778, 1745.3280487012496, 7610.429217808666, 7884.80287992799, 7913.0, 7916.40626952978, 7917.04995400552, 7699.461037727361, 7758.767236982885, 7762.728304509344, 7775.922240777591, 7855.25375089367, 1921.7117432385114, 2202.1081462007915, 2215.822734181266, 2241.618924782791, 2268.591653502369, 2226.4990377165173, 2299.344686764264, 2302.470431800687, 2303.2284184798114, 2305.0203663443053, 2232.475368288451, 2276.089564174335, 2285.2572913802996, 2286.7827556382117, 2287.542491501698, 1958.6866101423775, 2108.39910625471, 2154.5690861827698, 2156.299202759094, 2162.13514594162, 2062.742157230346, 2082.5106100066473, 2090.6654935210445, 2092.8116469517818, 2121.469632591852, 7760.689572417096, 7835.0989636191425, 7961.562114083723, 7984.8403031939615, 8017.0, 4500.617447516932, 4640.257558790611, 4648.790804413776, 4657.022025374676, 4682.040181762731, 2914.883404663811, 2954.1875984104327, 2959.6448426188995, 3010.71398217169, 3021.456137895178, 953.6328513522344, 1819.7452356670076, 1829.1494455078453, 1851.9721554537227, 1893.7916829148783, 10273.589056437733, 10375.84436233457, 10376.273660843744, 10393.79212415755, 10394.324368916072, 4049.372347286175, 4095.28332541804, 4237.067845074079, 4257.638100761408, 4295.634871035997, 8190.0, 8192.631331590093, 8201.425900187049, 8206.548639824747, 8208.548529830798, 4079.9592004079577, 4647.86056418308, 4658.510856360102, 4667.0, 4667.556582124693, 4056.6551843093075, 4125.278076336629, 4132.008318003657, 4147.564505726916, 4169.833206671759, 3397.7281817454545, 3409.147713071732, 3493.7554371194283, 3515.9472607910902, 3520.0, 1051.6161601015574, 1092.093562343253, 1093.6937657455926, 1103.3214573037685, 1106.253279036647, 635.2694401438383, 718.192033961793, 769.2922511289627, 773.97678069658, 796.5738329993542, 5001.499850015042, 5125.205593133071, 5189.714565698923, 5225.843224703265, 5245.370555533361, 398.25128757935477, 403.67705835331617, 408.236597562554, 410.8089738271658, 413.32421490862055, 3363.6131844838155, 3365.1250674824723, 3388.610309814403, 3422.691957723767, 3446.2418267981, 9623.182029527568, 9921.454320012324, 10081.798364032678, 10147.9492602538, 10149.188064954933, 9298.767530811649, 9889.06053924876, 9918.752031199134, 9976.700698979042, 9988.550515226832, 7347.37547308474, 7437.479376443705, 7504.137024242282, 7525.059367579052, 7525.360344370681, 4995.350604421402, 5077.136886729191, 5169.172932330809, 5198.4801519847715, 5232.267482552522, 8795.560221989002, 8796.428232164888, 8837.337199709918, 8837.381383303107, 8886.0, 8852.822943540965, 8970.37207395476, 9085.636574536944, 9125.361224714472, 9235.445873247627, 6576.638284894377, 7072.398846098139, 7195.0, 7271.527350722186, 7278.7816365507, 7333.193348731742, 7338.633068346455, 7390.187079421152, 7394.926050739424, 7398.371138453292, 6631.436327912182, 6725.663716814238, 6732.932670673426, 6837.965810170917, 6845.315468453314, 6385.776497822554, 6476.384743449365, 6622.238442579165, 6667.366600172976, 6671.33286671329, 5830.53355731549, 5866.5893387462465, 5879.559033072622, 5891.675957822361, 5899.882002360015, 4301.784910754513, 4405.036600891142, 4453.220686379806, 4496.7077139985795, 4560.771961401983, 4521.208788462071, 4530.614897733598, 4580.564846339593, 4628.537146285479, 4632.004119114406], "value": 4074.4471020996316, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.872476646958, 318.87723226557785, 325.7117451055815, 325.92829577492944, 327.6477786379642, 5105.387353517578, 5154.896902061966, 5156.278121063054, 5186.662866913653, 5187.170052791555, 5080.542751152396, 5086.33877595913, 5092.185250359943, 5107.693538387699, 5114.820981265657, 3817.3892177251646, 3926.175503144343, 3947.1118998225456, 4034.354503279476, 4036.9798151009204, 4010.278149933011, 4010.69919756018, 4022.617851304136, 4026.1947610477873, 4029.415734718464, 3788.6590206881374, 3999.7202294118833, 3999.920021594168, 4000.7799571023584, 4007.138465229975, 3876.612338766129, 4012.378081397388, 4013.177298653769, 4017.296973029708, 4022.0, 3559.4660800879815, 3560.1099725068734, 3564.32277867207, 3567.6432356764376, 3570.553680789901, 4890.144224760688, 4892.975535122301, 4903.63222758291, 4907.2639104134305, 4910.656254062217, 4376.912461750747, 4624.676272660915, 4632.235681112612, 4636.397268355126, 4647.790849411751, 5361.276227709248, 5376.220448035052, 5379.677219366811, 5379.799019583342, 5384.569234461273, 3898.4542164097047, 3900.843966241347, 3904.6485816276386, 3906.902327441808, 3908.7850168240734, 5513.476219759116, 5550.306211723535, 5596.4403559644115, 5632.436756324376, 5633.211350410946, 4000.8399664013696, 4016.116454380032, 4017.0961533655277, 4036.2129384770274, 4041.535223449282, 4076.3477843544892, 4084.81618327176, 4089.161721847014, 4103.4050062740735, 4104.0970986382945, 4390.714603550759, 4601.562851529099, 4604.401427814362, 4619.0, 4624.127228472474, 5389.703566303812, 5398.703071331036, 5406.729663516809, 5417.214503896992, 5427.29445172133, 1397.8392484864166, 1415.1367665723901, 1418.666613345863, 1422.8363738170242, 1426.8715815576647, 916.1937495004487, 962.9470379129075, 977.9951100244596, 995.6863587969766, 997.1374760831828, 4669.4396672399525, 4683.531646835289, 4683.8360657376825, 4690.132325519789, 4711.45818230901, 5508.283923089973, 5508.724563771795, 5515.393306736256, 5536.141898005735, 5543.61194716366, 4580.152671755736, 4713.481517033124, 4713.9764301178275, 4719.362886010414, 4831.73425461596, 2994.5358469437274, 3004.0, 3009.593704849817, 3018.849057547158, 3021.471242532548, 5254.894902101936, 5268.446813084647, 5275.7362131894015, 5276.445973172838, 5287.920681189786, 5549.778008879681, 5766.769329226868, 5786.855328616818, 5788.392218817048, 5811.099279611667, 5277.1292736698015, 5279.709615971158, 5287.101192797234, 5289.391719952255, 5312.707801070978, 5324.494173053554, 5587.832365029056, 5627.577931655224, 5641.0, 5657.632253903483, 5493.121100623881, 5513.972430137984, 5523.309586301712, 5529.253550770594, 5529.889402212014, 5251.501107394792, 5262.447443018581, 5264.73676316175, 5265.868353291198, 5267.130923397596, 3831.425286207091, 3872.322343589804, 3886.5336159661024, 3891.8248678810087, 3916.804159792056, 5552.583556233218, 5560.388357280615, 5570.749316280858, 5582.274304340573, 5584.413636568264, 5397.190421436816, 5400.729963501888, 5416.702081385404, 5427.972860135674, 5432.375276843213, 5246.3704355477585, 5404.216388623706, 5406.918896216481, 5423.9186412204635, 5435.945640543544, 5077.8730531737, 5289.6826190427155, 5318.627696061239, 5325.786968521371, 5335.1730481775385, 5252.9737351313, 5416.83749487516, 5437.238786569963, 5467.72661366938, 5489.39616642177, 5293.338332708411, 5303.761330740049, 5306.708131052829, 5311.575073993994, 5311.840644780663], "value": 4085.75066993912, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.5378419969223, 638.4477427025624, 713.5968177979441, 729.5221629832458, 733.9486235963485, 10779.676609701712, 11320.207585469021, 11735.882641173597, 11854.703632409193, 12007.939960300208, 12276.202046866969, 12278.938605306961, 12395.38023098846, 12406.193597416162, 12435.689107772288, 625.1872565664618, 765.4679997401807, 777.7316825695154, 786.5831109511968, 787.1498781316164, 754.5962909843234, 789.3842802613971, 790.7034861926777, 793.972210972616, 794.2573693596477, 822.3667775812621, 822.4859462835727, 824.9422540422173, 825.8183199696057, 825.84721826462, 641.5573254454458, 788.1724189600897, 822.3010441125026, 822.9876551851727, 824.1470078468786, 592.7421571616361, 593.1902952469891, 594.447164137352, 594.551113908996, 594.7115648910275, 11812.763744725144, 11876.643700688994, 11889.464974076187, 11903.880961190363, 11906.34515101669, 12205.877941220562, 12706.475222973302, 12728.872711272861, 12957.0, 13011.154274972192, 9582.0, 9752.561134748954, 9779.951100244525, 9812.754681132958, 9936.205103591696, 3157.6368717597543, 3178.7457003439667, 3181.3955348483714, 3223.8065716057113, 3251.7886337387995, 47845.28232076522, 49940.50059499359, 50552.74723626358, 50618.493815061745, 50757.0, 9182.127697868691, 9213.12475314844, 9221.538923053955, 9416.293777966679, 9451.385659932082, 16401.42595009169, 16494.34022639081, 16497.587560311087, 16541.58646033835, 16551.91724041372, 6693.364130407604, 6703.262641109474, 6780.186377634715, 6808.8978665320055, 6931.653417329113, 3585.695215906625, 3617.5116359291687, 3667.3032123896373, 3726.1988672435014, 3751.343514884939, 2693.7440943110373, 2724.741149590786, 2734.5214587447517, 2735.548634475329, 2737.1925282041843, 461.88452886778305, 465.1000314391663, 467.13813014987295, 473.22155054935126, 473.97393143377445, 500.432009669021, 563.5463451921161, 569.7037540478927, 578.1876463568609, 586.4663156527539, 7109.324614161646, 7210.783676489714, 7522.623868806538, 7619.4556677611145, 7849.193141326452, 489.83835334339585, 533.7277988226033, 553.914143307788, 556.3935310511481, 558.7290164270325, 3315.469386341229, 3425.880094196691, 3431.3480438716565, 3520.190356218084, 3526.947095793565, 48907.0, 49768.75115624399, 50709.23936140961, 50890.236646450336, 51377.74311128495, 42143.0, 43316.78341608272, 44024.0, 44451.55548444539, 44877.0, 36300.27399452049, 36378.45432318517, 36697.0, 36950.445743313874, 38238.0, 6444.806655800334, 6502.252240992158, 6510.088587597835, 6851.143607049119, 7059.5764254144915, 24392.26823195307, 26897.731022690306, 27569.448611027266, 27646.44707105887, 27748.44503109967, 34551.82724086363, 36224.0, 37283.25433491369, 37585.0, 37601.0, 9792.951035244778, 9842.0, 10088.596456141671, 10125.139363154214, 10197.490125493547, 10676.89323106759, 10731.517081731185, 10927.562897484011, 11022.614208502664, 11067.778644426906, 7892.447528672938, 8423.578821059045, 10223.1821454282, 10272.537735801758, 10323.277370584288, 9693.70918872435, 10086.29395942277, 10201.081902628799, 10312.071913527818, 10387.948060259952, 9995.850062249217, 10104.848427273744, 10420.635277765241, 10658.25392222568, 10675.412852293199, 8726.563671816257, 8815.911840881508, 8880.289576833968, 9085.227755640844, 9235.492047937429, 8363.525513850062, 8762.430442021248, 8909.866352004854, 8935.776605584653, 8947.776305592151], "value": 5606.455261763887, "unit": "score"}], "name": "dromaeo_css", "value": 6279.954669989074, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 108.0, 113.0, 113.0, 113.0, 102.0, 113.0, 113.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 135.0, 163.0, 187.0, 136.0, 157.0, 163.0, 135.0, 195.0, 140.0], "value": 156.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 161.0, 160.0, 162.0, 162.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 110.0, 108.0, 74.0, 73.0, 73.0, 127.0, 98.0, 77.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 151.0, 93.0, 92.0, 93.0, 146.0, 93.0, 93.0, 149.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 119.0, 117.0, 117.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 64.0, 64.0, 89.0, 62.0, 63.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 78.0, 88.0, 79.0, 80.0, 81.0, 79.0, 79.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 146.0, 133.0, 129.0, 132.0, 130.0, 130.0, 174.0, 137.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 172.0, 178.0, 184.0, 179.0, 179.0, 183.0, 183.0, 175.0, 177.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 73.0, 72.0, 74.0, 71.0, 71.0, 72.0, 74.0, 73.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1587.9, "alertThreshold": 2.0}]} 02:13:59 INFO - Return code: 0 02:13:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:13:59 ERROR - # TBPL SUCCESS # 02:13:59 INFO - Running post-action listener: _resource_record_post_action 02:13:59 INFO - Running post-run listener: _resource_record_post_run 02:14:00 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7802880; Write bytes: 417689600; Read time: 2252; Write time: 653860 02:14:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7462912; Read time: 0; Write time: 15612 02:14:00 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 7802880; Write bytes: 405909504; Read time: 2252; Write time: 637872 02:14:00 INFO - Running post-run listener: _upload_blobber_files 02:14:00 INFO - Blob upload gear active. 02:14:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:14:00 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 02:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:14:00 INFO - (blobuploader) - INFO - Open directory for files ... 02:14:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:14:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:14:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:01 INFO - (blobuploader) - INFO - Done attempting. 02:14:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:14:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:14:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:02 INFO - (blobuploader) - INFO - Done attempting. 02:14:02 INFO - (blobuploader) - INFO - Iteration through files over. 02:14:02 INFO - Return code: 0 02:14:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:14:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:14:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dac53b27cfcbdd8f2ce071c12bb449e5ebe012643f4ec32da14f465da7a3296b20750b5df277290ec908c025ada0ef310d3e47bb09f5a2392c94270ef5705901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec84a8880399abd6b8624559245d940a420655860a77bd2b0723feb0d3bf9aa291117160b4bfe00d38d952ed1b8449ea74e85434a840d5ca04fd138e248afaf3"} 02:14:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:14:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:14:02 INFO - Contents: 02:14:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dac53b27cfcbdd8f2ce071c12bb449e5ebe012643f4ec32da14f465da7a3296b20750b5df277290ec908c025ada0ef310d3e47bb09f5a2392c94270ef5705901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec84a8880399abd6b8624559245d940a420655860a77bd2b0723feb0d3bf9aa291117160b4bfe00d38d952ed1b8449ea74e85434a840d5ca04fd138e248afaf3"} 02:14:02 INFO - Running post-run listener: copy_logs_to_upload_dir 02:14:02 INFO - Copying logs to upload dir... 02:14:02 INFO - mkdir: /builds/slave/test/build/upload/logs 02:14:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.832688 ========= master_lag: 310.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 58 secs) (at 2016-04-22 02:19:12.831523) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 02:19:12.834867) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dac53b27cfcbdd8f2ce071c12bb449e5ebe012643f4ec32da14f465da7a3296b20750b5df277290ec908c025ada0ef310d3e47bb09f5a2392c94270ef5705901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec84a8880399abd6b8624559245d940a420655860a77bd2b0723feb0d3bf9aa291117160b4bfe00d38d952ed1b8449ea74e85434a840d5ca04fd138e248afaf3"} build_url:https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/TKV0fOIhQouwpq889NB50w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dac53b27cfcbdd8f2ce071c12bb449e5ebe012643f4ec32da14f465da7a3296b20750b5df277290ec908c025ada0ef310d3e47bb09f5a2392c94270ef5705901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec84a8880399abd6b8624559245d940a420655860a77bd2b0723feb0d3bf9aa291117160b4bfe00d38d952ed1b8449ea74e85434a840d5ca04fd138e248afaf3"}' ========= master_lag: 0.59 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 02:19:13.435243) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:19:13.435597) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1461314246.263168-181569157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:19:13.520064) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-04-22 02:19:13.520403) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-04-22 02:19:15.910694) ========= ========= Total master_lag: 311.26 =========