builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1460765591.62 results: success (0) buildid: 20160415154116 builduid: 5670e814ac16439ba664de8cb8aabf05 revision: 29782c3286ca0d496b16cd3a7a0edd0741641d99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:11.617479) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:11.618015) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:11.618287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:11.651411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:11.651661) ========= 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=aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 17:13:12-- 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% 31.2M=0s 2016-04-15 17:13:12 (31.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:11.818347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:11.818624) ========= 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=aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014805 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:11.868335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-15 17:13:11.868640) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29782c3286ca0d496b16cd3a7a0edd0741641d99 --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 29782c3286ca0d496b16cd3a7a0edd0741641d99 --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=aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 17:13:12,302 truncating revision to first 12 chars 2016-04-15 17:13:12,302 Setting DEBUG logging. 2016-04-15 17:13:12,302 attempt 1/10 2016-04-15 17:13:12,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29782c3286ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 17:13:13,341 unpacking tar archive at: fx-team-29782c3286ca/testing/mozharness/ program finished with exit code 0 elapsedTime=1.350879 ========= master_lag: 0.87 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-15 17:13:14.084723) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:14.085061) ========= script_repo_revision: 29782c3286ca0d496b16cd3a7a0edd0741641d99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:14.085475) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:14.085740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:14.104663) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-15 17:13:14.105054) ========= /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=aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:13:14 INFO - MultiFileLogger online at 20160415 17:13:14 in /builds/slave/test 17:13: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 17:13:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:14 INFO - {'append_to_log': False, 17:13:14 INFO - 'base_work_dir': '/builds/slave/test', 17:13:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:13:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:14 INFO - 'branch': 'Fx-Team-Non-PGO', 17:13:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:14 INFO - 'config_files': ('talos/linux_config.py',), 17:13:14 INFO - 'default_actions': ('clobber', 17:13:14 INFO - 'read-buildbot-config', 17:13:14 INFO - 'download-and-extract', 17:13:14 INFO - 'populate-webroot', 17:13:14 INFO - 'create-virtualenv', 17:13:14 INFO - 'install', 17:13:14 INFO - 'run-tests'), 17:13:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:14 INFO - 'download_minidump_stackwalk': True, 17:13:14 INFO - 'download_symbols': 'ondemand', 17:13:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:13:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:13:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:13:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:13:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:14 INFO - 'installer_path': 'installer.exe', 17:13:14 INFO - 'log_level': 'info', 17:13:14 INFO - 'log_name': 'talos', 17:13:14 INFO - 'log_to_console': True, 17:13:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:13:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:13:14 INFO - 'opt_config_files': (), 17:13:14 INFO - 'pip_index': False, 17:13:14 INFO - 'sps_profile': False, 17:13:14 INFO - 'sps_profile_interval': 0, 17:13:14 INFO - 'suite': 'dromaeojs', 17:13:14 INFO - 'system_bits': '32', 17:13:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:14 INFO - 'title': 'talos-linux64-ix-037', 17:13:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:14 INFO - 'use_talos_json': True, 17:13:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:14 INFO - 'work_dir': 'build'} 17:13:14 INFO - ##### 17:13:14 INFO - ##### Running clobber step. 17:13:14 INFO - ##### 17:13:14 INFO - Running pre-action listener: _resource_record_pre_action 17:13:14 INFO - Running main action method: clobber 17:13:14 INFO - rmtree: /builds/slave/test/build 17:13:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:15 INFO - Running post-action listener: _resource_record_post_action 17:13:15 INFO - ##### 17:13:15 INFO - ##### Running read-buildbot-config step. 17:13:15 INFO - ##### 17:13:15 INFO - Running pre-action listener: _resource_record_pre_action 17:13:15 INFO - Running main action method: read_buildbot_config 17:13:15 INFO - Using buildbot properties: 17:13:15 INFO - { 17:13:15 INFO - "project": "", 17:13:15 INFO - "product": "firefox", 17:13:15 INFO - "script_repo_revision": "production", 17:13:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:13:15 INFO - "repository": "", 17:13:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:13:15 INFO - "buildid": "20160415154116", 17:13:15 INFO - "pgo_build": "False", 17:13:15 INFO - "basedir": "/builds/slave/test", 17:13:15 INFO - "buildnumber": 1568, 17:13:15 INFO - "slavename": "talos-linux64-ix-037", 17:13:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:13:15 INFO - "platform": "ubuntu64_hw", 17:13:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:13:15 INFO - "branch": "fx-team", 17:13:15 INFO - "repo_path": "integration/fx-team", 17:13:15 INFO - "revision": "29782c3286ca0d496b16cd3a7a0edd0741641d99", 17:13:15 INFO - "stage_platform": "linux64", 17:13:15 INFO - "builduid": "5670e814ac16439ba664de8cb8aabf05", 17:13:15 INFO - "slavebuilddir": "test" 17:13:15 INFO - } 17:13:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:13:15 INFO - Running post-action listener: _resource_record_post_action 17:13:15 INFO - ##### 17:13:15 INFO - ##### Running download-and-extract step. 17:13:15 INFO - ##### 17:13:15 INFO - Running pre-action listener: _resource_record_pre_action 17:13:15 INFO - Running main action method: download_and_extract 17:13:15 INFO - mkdir: /builds/slave/test/build/tests 17:13: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')]} 17:13:15 INFO - https://queue.taskcluster.net/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:13:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:13:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:13:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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 17:13:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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 17:13:16 INFO - Downloaded 1361 bytes. 17:13:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:13:16 INFO - Using the following test package requirements: 17:13:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:13:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:13:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'jsshell-linux-x86_64.zip'], 17:13:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:13:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:13:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:13:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:13:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:13:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:13: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')]} 17:13:16 INFO - https://queue.taskcluster.net/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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 17:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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 17:13:17 INFO - Downloaded 22203703 bytes. 17:13: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'] 17:13: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 17:13:18 INFO - Return code: 0 17:13:18 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 17:13:18 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')]} 17:13:18 INFO - https://queue.taskcluster.net/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:13:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:13:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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 17:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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 17:13:21 INFO - Downloaded 22203703 bytes. 17:13:21 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'] 17:13:21 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 17:13:23 INFO - Return code: 0 17:13: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')]} 17:13:23 INFO - https://queue.taskcluster.net/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:13:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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 17:13:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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 17:13:24 INFO - Downloaded 10841076 bytes. 17:13: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'] 17:13: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 17:13:24 INFO - Return code: 0 17:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:24 INFO - https://queue.taskcluster.net/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:13:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:13:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:13:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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 17:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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 17:13:27 INFO - Downloaded 54447341 bytes. 17:13:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:13:27 INFO - mkdir: /builds/slave/test/properties 17:13:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:13:27 INFO - Writing to file /builds/slave/test/properties/build_url 17:13:27 INFO - Contents: 17:13:27 INFO - build_url:https://queue.taskcluster.net/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:13:29 INFO - Running post-action listener: _resource_record_post_action 17:13:29 INFO - Running post-action listener: set_extra_try_arguments 17:13:29 INFO - ##### 17:13:29 INFO - ##### Running populate-webroot step. 17:13:29 INFO - ##### 17:13:29 INFO - Running pre-action listener: _resource_record_pre_action 17:13:29 INFO - Running main action method: populate_webroot 17:13:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:13:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:13:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:13:29 INFO - '--tppagecycles', 17:13:29 INFO - '7'], 17:13:29 INFO - 'tests': ['tsvgm']}}, 17:13:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:13:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:13:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:13:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:13:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:13:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:13:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:29 INFO - 'talos_options': ['--disable-e10s'], 17:13:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:29 INFO - 'talos_options': ['--disable-e10s'], 17:13:29 INFO - 'tests': ['damp', 'tps']}, 17:13:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:29 INFO - 'tests': ['damp', 'tps']}, 17:13:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:13:29 INFO - 'tests': ['dromaeo_dom']}, 17:13:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:13:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:13:29 INFO - 'tests': ['a11yr', 17:13:29 INFO - 'ts_paint', 17:13:29 INFO - 'tpaint', 17:13:29 INFO - 'sessionrestore', 17:13:29 INFO - 'sessionrestore_no_auto_restore', 17:13:29 INFO - 'tabpaint']}, 17:13:29 INFO - 'other-e10s': {'tests': ['a11yr', 17:13:29 INFO - 'ts_paint', 17:13:29 INFO - 'tpaint', 17:13:29 INFO - 'sessionrestore', 17:13:29 INFO - 'sessionrestore_no_auto_restore', 17:13:29 INFO - 'tabpaint']}, 17:13:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:13:29 INFO - 'ts_paint', 17:13:29 INFO - 'tpaint', 17:13:29 INFO - 'sessionrestore', 17:13:29 INFO - 'sessionrestore_no_auto_restore', 17:13:29 INFO - 'tabpaint']}, 17:13:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:13:29 INFO - 'ts_paint', 17:13:29 INFO - 'tpaint', 17:13:29 INFO - 'sessionrestore', 17:13:29 INFO - 'sessionrestore_no_auto_restore', 17:13:29 INFO - 'tabpaint']}, 17:13:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:13:29 INFO - 'tests': ['a11yr', 17:13:29 INFO - 'ts_paint', 17:13:29 INFO - 'tpaint', 17:13:29 INFO - 'sessionrestore', 17:13:29 INFO - 'sessionrestore_no_auto_restore', 17:13:29 INFO - 'tabpaint']}, 17:13:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:13:29 INFO - 'tests': ['a11yr', 17:13:29 INFO - 'ts_paint', 17:13:29 INFO - 'tpaint', 17:13:29 INFO - 'sessionrestore', 17:13:29 INFO - 'sessionrestore_no_auto_restore', 17:13:29 INFO - 'tabpaint']}, 17:13:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:13:29 INFO - 'tests': ['tsvgx', 17:13:29 INFO - 'tsvgr_opacity', 17:13:29 INFO - 'tart', 17:13:29 INFO - 'tscrollx', 17:13:29 INFO - 'cart']}, 17:13:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:13:29 INFO - 'tsvgr_opacity', 17:13:29 INFO - 'tart', 17:13:29 INFO - 'tscrollx', 17:13:29 INFO - 'cart']}, 17:13:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:29 INFO - 'talos_options': ['--disable-e10s'], 17:13:29 INFO - 'tests': ['tp5o']}, 17:13:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:29 INFO - 'tests': ['tp5o']}, 17:13:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:29 INFO - 'talos_options': ['--disable-e10s', 17:13:29 INFO - '--xperf_path', 17:13:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:29 INFO - 'tests': ['tp5n']}, 17:13:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:29 INFO - 'talos_options': ['--xperf_path', 17:13:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:29 INFO - 'tests': ['tp5n']}}, 17:13:29 INFO - 'talos.zip': {'path': '', 17:13:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:13:29 INFO - Running post-action listener: _resource_record_post_action 17:13:29 INFO - ##### 17:13:29 INFO - ##### Running create-virtualenv step. 17:13:29 INFO - ##### 17:13:29 INFO - Running pre-action listener: _resource_record_pre_action 17:13:29 INFO - Running main action method: create_virtualenv 17:13:29 INFO - Creating virtualenv /builds/slave/test/build/venv 17:13:29 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 17:13:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:13:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:13:29 INFO - Using real prefix '/usr' 17:13:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:13:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:13:31 INFO - Installing pip.................done. 17:13:31 INFO - Return code: 0 17:13:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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 0x7ffb4d244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e410>, '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 0x2c5f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f7a0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', '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 17:13: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 17:13: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 17:13:31 INFO - Using env: {'DISPLAY': ':0', 17:13:31 INFO - 'HOME': '/home/cltbld', 17:13:31 INFO - 'LANG': 'en_US.UTF-8', 17:13:31 INFO - 'LANGUAGE': 'en_US:en', 17:13:31 INFO - 'LOGNAME': 'cltbld', 17:13:31 INFO - 'MAIL': '/var/mail/cltbld', 17:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:31 INFO - 'MOZ_NO_REMOTE': '1', 17:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:31 INFO - 'NO_EM_RESTART': '1', 17:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:31 INFO - 'PWD': '/builds/slave/test', 17:13:31 INFO - 'SHELL': '/bin/bash', 17:13:31 INFO - 'SHLVL': '1', 17:13:31 INFO - 'TERM': 'linux', 17:13:31 INFO - 'TMOUT': '86400', 17:13:31 INFO - 'USER': 'cltbld', 17:13:31 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', 17:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:31 INFO - '_': '/tools/buildbot/bin/python'} 17:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:31 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 17:13:31 INFO - Cleaning up... 17:13:31 INFO - Return code: 0 17:13:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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', '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 0x7ffb4d244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e410>, '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 0x2c5f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f7a0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', '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 17:13: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', 'psutil>=0.7.1'] in /builds/slave/test/build 17:13: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 psutil>=0.7.1 17:13:31 INFO - Using env: {'DISPLAY': ':0', 17:13:31 INFO - 'HOME': '/home/cltbld', 17:13:31 INFO - 'LANG': 'en_US.UTF-8', 17:13:31 INFO - 'LANGUAGE': 'en_US:en', 17:13:31 INFO - 'LOGNAME': 'cltbld', 17:13:31 INFO - 'MAIL': '/var/mail/cltbld', 17:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:31 INFO - 'MOZ_NO_REMOTE': '1', 17:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:31 INFO - 'NO_EM_RESTART': '1', 17:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:31 INFO - 'PWD': '/builds/slave/test', 17:13:31 INFO - 'SHELL': '/bin/bash', 17:13:31 INFO - 'SHLVL': '1', 17:13:31 INFO - 'TERM': 'linux', 17:13:31 INFO - 'TMOUT': '86400', 17:13:31 INFO - 'USER': 'cltbld', 17:13:31 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', 17:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:31 INFO - '_': '/tools/buildbot/bin/python'} 17:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:32 INFO - Downloading/unpacking psutil>=0.7.1 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:13:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:34 INFO - Installing collected packages: psutil 17:13:34 INFO - Running setup.py install for psutil 17:13:34 INFO - building 'psutil._psutil_linux' extension 17:13: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 17:13:34 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 17:13:34 INFO - building 'psutil._psutil_posix' extension 17:13:34 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 17:13:34 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 17:13:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:34 INFO - Successfully installed psutil 17:13:34 INFO - Cleaning up... 17:13:34 INFO - Return code: 0 17:13:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:34 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 0x7ffb4d244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e410>, '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 0x2c5f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f7a0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', '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 17:13:34 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 17:13:34 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 17:13:34 INFO - Using env: {'DISPLAY': ':0', 17:13:34 INFO - 'HOME': '/home/cltbld', 17:13:34 INFO - 'LANG': 'en_US.UTF-8', 17:13:34 INFO - 'LANGUAGE': 'en_US:en', 17:13:34 INFO - 'LOGNAME': 'cltbld', 17:13:34 INFO - 'MAIL': '/var/mail/cltbld', 17:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:34 INFO - 'MOZ_NO_REMOTE': '1', 17:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:34 INFO - 'NO_EM_RESTART': '1', 17:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:34 INFO - 'PWD': '/builds/slave/test', 17:13:34 INFO - 'SHELL': '/bin/bash', 17:13:34 INFO - 'SHLVL': '1', 17:13:34 INFO - 'TERM': 'linux', 17:13:34 INFO - 'TMOUT': '86400', 17:13:34 INFO - 'USER': 'cltbld', 17:13:34 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', 17:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:34 INFO - '_': '/tools/buildbot/bin/python'} 17:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:13:34 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 17:13:34 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 17:13:34 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 17:13:34 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 17:13:34 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 17:13:34 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 17:13:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:13:36 INFO - Installing collected packages: mozsystemmonitor 17:13:36 INFO - Running setup.py install for mozsystemmonitor 17:13:36 INFO - Successfully installed mozsystemmonitor 17:13:36 INFO - Cleaning up... 17:13:36 INFO - Return code: 0 17:13:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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', '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 0x7ffb4d244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e410>, '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 0x2c5f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f7a0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', '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 17:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:13: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 blobuploader==1.2.4 17:13:36 INFO - Using env: {'DISPLAY': ':0', 17:13:36 INFO - 'HOME': '/home/cltbld', 17:13:36 INFO - 'LANG': 'en_US.UTF-8', 17:13:36 INFO - 'LANGUAGE': 'en_US:en', 17:13:36 INFO - 'LOGNAME': 'cltbld', 17:13:36 INFO - 'MAIL': '/var/mail/cltbld', 17:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:36 INFO - 'MOZ_NO_REMOTE': '1', 17:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:36 INFO - 'NO_EM_RESTART': '1', 17:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:36 INFO - 'PWD': '/builds/slave/test', 17:13:36 INFO - 'SHELL': '/bin/bash', 17:13:36 INFO - 'SHLVL': '1', 17:13:36 INFO - 'TERM': 'linux', 17:13:36 INFO - 'TMOUT': '86400', 17:13:36 INFO - 'USER': 'cltbld', 17:13:36 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', 17:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:36 INFO - '_': '/tools/buildbot/bin/python'} 17:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:37 INFO - Downloading/unpacking blobuploader==1.2.4 17:13:37 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 17:13:37 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 17:13:37 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 17:13:37 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 17:13:37 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 17:13:37 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 17:13:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:13:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:13:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 INFO - Downloading docopt-0.6.1.tar.gz 17:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:39 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:39 INFO - Running setup.py install for blobuploader 17:13:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:13:39 INFO - Running setup.py install for requests 17:13:40 INFO - Running setup.py install for docopt 17:13:40 INFO - Successfully installed blobuploader requests docopt 17:13:40 INFO - Cleaning up... 17:13:40 INFO - Return code: 0 17:13:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:40 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 0x7ffb4d244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e410>, '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 0x2c5f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f7a0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', '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 17:13:40 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 17:13:40 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 17:13:40 INFO - Using env: {'DISPLAY': ':0', 17:13:40 INFO - 'HOME': '/home/cltbld', 17:13:40 INFO - 'LANG': 'en_US.UTF-8', 17:13:40 INFO - 'LANGUAGE': 'en_US:en', 17:13:40 INFO - 'LOGNAME': 'cltbld', 17:13:40 INFO - 'MAIL': '/var/mail/cltbld', 17:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:40 INFO - 'MOZ_NO_REMOTE': '1', 17:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:40 INFO - 'NO_EM_RESTART': '1', 17:13:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:40 INFO - 'PWD': '/builds/slave/test', 17:13:40 INFO - 'SHELL': '/bin/bash', 17:13:40 INFO - 'SHLVL': '1', 17:13:40 INFO - 'TERM': 'linux', 17:13:40 INFO - 'TMOUT': '86400', 17:13:40 INFO - 'USER': 'cltbld', 17:13:40 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', 17:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:40 INFO - '_': '/tools/buildbot/bin/python'} 17:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:40 INFO - Running setup.py (path:/tmp/pip-zCwiGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:40 INFO - Running setup.py (path:/tmp/pip-rXDlw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:40 INFO - Running setup.py (path:/tmp/pip-zHJCGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:40 INFO - Running setup.py (path:/tmp/pip-eapYvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:40 INFO - Running setup.py (path:/tmp/pip-cRgCRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:40 INFO - Running setup.py (path:/tmp/pip-TGfi5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:41 INFO - Running setup.py (path:/tmp/pip-6rJ64P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:41 INFO - Running setup.py (path:/tmp/pip-_9ZZyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:41 INFO - Running setup.py (path:/tmp/pip-z9879F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:41 INFO - Running setup.py (path:/tmp/pip-52K7mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:41 INFO - Running setup.py (path:/tmp/pip-Sq1y_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:41 INFO - Running setup.py (path:/tmp/pip-bO7QcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:41 INFO - Running setup.py (path:/tmp/pip-Mem3b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:41 INFO - Running setup.py (path:/tmp/pip-F_YNrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:41 INFO - Running setup.py (path:/tmp/pip-rDxKaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:41 INFO - Running setup.py (path:/tmp/pip-WS4ysZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:41 INFO - Running setup.py (path:/tmp/pip-wFu7Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:41 INFO - Running setup.py install for manifestparser 17:13:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:13:41 INFO - Running setup.py install for mozcrash 17:13:42 INFO - Running setup.py install for mozdebug 17:13:42 INFO - Running setup.py install for mozdevice 17:13:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:13:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:13:42 INFO - Running setup.py install for mozfile 17:13:42 INFO - Running setup.py install for mozhttpd 17:13:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:13:42 INFO - Running setup.py install for mozinfo 17:13:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:13:42 INFO - Running setup.py install for mozInstall 17:13:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:13:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:13:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:13:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:13:42 INFO - Running setup.py install for mozleak 17:13:42 INFO - Running setup.py install for mozlog 17:13:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:42 INFO - Running setup.py install for moznetwork 17:13:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:42 INFO - Running setup.py install for mozprocess 17:13:43 INFO - Running setup.py install for mozprofile 17:13:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:43 INFO - Running setup.py install for mozrunner 17:13:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:43 INFO - Running setup.py install for mozscreenshot 17:13:43 INFO - Running setup.py install for moztest 17:13:43 INFO - Running setup.py install for mozversion 17:13:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:43 INFO - Cleaning up... 17:13:43 INFO - Return code: 0 17:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:43 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 0x7ffb4d244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e410>, '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 0x2c5f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f7a0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', '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 17:13:43 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 17:13:43 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 17:13:43 INFO - Using env: {'DISPLAY': ':0', 17:13:43 INFO - 'HOME': '/home/cltbld', 17:13:43 INFO - 'LANG': 'en_US.UTF-8', 17:13:43 INFO - 'LANGUAGE': 'en_US:en', 17:13:43 INFO - 'LOGNAME': 'cltbld', 17:13:43 INFO - 'MAIL': '/var/mail/cltbld', 17:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:43 INFO - 'MOZ_NO_REMOTE': '1', 17:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:43 INFO - 'NO_EM_RESTART': '1', 17:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:43 INFO - 'PWD': '/builds/slave/test', 17:13:43 INFO - 'SHELL': '/bin/bash', 17:13:43 INFO - 'SHLVL': '1', 17:13:43 INFO - 'TERM': 'linux', 17:13:43 INFO - 'TMOUT': '86400', 17:13:43 INFO - 'USER': 'cltbld', 17:13:43 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', 17:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:43 INFO - '_': '/tools/buildbot/bin/python'} 17:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:43 INFO - Running setup.py (path:/tmp/pip-RVuZaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:43 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)) 17:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:43 INFO - Running setup.py (path:/tmp/pip-CZN6Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:43 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)) 17:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:43 INFO - Running setup.py (path:/tmp/pip-26sxNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:44 INFO - Running setup.py (path:/tmp/pip-y85kum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:44 INFO - Running setup.py (path:/tmp/pip-79rxYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:44 INFO - Running setup.py (path:/tmp/pip-KHz8i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:44 INFO - Running setup.py (path:/tmp/pip-ULTQNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:44 INFO - Running setup.py (path:/tmp/pip-HK_wMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:44 INFO - Running setup.py (path:/tmp/pip-8tvjy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:44 INFO - Running setup.py (path:/tmp/pip-YtFiEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:44 INFO - Running setup.py (path:/tmp/pip-90bX5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:44 INFO - Running setup.py (path:/tmp/pip-WmVl5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:44 INFO - Running setup.py (path:/tmp/pip-XwEjuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:44 INFO - Running setup.py (path:/tmp/pip-fylTDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:44 INFO - Running setup.py (path:/tmp/pip-eNYVMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:44 INFO - Running setup.py (path:/tmp/pip-N8Koji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:44 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)) 17:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:44 INFO - Running setup.py (path:/tmp/pip-YV4I4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:45 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)) 17:13:45 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)) 17:13:45 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)) 17:13:45 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)) 17:13:45 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)) 17:13:45 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)) 17:13:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:46 INFO - Downloading blessings-1.6.tar.gz 17:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:47 INFO - Installing collected packages: blessings 17:13:47 INFO - Running setup.py install for blessings 17:13:47 INFO - Successfully installed blessings 17:13:47 INFO - Cleaning up... 17:13:47 INFO - Return code: 0 17:13:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:47 INFO - Reading from file tmpfile_stdout 17:13:47 INFO - Current package versions: 17:13:47 INFO - argparse == 1.2.1 17:13:47 INFO - blessings == 1.6 17:13:47 INFO - blobuploader == 1.2.4 17:13:47 INFO - docopt == 0.6.1 17:13:47 INFO - manifestparser == 1.1 17:13:47 INFO - mozInstall == 1.12 17:13:47 INFO - mozcrash == 0.17 17:13:47 INFO - mozdebug == 0.1 17:13:47 INFO - mozdevice == 0.48 17:13:47 INFO - mozfile == 1.2 17:13:47 INFO - mozhttpd == 0.7 17:13:47 INFO - mozinfo == 0.9 17:13:47 INFO - mozleak == 0.1 17:13:47 INFO - mozlog == 3.1 17:13:47 INFO - moznetwork == 0.27 17:13:47 INFO - mozprocess == 0.22 17:13:47 INFO - mozprofile == 0.28 17:13:47 INFO - mozrunner == 6.11 17:13:47 INFO - mozscreenshot == 0.1 17:13:47 INFO - mozsystemmonitor == 0.0 17:13:47 INFO - moztest == 0.7 17:13:47 INFO - mozversion == 1.4 17:13:47 INFO - psutil == 3.1.1 17:13:47 INFO - requests == 1.2.3 17:13:47 INFO - wsgiref == 0.1.2 17:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:47 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 0x7ffb4d244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e410>, '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 0x2c5f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f7a0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', '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 17:13:47 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 17:13:47 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 17:13:47 INFO - Using env: {'DISPLAY': ':0', 17:13:47 INFO - 'HOME': '/home/cltbld', 17:13:47 INFO - 'LANG': 'en_US.UTF-8', 17:13:47 INFO - 'LANGUAGE': 'en_US:en', 17:13:47 INFO - 'LOGNAME': 'cltbld', 17:13:47 INFO - 'MAIL': '/var/mail/cltbld', 17:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:47 INFO - 'MOZ_NO_REMOTE': '1', 17:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:47 INFO - 'NO_EM_RESTART': '1', 17:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:47 INFO - 'PWD': '/builds/slave/test', 17:13:47 INFO - 'SHELL': '/bin/bash', 17:13:47 INFO - 'SHLVL': '1', 17:13:47 INFO - 'TERM': 'linux', 17:13:47 INFO - 'TMOUT': '86400', 17:13:47 INFO - 'USER': 'cltbld', 17:13:47 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', 17:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:47 INFO - '_': '/tools/buildbot/bin/python'} 17:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:47 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)) 17:13:47 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)) 17:13:47 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)) 17:13:47 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)) 17:13:47 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)) 17:13:47 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)) 17:13:47 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)) 17:13:47 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)) 17:13:47 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)) 17:13:47 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)) 17:13:47 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)) 17:13:47 INFO - Cleaning up... 17:13:47 INFO - Return code: 0 17:13:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:47 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 0x7ffb4d244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e410>, '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 0x2c5f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f7a0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', '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 17:13:47 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 17:13:47 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 17:13:47 INFO - Using env: {'DISPLAY': ':0', 17:13:47 INFO - 'HOME': '/home/cltbld', 17:13:47 INFO - 'LANG': 'en_US.UTF-8', 17:13:47 INFO - 'LANGUAGE': 'en_US:en', 17:13:47 INFO - 'LOGNAME': 'cltbld', 17:13:47 INFO - 'MAIL': '/var/mail/cltbld', 17:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:47 INFO - 'MOZ_NO_REMOTE': '1', 17:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:47 INFO - 'NO_EM_RESTART': '1', 17:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:47 INFO - 'PWD': '/builds/slave/test', 17:13:47 INFO - 'SHELL': '/bin/bash', 17:13:47 INFO - 'SHLVL': '1', 17:13:47 INFO - 'TERM': 'linux', 17:13:47 INFO - 'TMOUT': '86400', 17:13:47 INFO - 'USER': 'cltbld', 17:13:47 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', 17:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:47 INFO - '_': '/tools/buildbot/bin/python'} 17:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:47 INFO - Downloading/unpacking jsonschema 17:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:49 INFO - Downloading/unpacking functools32 (from jsonschema) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:49 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:49 INFO - warning: no files found matching '*.txt' 17:13:49 INFO - no previously-included directories found matching 'build' 17:13:49 INFO - no previously-included directories found matching 'dist' 17:13:49 INFO - no previously-included directories found matching '.git*' 17:13:49 INFO - Installing collected packages: jsonschema, functools32 17:13:50 INFO - Running setup.py install for functools32 17:13:50 INFO - warning: no files found matching '*.txt' 17:13:50 INFO - no previously-included directories found matching 'build' 17:13:50 INFO - no previously-included directories found matching 'dist' 17:13:50 INFO - no previously-included directories found matching '.git*' 17:13:50 INFO - Successfully installed jsonschema functools32 17:13:50 INFO - Cleaning up... 17:13:50 INFO - Return code: 0 17:13:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:50 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 0x7ffb4d244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e410>, '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 0x2c5f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f7a0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', '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 17:13:50 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 17:13:50 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 17:13:50 INFO - Using env: {'DISPLAY': ':0', 17:13:50 INFO - 'HOME': '/home/cltbld', 17:13:50 INFO - 'LANG': 'en_US.UTF-8', 17:13:50 INFO - 'LANGUAGE': 'en_US:en', 17:13:50 INFO - 'LOGNAME': 'cltbld', 17:13:50 INFO - 'MAIL': '/var/mail/cltbld', 17:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:50 INFO - 'MOZ_NO_REMOTE': '1', 17:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:50 INFO - 'NO_EM_RESTART': '1', 17:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:50 INFO - 'PWD': '/builds/slave/test', 17:13:50 INFO - 'SHELL': '/bin/bash', 17:13:50 INFO - 'SHLVL': '1', 17:13:50 INFO - 'TERM': 'linux', 17:13:50 INFO - 'TMOUT': '86400', 17:13:50 INFO - 'USER': 'cltbld', 17:13:50 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', 17:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:50 INFO - '_': '/tools/buildbot/bin/python'} 17:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:50 INFO - Downloading/unpacking flake8 17:13:50 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 17:13:50 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 17:13:50 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 17:13:50 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 17:13:50 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 17:13:50 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 17:13:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:13:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:13:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:13:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:53 INFO - no previously-included directories found matching 'docs/_build' 17:13:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:13:53 INFO - Running setup.py install for pep8 17:13:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:53 INFO - no previously-included directories found matching 'docs/_build' 17:13:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:13:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:13:53 INFO - Cleaning up... 17:13:53 INFO - Return code: 0 17:13:53 INFO - Running post-action listener: _resource_record_post_action 17:13:53 INFO - Running post-action listener: _start_resource_monitoring 17:13:53 INFO - Starting resource monitoring. 17:13:53 INFO - ##### 17:13:53 INFO - ##### Running install step. 17:13:53 INFO - ##### 17:13:53 INFO - Running pre-action listener: _resource_record_pre_action 17:13:53 INFO - Running main action method: install 17:13:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:53 INFO - Reading from file tmpfile_stdout 17:13:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:13:53 INFO - Reading from file tmpfile_stdout 17:13:53 INFO - Output received: 17:13:53 INFO - Usage: mozinstall [options] installer 17:13:53 INFO - Options: 17:13:53 INFO - -h, --help show this help message and exit 17:13:53 INFO - -d DEST, --destination=DEST 17:13:53 INFO - Directory to install application into. [default: 17:13:53 INFO - "/builds/slave/test"] 17:13:53 INFO - --app=APP Application being installed. [default: firefox] 17:13:53 INFO - mkdir: /builds/slave/test/build/application 17:13:53 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'] 17:13:53 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 17:14:09 INFO - Reading from file tmpfile_stdout 17:14:09 INFO - Output received: 17:14:09 INFO - /builds/slave/test/build/application/firefox/firefox 17:14:09 INFO - Running post-action listener: _resource_record_post_action 17:14:09 INFO - ##### 17:14:09 INFO - ##### Running run-tests step. 17:14:09 INFO - ##### 17:14:09 INFO - Running pre-action listener: _resource_record_pre_action 17:14:09 INFO - Running main action method: run_tests 17:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:14:09 INFO - Python 2.7.3 17:14:09 INFO - Return code: 0 17:14:09 INFO - grabbing minidump binary from tooltool 17:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:09 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 0x2c5e410>, '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 0x2c5f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:14:09 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 17:14:09 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 17:14:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:14:09 INFO - Return code: 0 17:14:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:14:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:14:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:14:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:14:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:14:10 INFO - Return code: 0 17:14:10 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/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 17:14:10 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/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 17:14:10 INFO - Using env: {'DISPLAY': ':0', 17:14:10 INFO - 'HOME': '/home/cltbld', 17:14:10 INFO - 'LANG': 'en_US.UTF-8', 17:14:10 INFO - 'LANGUAGE': 'en_US:en', 17:14:10 INFO - 'LOGNAME': 'cltbld', 17:14:10 INFO - 'MAIL': '/var/mail/cltbld', 17:14:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:14:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:10 INFO - 'MOZ_NO_REMOTE': '1', 17:14:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:10 INFO - 'NO_EM_RESTART': '1', 17:14:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:10 INFO - 'PWD': '/builds/slave/test', 17:14:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:14:10 INFO - 'SHELL': '/bin/bash', 17:14:10 INFO - 'SHLVL': '1', 17:14:10 INFO - 'TERM': 'linux', 17:14:10 INFO - 'TMOUT': '86400', 17:14:10 INFO - 'USER': 'cltbld', 17:14:10 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852', 17:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:10 INFO - '_': '/tools/buildbot/bin/python'} 17:14:10 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/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 17:14:10 INFO - mozversion application_buildid: 20160415154116 17:14:10 INFO - mozversion application_changeset: 29782c3286ca0d496b16cd3a7a0edd0741641d99 17:14:10 INFO - mozversion application_display_name: Nightly 17:14:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:14:10 INFO - mozversion application_name: Firefox 17:14:10 INFO - mozversion application_remotingname: firefox 17:14:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:14:10 INFO - mozversion application_vendor: Mozilla 17:14:10 INFO - mozversion application_version: 48.0a1 17:14:10 INFO - mozversion platform_buildid: 20160415154116 17:14:10 INFO - mozversion platform_changeset: 29782c3286ca0d496b16cd3a7a0edd0741641d99 17:14:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:14:10 INFO - mozversion platform_version: 48.0a1 17:14:10 INFO - using testdate: 1460765650 17:14:10 INFO - actual date: 1460765650 17:14:10 INFO - starting webserver on 'localhost:45400' 17:14:10 INFO - SUITE-START | Running 2 tests 17:14:10 INFO - TEST-START | dromaeo_css 17:14:10 INFO - operating with platform_type : linux_ 17:14:10 INFO - Initialising browser for dromaeo_css test... 17:14:10 INFO - TEST-INFO | started process 30545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsv3ybm/profile http://localhost:45400/getInfo.html) 17:14:15 INFO - PROCESS | 30545 | __metrics Screen width/height:1600/1200 17:14:15 INFO - PROCESS | 30545 | colorDepth:24 17:14:15 INFO - PROCESS | 30545 | Browser inner width/height: 1024/697 17:14:15 INFO - PROCESS | 30545 | __metrics 17:14:16 ERROR - PROCESS | 30545 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:14:16 INFO - TEST-INFO | 30545: exit 0 17:14:16 INFO - Browser initialized. 17:14:16 INFO - Running cycle 1/1 for dromaeo_css test... 17:14:16 INFO - TEST-INFO | started process 30626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsv3ybm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:28 INFO - PROCESS | 30626 | RSS: Main: 154861568 17:14:28 INFO - PROCESS | 30626 | 17:15:20 INFO - PROCESS | 30626 | 1460765720300 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] 17:17:31 INFO - PROCESS | 30626 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45400/tests/dromaeo/cssquery-ext.html) 17:17:32 INFO - PROCESS | 30626 | RSS: Main: 234639360 17:17:32 INFO - PROCESS | 30626 | 17:20:34 INFO - PROCESS | 30626 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-ext.html (next: http://localhost:45400/tests/dromaeo/cssquery-jquery.html) 17:20:35 INFO - PROCESS | 30626 | RSS: Main: 241016832 17:20:35 INFO - PROCESS | 30626 | 17:23:37 INFO - PROCESS | 30626 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45400/tests/dromaeo/cssquery-mootools.html) 17:23:38 INFO - PROCESS | 30626 | RSS: Main: 242507776 17:23:38 INFO - PROCESS | 30626 | 17:26:40 INFO - PROCESS | 30626 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45400/tests/dromaeo/cssquery-prototype.html) 17:26:41 INFO - PROCESS | 30626 | RSS: Main: 235544576 17:26:41 INFO - PROCESS | 30626 | 17:29:43 INFO - PROCESS | 30626 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45400/tests/dromaeo/cssquery-yui.html) 17:29:44 INFO - PROCESS | 30626 | RSS: Main: 215003136 17:29:44 INFO - PROCESS | 30626 | 17:32:47 INFO - PROCESS | 30626 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-yui.html (next: http://localhost:45400/tests/dromaeo/cssquery-dojo.html) 17:32:47 INFO - PROCESS | 30626 | RSS: Main: 294019072 17:32:47 INFO - PROCESS | 30626 | 17:32:47 INFO - PROCESS | 30626 | __start_tp_report 17:32:47 INFO - PROCESS | 30626 | _x_x_mozilla_page_load 17:32:47 INFO - PROCESS | 30626 | _x_x_mozilla_page_load_details 17:32:47 INFO - PROCESS | 30626 | |i|pagename|runs| 17:32:47 INFO - PROCESS | 30626 | |0;dojo.html;2611.5038142752874;2662.9689270591043;2671.799615028873;2676;2700.7164247753985;4571.9314210286875;4598.678092533524;4601.03378290559;4631.9073618527655;4649.721016738989;4653.488116307203;4693.389859318292;4710.199266124759;4718.079974404993;4736;4257.936130958023;4292.6780491463105;4325.502567204764;4351.586599273064;4444.577765112309;4365.36702178184;4396.1867054595;4408.228560002003;4417.271150260203;4449.26587113126;4155.7506549606815;4239.745615263094;4280.400743895857;4341.218580655481;4351.760653164075;4248.575142485757;4278.101598664284;4282.657387409;4284.61438470536;4322.610965013164;4241.597048280409;4269.124829409963;4273.636740877029;4296.291111966521;4299.978500107511;4379.605835474823;4473.217186992263;4522.7286362818;4558.703684260512;4578.542145785428;4965.280034395028;4984.327115839352;4986.5761410280165;4987.625928055374;5015.548600625962;4990.575801056914;5009.098362294785;5016.799328026875;5018.222175562757;5055.039542486952;4424.137293227822;4634.096351211515;4672.2057250267535;4724.267738500538;4726.787294571753;5001.624878134155;5004.274380214922;5017.698938063728;5019.996000799854;5021.59827213822;4741.644376671763;4817.710937343771;4817.9518204818205;4819.759012049453;4853.126437241331;4932.950670493249;4988.176950803149;4993.650444468853;4996.925046124311;5004.274380214849;4905.23968784839;4933.161362568372;4938.654294199443;4943;4980.153373926441;4746.264329029006;4915.95084049155;4921.040397122527;4934.18585933317;4969.850904472799;4193.5387107418155;4197.580241975778;4217.91564168721;4218.367244913287;4235.53409124996;3666.8899933002053;3684.078980254936;3687.8893633191046;3715.851365945386;3727.7390582658954;4137.81379837908;4211.705180637326;4258.1696569169335;4272.4445822042935;4290.635295999812;4965.925511117336;4968.577670898014;4981.975090124526;5015.573676237561;5036.496350364934;4259.1268789897995;4262.914741705148;4267.125239325931;4283.1005488847695;4316.438862947797;4346.630536404377;4450.821967121344;4452.243118669834;4458.554144585515;4511.368408422823;4604.930926036045;4626.236670949255;4636.582707556268;4669.182892993713;4673.205555055717;4886.071646387175;4887.218045112765;4898.926516102332;4903.460619331942;4940.308356830118;4571.542845715535;4632.305154226893;4704.294355846513;4782.976085119552;4797.376341075777;4754.881127971828;4787.61699064067;4799.952000480091;4801.135795556834;4841.8547443576745;4837.298591704253;4845.8303959362665;4849.345338379274;4862.5380588844;4889.291052797395;4678.345031695498;4848.878778030577;4878.756062196805;4892.315075889307;4932.580730637793;4785.928211076906;4787.904241915073;4793.304970779148;4801.231802911518;4836.733979631013;4581.725096494221;4715.599174070242;4730.030343779586;4734.6685731999805;4786.545278198566;4820.39745031871;4867.90264194707;4874.268859671078;4923;4924.01519696055;4736.478987311462;4790;4793.376861008047;4793.49668284839;4834.444038935568 17:32:47 INFO - PROCESS | 30626 | |1;ext.html;598.3119412675422;603.4960807725549;610.3194937644528;615.9507239420847;618.0883197284006;33989.83005084974;34351.31297374054;35428.64571354286;35475.2904941901;35579.64420355796;40306.19387612246;40773.38839917404;40837;40948.79525602375;40965.59034409662;7690.115636701795;7926.6829326826855;7929;7935.841283174333;7941.483803552751;7837.294643482085;7933.523988560676;7946.324562412173;7956.562389068599;7960.920390796105;7943.205679432069;7971.920280797176;8004.359651227917;8006.039275286974;8016.63925123368;7903.8419231615335;7953.801154971115;7961.243681850215;7969.083555391088;7975.401844861659;7836.216378362175;7914.298425838415;7924.128345881948;7926.128125906146;7931.643076061591;38147.618523814686;38636.227275454614;38650;38688.61311386906;38735;3150.6219253689474;3216.4853623420377;3235.8382080895863;3299.78551394161;3356.177736454584;28402.147935561967;28721.712782872113;28749.856250718614;29190.27024324388;29451.558226626617;3517.542719446481;3561.94657080144;3566.268914872445;3568.1614820517157;3616.7468277220605;198300;200652;201738;201912;202384;51766.96466070733;51869.7406512965;51876.481235187166;52010.219846702326;52289.47710522846;51408.485915141115;54269.72865135649;58219.417805822246;59955.40044599585;60256;13121.803172952414;13169.802452963213;13215.735685286241;13254.469821207236;13263.137896036727;10126.088652021206;10131.138853197413;10160.898391016142;10164.339317944457;10177.134943529883;15947.681046379239;18253;18600.34898778536;18889.338873139648;19168;6598.802035938929;6772.255051944282;6874;6876.381125698711;6960.37356637905;852.5779739029097;903.6069309850236;911.2482202183226;971.8590804333332;980.578351308944;25902;26431.407933289283;27095.86452067727;28428.289292767433;28810.567841482396;990.9058639429243;993.4188499727741;1063.1760385701143;1063.5426766490484;1067.130288814629;14831.5550533482;15176;15254.847451525564;15559.611009724622;15593.298301576457;327254;390678;400255;400988;402667;49548.01807927714;50529.74735126301;50887;50945;50973;1078.7464945737745;1166.65000499848;1182.722060315825;1247.4947646203302;1273.9108262421541;25108.874455627603;27250.727492724818;27689.169324920284;27809.16572502828;27845.860770696017;39394.21211575695;39957.2008559833;40361.59638403579;40391.596084038785;40471.392929105496;250767;251790;251954;252003;252187;22851.657225141305;25477.617835732108;26042.609360859224;26365;26416.603750944134;36177.45733813942;36241.63758362383;36569.63430365769;36686;37170.8141459291;31522.527162093047;31593;31730.841345793124;32119.678803211667;32154.678453216104;33589.66410335963;33702.66297336995;33848.66151338554;34101.488477672356;34120.48819267663;32569;32800.343993120485;32924.34151317008;33203.66796332102;33311.333773324885;30443;32068.19829504281;33810;33941.49087763735;34069.148271293416;23005.309840704806;23199.652005220272;23300.53398932046;23644.645330320403;23760.287191384286 17:32:47 INFO - PROCESS | 30626 | |2;jquery.html;376.4607720922379;381.2698682023926;389.7973054011914;390.1105479506724;397.75339289640425;15383.461578844728;16524.83475165248;16689.415870444536;16692.49922502324;16702.494625806135;15616.141112238822;15764;16376.426825061126;16401.42595009175;16426.589335266624;4561.543845615437;4675.275332323478;4714.127886341021;4715.858524244278;4716.999999999983;3335.2328964338217;5105.438401775802;5435.320584926884;5435.374931882825;5440.836774896739;5379.596530260226;5389.272448219499;5393.164059570753;5397.811076612319;5422.105352616833;5020.523050310233;5320.813771518017;5320.893582128375;5323.893522129555;5341.092014357569;3272.280098378353;3456.4815277708294;3463.9826800866085;3468.7398445116464;4797.088553174885;11868.347240901747;12036.277823330629;12065.396730163457;12253.264804111783;12256.264624122581;1773.671870703924;1862.1341076399403;1905.771307443102;1913.8468922486168;1956.745623068992;8903.955480222558;8972.05793391691;9093.727188184364;9096.090390960917;9134.995150533436;1710.1107424139502;1719.1146559521856;1739.5651087228193;1763.7266223735342;1769.7256925176619;63764;65103;67167;67227.66386168038;68939.65530172367;9984.35101718386;10213;10336.431496267627;10646.467676616137;10909.072728818139;14237.78643320351;14281.072055272612;14284.857151428352;14299.78550321746;14325.498607548685;6859.828504287333;7295.854082918312;7342.229065948105;7469.738559150513;7469.775906722807;6912.447004239649;6946.652667366611;6983.441324694012;6998.68505917235;7027.262137475594;4374.496932852699;4379.496357918816;4380.430544029319;4389.1915536644965;4497.730136191839;1672.5747665884517;1744.6423483185915;1824.9927010188999;1825.5344887053716;1856.378113332022;790.3479629305846;856.1652388920752;857.6440777077443;865.7143142762873;884.4383816276711;16383.508494745176;16606.418775342805;17054;17104.914475427544;17352.739708904377;880.2623839858037;904.2494729374604;906.8507636900456;919.1911118215927;964.2671569607149;9312.8603070954;9444;9529.094736000068;9661.874387634709;9680.322377433653;390469;394653;406245;413515;417518;73705.26294737091;76227.23772762313;77692.61153694196;79930.60034699789;81108;936.6862101196176;944.4239014201331;958.8274110660149;963.9036096390445;976.4775844923074;15095.32071056783;15520.5343839685;15776.921115394349;15835.524934251991;16040.839591603935;33415.83292083524;34286.82856585701;34859;34862.30275394427;34890.47664285089;48390.516094838604;48445;48752.75623621859;48768.2684759736;48849.267260990404;6966.442684585119;7203.963980180066;7226.819329516804;7280.453965952469;7481.850362992818;9922.950385248028;10590.8940910593;10795.460226988462;10884.238103332691;10910.890891090987;9481.478518681539;9505.857412138961;9697.466639334903;9735.951320243354;9790.706278811647;9520.333576649567;9610.231181505602;9693.6122555097;9762.267829912644;9849.212063034796;9670.052525493467;9698.70903872885;9737.367071140354;9967.302288839712;10135.290529662852;7201.13586369639;7210.242924492853;7248.586525627663;7309.671064801991;7477.327040566375;7524.736634217776;8450.90131286338;8734.475931444134;9279.304052196247;10003.29976901639 17:32:47 INFO - PROCESS | 30626 | |3;mootools.html;1228.6007047709493;1280.5838102616651;1300.8178854960306;1354.2416246901735;1682.8906121102127;7569.65936532856;7903.802404939879;7907.565083920389;7908.011498562687;7920.722774702886;7668.309852113309;7838.960805195966;7842.098158711749;7842.960785196066;7850;1864.683003889342;2196.8572042817245;2242.069541140425;2264.841461097724;2273.874936878471;2215.512587230815;2236.317923033474;2244.652078927769;2244.674522194281;2253.0987604957986;2169.305822136917;2231.152162178378;2231.7098777158944;2232.1071571371417;2232.553489302138;1883.5197024758668;2155.7628660847295;2216.5345277491747;2224.254874617005;2226.7439244486927;2169.240765731997;2177.2488491470417;2182.1925887421758;2188.3325585696357;2210.3921421609025;7805.843883122363;7945;7952.687806511919;7957.7612671619945;7962.163972782832;4505.36924830524;4647.930281045753;4649.814007439699;4655.883602909955;4669.579737823612;2990.7009299070137;3006.9849650751826;3069.3118784668345;3069.769767267464;3074.6156730408698;1007.1791489935679;1016.872890888639;1032.8708911386077;1039.4231201683062;1045.7803861189159;10838;10850.348979061282;10854.67435976922;10858.674239772741;10874.401907895062;4137.2552940471005;4471.8434854779925;4480.305552639346;4482.798274077609;4482.843100491467;9345.90654093464;9383.906160938439;9385.15533601979;9389.859152112724;9390.342676012613;4161.979190104091;4820.25286080658;4840.080384726891;4854.296127061556;4864.416270047617;3594.6225646307284;3908.081600823804;3916.1580260244186;4294.487724681097;4350.434443522322;3701.1857391373856;3725.869594564177;3761.0785357587565;3797.715171362159;3857.9614203858164;1186.7033241689578;1240.342618412243;1242.521629172775;1245.725940293134;1254.5358217459598;696.7665831946355;783.060327606874;807.5800583696445;809.0776514773163;815.9347252219808;5108.037338343752;5168.793248270103;5247.396549396792;5367.1680889462195;5441.5102640762525;415.90850012997095;416.96455801257235;421.4542167892586;422.01038564566045;430.6253559403339;3525.9118522037156;3571.428571428559;3571.9080174021133;3590.24604832988;3658.926821463556;9317;9525.19035881944;9642.276829237835;9682.322237443312;9693.079157480028;9526.666566670134;9712.951435242778;9861.556229969668;9905.158061564704;9959.402435853872;7358.264173582599;7438.628068596657;7460.328570428579;7492.438067145095;7506.737264195727;4994.850154495371;5180.792768289377;5220.973895130652;5245.108331583564;5280.155175171954;8695.521746304014;9000.234980026771;9012.954935225282;9100.726978190665;9196.310276729138;8989;9246.260299175916;9374.859377109486;9437.764055898657;9457.290703197425;6273.1844860167885;6476;6483.805485835433;6488.870222595616;6812.795616131524;7520.586367749826;7573.46985710995;7578.583177925267;7582.090149181913;7593.278638529331;6792.72829086831;6827.419669328163;6947.340002699735;7071.292870712888;7081.610511421921;6569.4744420445295;6720.966395167993;6752.054712340375;6852.074969879002;6886.793396198122;6274.592151510137;6297.811065668037;6302.369763023661;6314.778982735582;6319.96840015797;4565.292379681155;4599.908001840012;4660.836870709509;4702.200625893538;4708.658032460732;4568.200564901195;4603.930941035954;4659.5573420525;4669.976650116863;4671.789769460314 17:32:47 INFO - PROCESS | 30626 | |4;prototype.html;298.991030269092;312.8717225937366;318.3966383702883;319.9728023118035;326.5167552023007;4863.197572400554;4866;4956.2317840734695;4963.627727920411;4992.825251116207;4907.852764417074;4915.090708218982;4918.606511479082;4941.629377796662;4953.306537084811;3903.434002069698;3913.628205320504;3916.7454115482547;3924.0778417071965;3924.5682974872884;3885.825137868803;3895.5130608673917;3904.902377440558;3918.4122381642837;3934.5081864766903;3792.791396473193;3877.263319969211;3883.4757307763516;3896.649301562859;3902.414637804338;3858.459815625815;3875.0506125999027;3889.124946886956;3899.9220015599813;3901.590333015035;3452.5671846183805;3454.378211921853;3463.8787642432394;3464.064702530303;3479.2693534357813;4566.680332376735;4730.337752714623;4755.524447555252;4769.117713223065;4777.665563410563;4428.911421771579;4458.149867804889;4470.798814053375;4486.1027794440915;4491.124230775;5174.922376164361;5183.326167598226;5193.324867767204;5200.92198617021;5208.453112423217;3783.4324851272254;3785.6592906638534;3786.3941769317053;3792.260509200707;3807.695384369244;5095.388553373582;5243.501867322599;5267.130923397634;5397.109476936301;5462.262594549725;3907.8632247871187;3908.90227744303;3916.4712763777097;3923.92152156961;3925.941110883339;3948.782816945038;3967.2263908538134;3974.900627484336;3982.9203415932097;3983.9203215935518;4200.537940826506;4205.936910946277;4324.783760811947;4333.349997500337;4339.956600434019;5189.221616757516;5192.324997750344;5196.896062078813;5227.215917612389;5233.136532472099;1353.35715535122;1375.7317323122095;1380.0546625561321;1384.1625816381145;1388.2850332078988;948.5020364308793;958.8705524754068;966.9468179250209;970.6942313171328;971.8590804333332;4581.404417425713;4619.145458090197;4620.214563524209;4627.768611569408;4630.3748993886065;5417.702026388508;5419.512243897989;5420;5425.755840987165;5430.91853622196;4497.460304763384;4619.607333376701;4620.48842879414;4621.95378046222;4631.490536041033;2871.425714857037;2884.5288902659377;2886.2495751104866;2887.6967918368687;2894.348771526432;5111.233315002779;5112.795488180431;5115.769790359443;5120.820771272987;5126.949465068278;5360.973195133999;5519.69641669704;5525.336959564878;5525.392206857243;5527.226188333637;5071.391433027987;5083.466236045162;5092.2361645753435;5099.745012749348;5102;5378.085725426765;5378.273933019149;5384.084705600136;5390.355941437899;5394.271773310553;5084.542391184811;5338.2526446298325;5339.279197308314;5340.519353258225;5356.330458692663;4920.065187614342;4956.513046086087;5105.897882042264;5116.258142569381;5137.255098010843;3712.9071773205887;3771.6982641388076;3772.019689662839;3772.1512659651357;3799.7340186187807;5396.460353964572;5406.594505412031;5422.783088676409;5429.511343979061;5434.483724046209;5006.224035274538;5201.609879258995;5274.525292723673;5278.81524146653;5293;5226.738663066907;5230.921536177037;5233.450487698737;5249.081410753027;5263.921041184309;5180.404253510744;5196.792128314825;5196.922046169386;5197.558207552401;5211.322528071327;5010.974945125251;5314.760835762478;5317.308749862493;5319.122344813062;5332.33345831771;5176.637635365489;5184.611154163377;5203.5576975957465;5205.609579281493;5213.504717051874 17:32:47 INFO - PROCESS | 30626 | |5;yui.html;695.18663164098;764.1785081037879;781.7498400511835;784.4430454377392;790.1703211627793;11276.774464510705;11498.137639677037;11540.365279909602;11595.710107247323;11616.825747613771;11998.160128790967;12019.158658893859;12026.699332516691;12035;12088.516459341616;639.3031595560838;762.3938968520013;793.5119901260712;804.7947773317795;806.7902345390212;809.9676012959475;815.5840521334103;816.1389733830836;816.338765599863;817.0603805623521;844.1980118887051;852.4885068958606;852.8336974290016;853.0701535326493;853.5305581929945;676.5196710335692;826.6817275348974;842.4987132656059;845.4124383553433;857.9699710510165;619.1517620859452;622.390057743414;624.597134848025;624.9562530622858;625.383996763188;11490.253133546294;11548;11550.94224528872;11573.36346500942;11581.131415143813;12070.879291207064;12274.324912129829;12521.311327876963;12640.115191936567;12713.745725085539;10016.549255283457;10037.146842518394;10148.441835699034;10156.035176658206;10516.421596812172;3369.561956945581;3393.2874096439778;3394.8132852693093;3429.4855771634207;3469.5142680024815;44937.55062449366;45002;45065.77467112676;45410.54589454129;45550.77224613889;9596.808063838684;9997.400155990665;9999.50002499872;10041.146502547219;10057.29598928068;17071.402500912656;17120.486385408458;17151.485455436356;17173;17389.65220695604;6669.966650166718;6716.966415167893;6785.423239024738;6818.965905170541;6878.449724022066;3519.348920449725;3535.222251104753;3554.3424466473784;3568.91077723059;3571.8392672329805;2687.6237326774267;2730.808843380984;2743.931401714973;2748.848813315287;2756.476269508787;477.362720767772;506.7364970215541;516.9302144210559;523.9685618862804;532.82150479589;575.9452851979055;648.2415573778596;654.5385503220218;657.641585335993;661.2527843536773;7930.889675445443;7970.115801270078;8356.665733370719;8473.449225800303;8533.743987680255;593.5014587746314;605.8243109498196;623.9376062393815;637.6046850952347;639.9488040956712;3852.614738526125;3885.941710874339;3929.214157168578;3937.1928754605237;4070.4504891839224;45734.313985290246;46556.76721616438;47010.05979880452;47305;47375;41070;41139.38290925638;41216.58783412188;41401.378979315334;42411.57588424138;31854.840725796686;32408.189795254835;38246.23507529834;38640.6135938637;38743.80628096841;7998.240167184108;8322.45904016237;8445.408821382443;8460.661573537236;8486.575671216538;26710;26987;27259;27902.581461278503;28085.859570702014;33132;34234.82882585571;35653.82173089222;35884.641153589175;35940;11129.666110016713;11245.71885702864;11304.378259195822;11390.430478476208;11405.087592992706;11531.1928165031;11534.538618455503;11824.46789894474;12136.696582585506;12316.384180790745;11334.659960201207;11369.354854750549;11437;11479.598214062467;12055.397230138633;11075.390853503135;11259.155563332946;11569.6529104127;11593.88406115928;11634.476448560004;10782.73043173927;10982.725431864268;11584.073274138218;11598.362090085126;11612.419379031184;9502.572384242863;9634.566444509874;9756.853647195156;10316.948415257875;10434.68695939123;9765.462899540593;9812.509374531388;9908.455034973145;9928;9938.850917236103 17:32:47 INFO - PROCESS | 30626 | __end_tp_report 17:32:47 INFO - PROCESS | 30626 | __start_cc_report 17:32:47 INFO - PROCESS | 30626 | _x_x_mozilla_cycle_collect,908 17:32:47 INFO - PROCESS | 30626 | __end_cc_report 17:32:47 INFO - PROCESS | 30626 | __startTimestamp1460766767566__endTimestamp 17:32:47 INFO - PROCESS | 30626 | 17:32:47 INFO - PROCESS | 30626 | ------- Summary: start ------- 17:32:47 INFO - PROCESS | 30626 | Number of tests: 6 17:32:47 INFO - PROCESS | 30626 | 17:32:47 INFO - PROCESS | 30626 | [#0] dojo.html Cycles:165 Average:4579.54 Median:4718.08 stddev:460.53 (9.8%) stddev-sans-first:435.29 17:32:47 INFO - PROCESS | 30626 | Values: 2611.5 2663.0 2671.8 2676.0 2700.7 4571.9 4598.7 4601.0 4631.9 4649.7 4653.5 4693.4 4710.2 4718.1 4736.0 4257.9 4292.7 4325.5 4351.6 4444.6 4365.4 4396.2 4408.2 4417.3 4449.3 4155.8 4239.7 4280.4 4341.2 4351.8 4248.6 4278.1 4282.7 4284.6 4322.6 4241.6 4269.1 4273.6 4296.3 4300.0 4379.6 4473.2 4522.7 4558.7 4578.5 4965.3 4984.3 4986.6 4987.6 5015.5 4990.6 5009.1 5016.8 5018.2 5055.0 4424.1 4634.1 4672.2 4724.3 4726.8 5001.6 5004.3 5017.7 5020.0 5021.6 4741.6 4817.7 4818.0 4819.8 4853.1 4933.0 4988.2 4993.7 4996.9 5004.3 4905.2 4933.2 4938.7 4943.0 4980.2 4746.3 4916.0 4921.0 4934.2 4969.9 4193.5 4197.6 4217.9 4218.4 4235.5 3666.9 3684.1 3687.9 3715.9 3727.7 4137.8 4211.7 4258.2 4272.4 4290.6 4965.9 4968.6 4982.0 5015.6 5036.5 4259.1 4262.9 4267.1 4283.1 4316.4 4346.6 4450.8 4452.2 4458.6 4511.4 4604.9 4626.2 4636.6 4669.2 4673.2 4886.1 4887.2 4898.9 4903.5 4940.3 4571.5 4632.3 4704.3 4783.0 4797.4 4754.9 4787.6 4800.0 4801.1 4841.9 4837.3 4845.8 4849.3 4862.5 4889.3 4678.3 4848.9 4878.8 4892.3 4932.6 4785.9 4787.9 4793.3 4801.2 4836.7 4581.7 4715.6 4730.0 4734.7 4786.5 4820.4 4867.9 4874.3 4923.0 4924.0 4736.5 4790.0 4793.4 4793.5 4834.4 17:32:47 INFO - PROCESS | 30626 | 17:32:47 INFO - PROCESS | 30626 | [#1] ext.html Cycles:180 Average:43473.13 Median:18934.43 stddev:76444.35 (403.7%) stddev-sans-first:76591.01 17:32:47 INFO - PROCESS | 30626 | Values: 598.3 603.5 610.3 616.0 618.1 33989.8 34351.3 35428.6 35475.3 35579.6 40306.2 40773.4 40837.0 40948.8 40965.6 7690.1 7926.7 7929.0 7935.8 7941.5 7837.3 7933.5 7946.3 7956.6 7960.9 7943.2 7971.9 8004.4 8006.0 8016.6 7903.8 7953.8 7961.2 7969.1 7975.4 7836.2 7914.3 7924.1 7926.1 7931.6 38147.6 38636.2 38650.0 38688.6 38735.0 3150.6 3216.5 3235.8 3299.8 3356.2 28402.1 28721.7 28749.9 29190.3 29451.6 3517.5 3561.9 3566.3 3568.2 3616.7 198300.0 200652.0 201738.0 201912.0 202384.0 51767.0 51869.7 51876.5 52010.2 52289.5 51408.5 54269.7 58219.4 59955.4 60256.0 13121.8 13169.8 13215.7 13254.5 13263.1 10126.1 10131.1 10160.9 10164.3 10177.1 15947.7 18253.0 18600.3 18889.3 19168.0 6598.8 6772.3 6874.0 6876.4 6960.4 852.6 903.6 911.2 971.9 980.6 25902.0 26431.4 27095.9 28428.3 28810.6 990.9 993.4 1063.2 1063.5 1067.1 14831.6 15176.0 15254.8 15559.6 15593.3 327254.0 390678.0 400255.0 400988.0 402667.0 49548.0 50529.7 50887.0 50945.0 50973.0 1078.7 1166.7 1182.7 1247.5 1273.9 25108.9 27250.7 27689.2 27809.2 27845.9 39394.2 39957.2 40361.6 40391.6 40471.4 250767.0 251790.0 251954.0 252003.0 252187.0 22851.7 25477.6 26042.6 26365.0 26416.6 36177.5 36241.6 36569.6 36686.0 37170.8 31522.5 31593.0 31730.8 32119.7 32154.7 33589.7 33702.7 33848.7 34101.5 34120.5 32569.0 32800.3 32924.3 33203.7 33311.3 30443.0 32068.2 33810.0 33941.5 34069.1 23005.3 23199.7 23300.5 23644.6 23760.3 17:32:47 INFO - PROCESS | 30626 | 17:32:47 INFO - PROCESS | 30626 | [#2] jquery.html Cycles:180 Average:24068.52 Median:26934.90 stddev:66727.81 (247.7%) stddev-sans-first:66891.29 17:32:47 INFO - PROCESS | 30626 | Values: 376.5 381.3 389.8 390.1 397.8 15383.5 16524.8 16689.4 16692.5 16702.5 15616.1 15764.0 16376.4 16401.4 16426.6 4561.5 4675.3 4714.1 4715.9 4717.0 3335.2 5105.4 5435.3 5435.4 5440.8 5379.6 5389.3 5393.2 5397.8 5422.1 5020.5 5320.8 5320.9 5323.9 5341.1 3272.3 3456.5 3464.0 3468.7 4797.1 11868.3 12036.3 12065.4 12253.3 12256.3 1773.7 1862.1 1905.8 1913.8 1956.7 8904.0 8972.1 9093.7 9096.1 9135.0 1710.1 1719.1 1739.6 1763.7 1769.7 63764.0 65103.0 67167.0 67227.7 68939.7 9984.4 10213.0 10336.4 10646.5 10909.1 14237.8 14281.1 14284.9 14299.8 14325.5 6859.8 7295.9 7342.2 7469.7 7469.8 6912.4 6946.7 6983.4 6998.7 7027.3 4374.5 4379.5 4380.4 4389.2 4497.7 1672.6 1744.6 1825.0 1825.5 1856.4 790.3 856.2 857.6 865.7 884.4 16383.5 16606.4 17054.0 17104.9 17352.7 880.3 904.2 906.9 919.2 964.3 9312.9 9444.0 9529.1 9661.9 9680.3 390469.0 394653.0 406245.0 413515.0 417518.0 73705.3 76227.2 77692.6 79930.6 81108.0 936.7 944.4 958.8 963.9 976.5 15095.3 15520.5 15776.9 15835.5 16040.8 33415.8 34286.8 34859.0 34862.3 34890.5 48390.5 48445.0 48752.8 48768.3 48849.3 6966.4 7204.0 7226.8 7280.5 7481.9 9923.0 10590.9 10795.5 10884.2 10910.9 9481.5 9505.9 9697.5 9736.0 9790.7 9520.3 9610.2 9693.6 9762.3 9849.2 9670.1 9698.7 9737.4 9967.3 10135.3 7201.1 7210.2 7248.6 7309.7 7477.3 7524.7 8450.9 8734.5 9279.3 10003.3 17:32:47 INFO - PROCESS | 30626 | 17:32:47 INFO - PROCESS | 30626 | [#3] mootools.html Cycles:180 Average:5185.59 Median:4764.46 stddev:2941.02 (61.7%) stddev-sans-first:2934.24 17:32:47 INFO - PROCESS | 30626 | Values: 1228.6 1280.6 1300.8 1354.2 1682.9 7569.7 7903.8 7907.6 7908.0 7920.7 7668.3 7839.0 7842.1 7843.0 7850.0 1864.7 2196.9 2242.1 2264.8 2273.9 2215.5 2236.3 2244.7 2244.7 2253.1 2169.3 2231.2 2231.7 2232.1 2232.6 1883.5 2155.8 2216.5 2224.3 2226.7 2169.2 2177.2 2182.2 2188.3 2210.4 7805.8 7945.0 7952.7 7957.8 7962.2 4505.4 4647.9 4649.8 4655.9 4669.6 2990.7 3007.0 3069.3 3069.8 3074.6 1007.2 1016.9 1032.9 1039.4 1045.8 10838.0 10850.3 10854.7 10858.7 10874.4 4137.3 4471.8 4480.3 4482.8 4482.8 9345.9 9383.9 9385.2 9389.9 9390.3 4162.0 4820.3 4840.1 4854.3 4864.4 3594.6 3908.1 3916.2 4294.5 4350.4 3701.2 3725.9 3761.1 3797.7 3858.0 1186.7 1240.3 1242.5 1245.7 1254.5 696.8 783.1 807.6 809.1 815.9 5108.0 5168.8 5247.4 5367.2 5441.5 415.9 417.0 421.5 422.0 430.6 3525.9 3571.4 3571.9 3590.2 3658.9 9317.0 9525.2 9642.3 9682.3 9693.1 9526.7 9713.0 9861.6 9905.2 9959.4 7358.3 7438.6 7460.3 7492.4 7506.7 4994.9 5180.8 5221.0 5245.1 5280.2 8695.5 9000.2 9013.0 9100.7 9196.3 8989.0 9246.3 9374.9 9437.8 9457.3 6273.2 6476.0 6483.8 6488.9 6812.8 7520.6 7573.5 7578.6 7582.1 7593.3 6792.7 6827.4 6947.3 7071.3 7081.6 6569.5 6721.0 6752.1 6852.1 6886.8 6274.6 6297.8 6302.4 6314.8 6320.0 4565.3 4599.9 4660.8 4702.2 4708.7 4568.2 4603.9 4659.6 4670.0 4671.8 17:32:47 INFO - PROCESS | 30626 | 17:32:47 INFO - PROCESS | 30626 | [#4] prototype.html Cycles:180 Average:4350.71 Median:4930.85 stddev:1247.20 (25.3%) stddev-sans-first:1213.05 17:32:47 INFO - PROCESS | 30626 | Values: 299.0 312.9 318.4 320.0 326.5 4863.2 4866.0 4956.2 4963.6 4992.8 4907.9 4915.1 4918.6 4941.6 4953.3 3903.4 3913.6 3916.7 3924.1 3924.6 3885.8 3895.5 3904.9 3918.4 3934.5 3792.8 3877.3 3883.5 3896.6 3902.4 3858.5 3875.1 3889.1 3899.9 3901.6 3452.6 3454.4 3463.9 3464.1 3479.3 4566.7 4730.3 4755.5 4769.1 4777.7 4428.9 4458.1 4470.8 4486.1 4491.1 5174.9 5183.3 5193.3 5200.9 5208.5 3783.4 3785.7 3786.4 3792.3 3807.7 5095.4 5243.5 5267.1 5397.1 5462.3 3907.9 3908.9 3916.5 3923.9 3925.9 3948.8 3967.2 3974.9 3982.9 3983.9 4200.5 4205.9 4324.8 4333.3 4340.0 5189.2 5192.3 5196.9 5227.2 5233.1 1353.4 1375.7 1380.1 1384.2 1388.3 948.5 958.9 966.9 970.7 971.9 4581.4 4619.1 4620.2 4627.8 4630.4 5417.7 5419.5 5420.0 5425.8 5430.9 4497.5 4619.6 4620.5 4622.0 4631.5 2871.4 2884.5 2886.2 2887.7 2894.3 5111.2 5112.8 5115.8 5120.8 5126.9 5361.0 5519.7 5525.3 5525.4 5527.2 5071.4 5083.5 5092.2 5099.7 5102.0 5378.1 5378.3 5384.1 5390.4 5394.3 5084.5 5338.3 5339.3 5340.5 5356.3 4920.1 4956.5 5105.9 5116.3 5137.3 3712.9 3771.7 3772.0 3772.2 3799.7 5396.5 5406.6 5422.8 5429.5 5434.5 5006.2 5201.6 5274.5 5278.8 5293.0 5226.7 5230.9 5233.5 5249.1 5263.9 5180.4 5196.8 5196.9 5197.6 5211.3 5011.0 5314.8 5317.3 5319.1 5332.3 5176.6 5184.6 5203.6 5205.6 5213.5 17:32:47 INFO - PROCESS | 30626 | 17:32:47 INFO - PROCESS | 30626 | [#5] yui.html Cycles:180 Average:12145.34 Median:3907.58 stddev:13026.23 (333.4%) stddev-sans-first:13034.39 17:32:47 INFO - PROCESS | 30626 | Values: 695.2 764.2 781.7 784.4 790.2 11276.8 11498.1 11540.4 11595.7 11616.8 11998.2 12019.2 12026.7 12035.0 12088.5 639.3 762.4 793.5 804.8 806.8 810.0 815.6 816.1 816.3 817.1 844.2 852.5 852.8 853.1 853.5 676.5 826.7 842.5 845.4 858.0 619.2 622.4 624.6 625.0 625.4 11490.3 11548.0 11550.9 11573.4 11581.1 12070.9 12274.3 12521.3 12640.1 12713.7 10016.5 10037.1 10148.4 10156.0 10516.4 3369.6 3393.3 3394.8 3429.5 3469.5 44937.6 45002.0 45065.8 45410.5 45550.8 9596.8 9997.4 9999.5 10041.1 10057.3 17071.4 17120.5 17151.5 17173.0 17389.7 6670.0 6717.0 6785.4 6819.0 6878.4 3519.3 3535.2 3554.3 3568.9 3571.8 2687.6 2730.8 2743.9 2748.8 2756.5 477.4 506.7 516.9 524.0 532.8 575.9 648.2 654.5 657.6 661.3 7930.9 7970.1 8356.7 8473.4 8533.7 593.5 605.8 623.9 637.6 639.9 3852.6 3885.9 3929.2 3937.2 4070.5 45734.3 46556.8 47010.1 47305.0 47375.0 41070.0 41139.4 41216.6 41401.4 42411.6 31854.8 32408.2 38246.2 38640.6 38743.8 7998.2 8322.5 8445.4 8460.7 8486.6 26710.0 26987.0 27259.0 27902.6 28085.9 33132.0 34234.8 35653.8 35884.6 35940.0 11129.7 11245.7 11304.4 11390.4 11405.1 11531.2 11534.5 11824.5 12136.7 12316.4 11334.7 11369.4 11437.0 11479.6 12055.4 11075.4 11259.2 11569.7 11593.9 11634.5 10782.7 10982.7 11584.1 11598.4 11612.4 9502.6 9634.6 9756.9 10316.9 10434.7 9765.5 9812.5 9908.5 9928.0 9938.9 17:32:47 INFO - PROCESS | 30626 | -------- Summary: end -------- 17:32:47 INFO - PROCESS | 30626 | 17:32:48 INFO - TEST-INFO | 30626: exit 0 17:32:48 INFO - TEST-OK | dromaeo_css | took 1117774ms 17:32:48 INFO - TEST-START | kraken 17:32:48 INFO - operating with platform_type : linux_ 17:32:48 INFO - Initialising browser for kraken test... 17:32:48 INFO - TEST-INFO | started process 30804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe_DspE/profile http://localhost:45400/getInfo.html) 17:32:52 INFO - PROCESS | 30804 | __metrics Screen width/height:1600/1200 17:32:52 INFO - PROCESS | 30804 | colorDepth:24 17:32:52 INFO - PROCESS | 30804 | Browser inner width/height: 1024/697 17:32:52 INFO - PROCESS | 30804 | __metrics 17:32:53 ERROR - PROCESS | 30804 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:32:54 INFO - TEST-INFO | 30804: exit 0 17:32:54 INFO - Browser initialized. 17:32:54 INFO - Running cycle 1/1 for kraken test... 17:32:54 INFO - TEST-INFO | started process 30885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe_DspE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:06 INFO - PROCESS | 30885 | RSS: Main: 154865664 17:33:06 INFO - PROCESS | 30885 | 17:33:09 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45400/tests/kraken/driver.html?testName=audio-beat-detection) 17:33:10 INFO - PROCESS | 30885 | RSS: Main: 209190912 17:33:10 INFO - PROCESS | 30885 | 17:33:13 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45400/tests/kraken/driver.html?testName=audio-dft) 17:33:13 INFO - PROCESS | 30885 | RSS: Main: 195047424 17:33:13 INFO - PROCESS | 30885 | 17:33:16 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45400/tests/kraken/driver.html?testName=audio-fft) 17:33:17 INFO - PROCESS | 30885 | RSS: Main: 266629120 17:33:17 INFO - PROCESS | 30885 | 17:33:19 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45400/tests/kraken/driver.html?testName=audio-oscillator) 17:33:20 INFO - PROCESS | 30885 | RSS: Main: 174444544 17:33:20 INFO - PROCESS | 30885 | 17:33:22 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:33:23 INFO - PROCESS | 30885 | RSS: Main: 178724864 17:33:23 INFO - PROCESS | 30885 | 17:33:26 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45400/tests/kraken/driver.html?testName=imaging-darkroom) 17:33:26 INFO - PROCESS | 30885 | RSS: Main: 214667264 17:33:26 INFO - PROCESS | 30885 | 17:33:30 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45400/tests/kraken/driver.html?testName=imaging-desaturate) 17:33:30 INFO - PROCESS | 30885 | RSS: Main: 215142400 17:33:30 INFO - PROCESS | 30885 | 17:33:33 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45400/tests/kraken/driver.html?testName=json-parse-financial) 17:33:34 INFO - PROCESS | 30885 | RSS: Main: 215642112 17:33:34 INFO - PROCESS | 30885 | 17:33:36 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:33:36 INFO - PROCESS | 30885 | RSS: Main: 199868416 17:33:36 INFO - PROCESS | 30885 | 17:33:38 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:33:39 INFO - PROCESS | 30885 | RSS: Main: 205086720 17:33:39 INFO - PROCESS | 30885 | 17:33:41 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:33:41 INFO - PROCESS | 30885 | RSS: Main: 218697728 17:33:41 INFO - PROCESS | 30885 | 17:33:44 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:45 INFO - PROCESS | 30885 | RSS: Main: 224301056 17:33:45 INFO - PROCESS | 30885 | 17:33:48 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:48 INFO - PROCESS | 30885 | RSS: Main: 220717056 17:33:48 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45400/tests/kraken/driver.html?testName=ai-astar) 17:33:50 INFO - PROCESS | 30885 | RSS: Main: 284033024 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | __start_tp_report 17:33:50 INFO - PROCESS | 30885 | _x_x_mozilla_page_load 17:33:50 INFO - PROCESS | 30885 | _x_x_mozilla_page_load_details 17:33:50 INFO - PROCESS | 30885 | |i|pagename|runs| 17:33:50 INFO - PROCESS | 30885 | |0;ai-astar;112;112;107;113;113;115;104;114;114;115 17:33:50 INFO - PROCESS | 30885 | |1;audio-beat-detection;159;130;160;203;131;158;163;137;182;139 17:33:50 INFO - PROCESS | 30885 | |2;audio-dft;159;160;161;159;161;160;159;162;159;164 17:33:50 INFO - PROCESS | 30885 | |3;audio-fft;73;75;102;111;75;74;73;113;103;73 17:33:50 INFO - PROCESS | 30885 | |4;audio-oscillator;94;94;150;94;93;93;150;93;93;142 17:33:50 INFO - PROCESS | 30885 | |5;imaging-gaussian-blur;116;117;117;117;123;117;117;117;117;117 17:33:50 INFO - PROCESS | 30885 | |6;imaging-darkroom;146;146;146;145;146;147;146;146;146;146 17:33:50 INFO - PROCESS | 30885 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;94;94 17:33:50 INFO - PROCESS | 30885 | |8;json-parse-financial;64;64;65;66;66;66;65;80;62;62 17:33:50 INFO - PROCESS | 30885 | |9;json-stringify-tinderbox;64;64;64;64;65;63;64;65;64;65 17:33:50 INFO - PROCESS | 30885 | |10;stanford-crypto-aes;78;78;76;78;79;78;80;78;88;80 17:33:50 INFO - PROCESS | 30885 | |11;stanford-crypto-ccm;142;132;141;134;141;134;131;130;167;137 17:33:50 INFO - PROCESS | 30885 | |12;stanford-crypto-pbkdf2;172;186;172;171;173;174;171;171;178;172 17:33:50 INFO - PROCESS | 30885 | |13;stanford-crypto-sha256-iterative;74;81;73;74;73;72;72;72;71;70 17:33:50 INFO - PROCESS | 30885 | __end_tp_report 17:33:50 INFO - PROCESS | 30885 | __start_cc_report 17:33:50 INFO - PROCESS | 30885 | _x_x_mozilla_cycle_collect,1892 17:33:50 INFO - PROCESS | 30885 | __end_cc_report 17:33:50 INFO - PROCESS | 30885 | __startTimestamp1460766830957__endTimestamp 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | ------- Summary: start ------- 17:33:50 INFO - PROCESS | 30885 | Number of tests: 14 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:3.60 (3.2%) stddev-sans-first:3.82 17:33:50 INFO - PROCESS | 30885 | Values: 112.0 112.0 107.0 113.0 113.0 115.0 104.0 114.0 114.0 115.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:159.50 stddev:23.37 (14.6%) stddev-sans-first:24.76 17:33:50 INFO - PROCESS | 30885 | Values: 159.0 130.0 160.0 203.0 131.0 158.0 163.0 137.0 182.0 139.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.65 (1.0%) stddev-sans-first:1.67 17:33:50 INFO - PROCESS | 30885 | Values: 159.0 160.0 161.0 159.0 161.0 160.0 159.0 162.0 159.0 164.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#3] audio-fft Cycles:10 Average:87.20 Median:73.00 stddev:17.57 (24.1%) stddev-sans-first:17.87 17:33:50 INFO - PROCESS | 30885 | Values: 73.0 75.0 102.0 111.0 75.0 74.0 73.0 113.0 103.0 73.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:26.13 (28.1%) stddev-sans-first:27.10 17:33:50 INFO - PROCESS | 30885 | Values: 94.0 94.0 150.0 94.0 93.0 93.0 150.0 93.0 93.0 142.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:1.96 (1.7%) stddev-sans-first:2.00 17:33:50 INFO - PROCESS | 30885 | Values: 116.0 117.0 117.0 117.0 123.0 117.0 117.0 117.0 117.0 117.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 17:33:50 INFO - PROCESS | 30885 | Values: 146.0 146.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 146.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:33:50 INFO - PROCESS | 30885 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:65.50 stddev:5.14 (7.9%) stddev-sans-first:5.40 17:33:50 INFO - PROCESS | 30885 | Values: 64.0 64.0 65.0 66.0 66.0 66.0 65.0 80.0 62.0 62.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 17:33:50 INFO - PROCESS | 30885 | Values: 64.0 64.0 64.0 64.0 65.0 63.0 64.0 65.0 64.0 65.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:3.27 (4.2%) stddev-sans-first:3.43 17:33:50 INFO - PROCESS | 30885 | Values: 78.0 78.0 76.0 78.0 79.0 78.0 80.0 78.0 88.0 80.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:139.00 stddev:10.80 (7.8%) stddev-sans-first:11.39 17:33:50 INFO - PROCESS | 30885 | Values: 142.0 132.0 141.0 134.0 141.0 134.0 131.0 130.0 167.0 137.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:172.50 stddev:4.71 (2.7%) stddev-sans-first:4.94 17:33:50 INFO - PROCESS | 30885 | Values: 172.0 186.0 172.0 171.0 173.0 174.0 171.0 171.0 178.0 172.0 17:33:50 INFO - PROCESS | 30885 | 17:33:50 INFO - PROCESS | 30885 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:3.01 (4.1%) stddev-sans-first:3.18 17:33:50 INFO - PROCESS | 30885 | Values: 74.0 81.0 73.0 74.0 73.0 72.0 72.0 72.0 71.0 70.0 17:33:50 INFO - PROCESS | 30885 | -------- Summary: end -------- 17:33:50 INFO - PROCESS | 30885 | 17:33:51 INFO - TEST-INFO | 30885: exit 0 17:33:52 INFO - TEST-OK | kraken | took 63714ms 17:33:52 INFO - SUITE-END | took 1181s 17:33:52 INFO - Completed test suite (00:19:41) 17:33:52 INFO - javascript benchmark 17:33:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.5038142752874, 2662.9689270591043, 2671.799615028873, 2676.0, 2700.7164247753985, 4571.9314210286875, 4598.678092533524, 4601.03378290559, 4631.9073618527655, 4649.721016738989, 4653.488116307203, 4693.389859318292, 4710.199266124759, 4718.079974404993, 4736.0, 4257.936130958023, 4292.6780491463105, 4325.502567204764, 4351.586599273064, 4444.577765112309, 4365.36702178184, 4396.1867054595, 4408.228560002003, 4417.271150260203, 4449.26587113126, 4155.7506549606815, 4239.745615263094, 4280.400743895857, 4341.218580655481, 4351.760653164075, 4248.575142485757, 4278.101598664284, 4282.657387409, 4284.61438470536, 4322.610965013164, 4241.597048280409, 4269.124829409963, 4273.636740877029, 4296.291111966521, 4299.978500107511, 4379.605835474823, 4473.217186992263, 4522.7286362818, 4558.703684260512, 4578.542145785428, 4965.280034395028, 4984.327115839352, 4986.5761410280165, 4987.625928055374, 5015.548600625962, 4990.575801056914, 5009.098362294785, 5016.799328026875, 5018.222175562757, 5055.039542486952, 4424.137293227822, 4634.096351211515, 4672.2057250267535, 4724.267738500538, 4726.787294571753, 5001.624878134155, 5004.274380214922, 5017.698938063728, 5019.996000799854, 5021.59827213822, 4741.644376671763, 4817.710937343771, 4817.9518204818205, 4819.759012049453, 4853.126437241331, 4932.950670493249, 4988.176950803149, 4993.650444468853, 4996.925046124311, 5004.274380214849, 4905.23968784839, 4933.161362568372, 4938.654294199443, 4943.0, 4980.153373926441, 4746.264329029006, 4915.95084049155, 4921.040397122527, 4934.18585933317, 4969.850904472799, 4193.5387107418155, 4197.580241975778, 4217.91564168721, 4218.367244913287, 4235.53409124996, 3666.8899933002053, 3684.078980254936, 3687.8893633191046, 3715.851365945386, 3727.7390582658954, 4137.81379837908, 4211.705180637326, 4258.1696569169335, 4272.4445822042935, 4290.635295999812, 4965.925511117336, 4968.577670898014, 4981.975090124526, 5015.573676237561, 5036.496350364934, 4259.1268789897995, 4262.914741705148, 4267.125239325931, 4283.1005488847695, 4316.438862947797, 4346.630536404377, 4450.821967121344, 4452.243118669834, 4458.554144585515, 4511.368408422823, 4604.930926036045, 4626.236670949255, 4636.582707556268, 4669.182892993713, 4673.205555055717, 4886.071646387175, 4887.218045112765, 4898.926516102332, 4903.460619331942, 4940.308356830118, 4571.542845715535, 4632.305154226893, 4704.294355846513, 4782.976085119552, 4797.376341075777, 4754.881127971828, 4787.61699064067, 4799.952000480091, 4801.135795556834, 4841.8547443576745, 4837.298591704253, 4845.8303959362665, 4849.345338379274, 4862.5380588844, 4889.291052797395, 4678.345031695498, 4848.878778030577, 4878.756062196805, 4892.315075889307, 4932.580730637793, 4785.928211076906, 4787.904241915073, 4793.304970779148, 4801.231802911518, 4836.733979631013, 4581.725096494221, 4715.599174070242, 4730.030343779586, 4734.6685731999805, 4786.545278198566, 4820.39745031871, 4867.90264194707, 4874.268859671078, 4923.0, 4924.01519696055, 4736.478987311462, 4790.0, 4793.376861008047, 4793.49668284839, 4834.444038935568], "value": 4551.635709783181, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.3119412675422, 603.4960807725549, 610.3194937644528, 615.9507239420847, 618.0883197284006, 33989.83005084974, 34351.31297374054, 35428.64571354286, 35475.2904941901, 35579.64420355796, 40306.19387612246, 40773.38839917404, 40837.0, 40948.79525602375, 40965.59034409662, 7690.115636701795, 7926.6829326826855, 7929.0, 7935.841283174333, 7941.483803552751, 7837.294643482085, 7933.523988560676, 7946.324562412173, 7956.562389068599, 7960.920390796105, 7943.205679432069, 7971.920280797176, 8004.359651227917, 8006.039275286974, 8016.63925123368, 7903.8419231615335, 7953.801154971115, 7961.243681850215, 7969.083555391088, 7975.401844861659, 7836.216378362175, 7914.298425838415, 7924.128345881948, 7926.128125906146, 7931.643076061591, 38147.618523814686, 38636.227275454614, 38650.0, 38688.61311386906, 38735.0, 3150.6219253689474, 3216.4853623420377, 3235.8382080895863, 3299.78551394161, 3356.177736454584, 28402.147935561967, 28721.712782872113, 28749.856250718614, 29190.27024324388, 29451.558226626617, 3517.542719446481, 3561.94657080144, 3566.268914872445, 3568.1614820517157, 3616.7468277220605, 198300.0, 200652.0, 201738.0, 201912.0, 202384.0, 51766.96466070733, 51869.7406512965, 51876.481235187166, 52010.219846702326, 52289.47710522846, 51408.485915141115, 54269.72865135649, 58219.417805822246, 59955.40044599585, 60256.0, 13121.803172952414, 13169.802452963213, 13215.735685286241, 13254.469821207236, 13263.137896036727, 10126.088652021206, 10131.138853197413, 10160.898391016142, 10164.339317944457, 10177.134943529883, 15947.681046379239, 18253.0, 18600.34898778536, 18889.338873139648, 19168.0, 6598.802035938929, 6772.255051944282, 6874.0, 6876.381125698711, 6960.37356637905, 852.5779739029097, 903.6069309850236, 911.2482202183226, 971.8590804333332, 980.578351308944, 25902.0, 26431.407933289283, 27095.86452067727, 28428.289292767433, 28810.567841482396, 990.9058639429243, 993.4188499727741, 1063.1760385701143, 1063.5426766490484, 1067.130288814629, 14831.5550533482, 15176.0, 15254.847451525564, 15559.611009724622, 15593.298301576457, 327254.0, 390678.0, 400255.0, 400988.0, 402667.0, 49548.01807927714, 50529.74735126301, 50887.0, 50945.0, 50973.0, 1078.7464945737745, 1166.65000499848, 1182.722060315825, 1247.4947646203302, 1273.9108262421541, 25108.874455627603, 27250.727492724818, 27689.169324920284, 27809.16572502828, 27845.860770696017, 39394.21211575695, 39957.2008559833, 40361.59638403579, 40391.596084038785, 40471.392929105496, 250767.0, 251790.0, 251954.0, 252003.0, 252187.0, 22851.657225141305, 25477.617835732108, 26042.609360859224, 26365.0, 26416.603750944134, 36177.45733813942, 36241.63758362383, 36569.63430365769, 36686.0, 37170.8141459291, 31522.527162093047, 31593.0, 31730.841345793124, 32119.678803211667, 32154.678453216104, 33589.66410335963, 33702.66297336995, 33848.66151338554, 34101.488477672356, 34120.48819267663, 32569.0, 32800.343993120485, 32924.34151317008, 33203.66796332102, 33311.333773324885, 30443.0, 32068.19829504281, 33810.0, 33941.49087763735, 34069.148271293416, 23005.309840704806, 23199.652005220272, 23300.53398932046, 23644.645330320403, 23760.287191384286], "value": 17060.062358431926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.4607720922379, 381.2698682023926, 389.7973054011914, 390.1105479506724, 397.75339289640425, 15383.461578844728, 16524.83475165248, 16689.415870444536, 16692.49922502324, 16702.494625806135, 15616.141112238822, 15764.0, 16376.426825061126, 16401.42595009175, 16426.589335266624, 4561.543845615437, 4675.275332323478, 4714.127886341021, 4715.858524244278, 4716.999999999983, 3335.2328964338217, 5105.438401775802, 5435.320584926884, 5435.374931882825, 5440.836774896739, 5379.596530260226, 5389.272448219499, 5393.164059570753, 5397.811076612319, 5422.105352616833, 5020.523050310233, 5320.813771518017, 5320.893582128375, 5323.893522129555, 5341.092014357569, 3272.280098378353, 3456.4815277708294, 3463.9826800866085, 3468.7398445116464, 4797.088553174885, 11868.347240901747, 12036.277823330629, 12065.396730163457, 12253.264804111783, 12256.264624122581, 1773.671870703924, 1862.1341076399403, 1905.771307443102, 1913.8468922486168, 1956.745623068992, 8903.955480222558, 8972.05793391691, 9093.727188184364, 9096.090390960917, 9134.995150533436, 1710.1107424139502, 1719.1146559521856, 1739.5651087228193, 1763.7266223735342, 1769.7256925176619, 63764.0, 65103.0, 67167.0, 67227.66386168038, 68939.65530172367, 9984.35101718386, 10213.0, 10336.431496267627, 10646.467676616137, 10909.072728818139, 14237.78643320351, 14281.072055272612, 14284.857151428352, 14299.78550321746, 14325.498607548685, 6859.828504287333, 7295.854082918312, 7342.229065948105, 7469.738559150513, 7469.775906722807, 6912.447004239649, 6946.652667366611, 6983.441324694012, 6998.68505917235, 7027.262137475594, 4374.496932852699, 4379.496357918816, 4380.430544029319, 4389.1915536644965, 4497.730136191839, 1672.5747665884517, 1744.6423483185915, 1824.9927010188999, 1825.5344887053716, 1856.378113332022, 790.3479629305846, 856.1652388920752, 857.6440777077443, 865.7143142762873, 884.4383816276711, 16383.508494745176, 16606.418775342805, 17054.0, 17104.914475427544, 17352.739708904377, 880.2623839858037, 904.2494729374604, 906.8507636900456, 919.1911118215927, 964.2671569607149, 9312.8603070954, 9444.0, 9529.094736000068, 9661.874387634709, 9680.322377433653, 390469.0, 394653.0, 406245.0, 413515.0, 417518.0, 73705.26294737091, 76227.23772762313, 77692.61153694196, 79930.60034699789, 81108.0, 936.6862101196176, 944.4239014201331, 958.8274110660149, 963.9036096390445, 976.4775844923074, 15095.32071056783, 15520.5343839685, 15776.921115394349, 15835.524934251991, 16040.839591603935, 33415.83292083524, 34286.82856585701, 34859.0, 34862.30275394427, 34890.47664285089, 48390.516094838604, 48445.0, 48752.75623621859, 48768.2684759736, 48849.267260990404, 6966.442684585119, 7203.963980180066, 7226.819329516804, 7280.453965952469, 7481.850362992818, 9922.950385248028, 10590.8940910593, 10795.460226988462, 10884.238103332691, 10910.890891090987, 9481.478518681539, 9505.857412138961, 9697.466639334903, 9735.951320243354, 9790.706278811647, 9520.333576649567, 9610.231181505602, 9693.6122555097, 9762.267829912644, 9849.212063034796, 9670.052525493467, 9698.70903872885, 9737.367071140354, 9967.302288839712, 10135.290529662852, 7201.13586369639, 7210.242924492853, 7248.586525627663, 7309.671064801991, 7477.327040566375, 7524.736634217776, 8450.90131286338, 8734.475931444134, 9279.304052196247, 10003.29976901639], "value": 7842.166840209997, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.6007047709493, 1280.5838102616651, 1300.8178854960306, 1354.2416246901735, 1682.8906121102127, 7569.65936532856, 7903.802404939879, 7907.565083920389, 7908.011498562687, 7920.722774702886, 7668.309852113309, 7838.960805195966, 7842.098158711749, 7842.960785196066, 7850.0, 1864.683003889342, 2196.8572042817245, 2242.069541140425, 2264.841461097724, 2273.874936878471, 2215.512587230815, 2236.317923033474, 2244.652078927769, 2244.674522194281, 2253.0987604957986, 2169.305822136917, 2231.152162178378, 2231.7098777158944, 2232.1071571371417, 2232.553489302138, 1883.5197024758668, 2155.7628660847295, 2216.5345277491747, 2224.254874617005, 2226.7439244486927, 2169.240765731997, 2177.2488491470417, 2182.1925887421758, 2188.3325585696357, 2210.3921421609025, 7805.843883122363, 7945.0, 7952.687806511919, 7957.7612671619945, 7962.163972782832, 4505.36924830524, 4647.930281045753, 4649.814007439699, 4655.883602909955, 4669.579737823612, 2990.7009299070137, 3006.9849650751826, 3069.3118784668345, 3069.769767267464, 3074.6156730408698, 1007.1791489935679, 1016.872890888639, 1032.8708911386077, 1039.4231201683062, 1045.7803861189159, 10838.0, 10850.348979061282, 10854.67435976922, 10858.674239772741, 10874.401907895062, 4137.2552940471005, 4471.8434854779925, 4480.305552639346, 4482.798274077609, 4482.843100491467, 9345.90654093464, 9383.906160938439, 9385.15533601979, 9389.859152112724, 9390.342676012613, 4161.979190104091, 4820.25286080658, 4840.080384726891, 4854.296127061556, 4864.416270047617, 3594.6225646307284, 3908.081600823804, 3916.1580260244186, 4294.487724681097, 4350.434443522322, 3701.1857391373856, 3725.869594564177, 3761.0785357587565, 3797.715171362159, 3857.9614203858164, 1186.7033241689578, 1240.342618412243, 1242.521629172775, 1245.725940293134, 1254.5358217459598, 696.7665831946355, 783.060327606874, 807.5800583696445, 809.0776514773163, 815.9347252219808, 5108.037338343752, 5168.793248270103, 5247.396549396792, 5367.1680889462195, 5441.5102640762525, 415.90850012997095, 416.96455801257235, 421.4542167892586, 422.01038564566045, 430.6253559403339, 3525.9118522037156, 3571.428571428559, 3571.9080174021133, 3590.24604832988, 3658.926821463556, 9317.0, 9525.19035881944, 9642.276829237835, 9682.322237443312, 9693.079157480028, 9526.666566670134, 9712.951435242778, 9861.556229969668, 9905.158061564704, 9959.402435853872, 7358.264173582599, 7438.628068596657, 7460.328570428579, 7492.438067145095, 7506.737264195727, 4994.850154495371, 5180.792768289377, 5220.973895130652, 5245.108331583564, 5280.155175171954, 8695.521746304014, 9000.234980026771, 9012.954935225282, 9100.726978190665, 9196.310276729138, 8989.0, 9246.260299175916, 9374.859377109486, 9437.764055898657, 9457.290703197425, 6273.1844860167885, 6476.0, 6483.805485835433, 6488.870222595616, 6812.795616131524, 7520.586367749826, 7573.46985710995, 7578.583177925267, 7582.090149181913, 7593.278638529331, 6792.72829086831, 6827.419669328163, 6947.340002699735, 7071.292870712888, 7081.610511421921, 6569.4744420445295, 6720.966395167993, 6752.054712340375, 6852.074969879002, 6886.793396198122, 6274.592151510137, 6297.811065668037, 6302.369763023661, 6314.778982735582, 6319.96840015797, 4565.292379681155, 4599.908001840012, 4660.836870709509, 4702.200625893538, 4708.658032460732, 4568.200564901195, 4603.930941035954, 4659.5573420525, 4669.976650116863, 4671.789769460314], "value": 4098.842824629916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.991030269092, 312.8717225937366, 318.3966383702883, 319.9728023118035, 326.5167552023007, 4863.197572400554, 4866.0, 4956.2317840734695, 4963.627727920411, 4992.825251116207, 4907.852764417074, 4915.090708218982, 4918.606511479082, 4941.629377796662, 4953.306537084811, 3903.434002069698, 3913.628205320504, 3916.7454115482547, 3924.0778417071965, 3924.5682974872884, 3885.825137868803, 3895.5130608673917, 3904.902377440558, 3918.4122381642837, 3934.5081864766903, 3792.791396473193, 3877.263319969211, 3883.4757307763516, 3896.649301562859, 3902.414637804338, 3858.459815625815, 3875.0506125999027, 3889.124946886956, 3899.9220015599813, 3901.590333015035, 3452.5671846183805, 3454.378211921853, 3463.8787642432394, 3464.064702530303, 3479.2693534357813, 4566.680332376735, 4730.337752714623, 4755.524447555252, 4769.117713223065, 4777.665563410563, 4428.911421771579, 4458.149867804889, 4470.798814053375, 4486.1027794440915, 4491.124230775, 5174.922376164361, 5183.326167598226, 5193.324867767204, 5200.92198617021, 5208.453112423217, 3783.4324851272254, 3785.6592906638534, 3786.3941769317053, 3792.260509200707, 3807.695384369244, 5095.388553373582, 5243.501867322599, 5267.130923397634, 5397.109476936301, 5462.262594549725, 3907.8632247871187, 3908.90227744303, 3916.4712763777097, 3923.92152156961, 3925.941110883339, 3948.782816945038, 3967.2263908538134, 3974.900627484336, 3982.9203415932097, 3983.9203215935518, 4200.537940826506, 4205.936910946277, 4324.783760811947, 4333.349997500337, 4339.956600434019, 5189.221616757516, 5192.324997750344, 5196.896062078813, 5227.215917612389, 5233.136532472099, 1353.35715535122, 1375.7317323122095, 1380.0546625561321, 1384.1625816381145, 1388.2850332078988, 948.5020364308793, 958.8705524754068, 966.9468179250209, 970.6942313171328, 971.8590804333332, 4581.404417425713, 4619.145458090197, 4620.214563524209, 4627.768611569408, 4630.3748993886065, 5417.702026388508, 5419.512243897989, 5420.0, 5425.755840987165, 5430.91853622196, 4497.460304763384, 4619.607333376701, 4620.48842879414, 4621.95378046222, 4631.490536041033, 2871.425714857037, 2884.5288902659377, 2886.2495751104866, 2887.6967918368687, 2894.348771526432, 5111.233315002779, 5112.795488180431, 5115.769790359443, 5120.820771272987, 5126.949465068278, 5360.973195133999, 5519.69641669704, 5525.336959564878, 5525.392206857243, 5527.226188333637, 5071.391433027987, 5083.466236045162, 5092.2361645753435, 5099.745012749348, 5102.0, 5378.085725426765, 5378.273933019149, 5384.084705600136, 5390.355941437899, 5394.271773310553, 5084.542391184811, 5338.2526446298325, 5339.279197308314, 5340.519353258225, 5356.330458692663, 4920.065187614342, 4956.513046086087, 5105.897882042264, 5116.258142569381, 5137.255098010843, 3712.9071773205887, 3771.6982641388076, 3772.019689662839, 3772.1512659651357, 3799.7340186187807, 5396.460353964572, 5406.594505412031, 5422.783088676409, 5429.511343979061, 5434.483724046209, 5006.224035274538, 5201.609879258995, 5274.525292723673, 5278.81524146653, 5293.0, 5226.738663066907, 5230.921536177037, 5233.450487698737, 5249.081410753027, 5263.921041184309, 5180.404253510744, 5196.792128314825, 5196.922046169386, 5197.558207552401, 5211.322528071327, 5010.974945125251, 5314.760835762478, 5317.308749862493, 5319.122344813062, 5332.33345831771, 5176.637635365489, 5184.611154163377, 5203.5576975957465, 5205.609579281493, 5213.504717051874], "value": 3961.771807769728, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.18663164098, 764.1785081037879, 781.7498400511835, 784.4430454377392, 790.1703211627793, 11276.774464510705, 11498.137639677037, 11540.365279909602, 11595.710107247323, 11616.825747613771, 11998.160128790967, 12019.158658893859, 12026.699332516691, 12035.0, 12088.516459341616, 639.3031595560838, 762.3938968520013, 793.5119901260712, 804.7947773317795, 806.7902345390212, 809.9676012959475, 815.5840521334103, 816.1389733830836, 816.338765599863, 817.0603805623521, 844.1980118887051, 852.4885068958606, 852.8336974290016, 853.0701535326493, 853.5305581929945, 676.5196710335692, 826.6817275348974, 842.4987132656059, 845.4124383553433, 857.9699710510165, 619.1517620859452, 622.390057743414, 624.597134848025, 624.9562530622858, 625.383996763188, 11490.253133546294, 11548.0, 11550.94224528872, 11573.36346500942, 11581.131415143813, 12070.879291207064, 12274.324912129829, 12521.311327876963, 12640.115191936567, 12713.745725085539, 10016.549255283457, 10037.146842518394, 10148.441835699034, 10156.035176658206, 10516.421596812172, 3369.561956945581, 3393.2874096439778, 3394.8132852693093, 3429.4855771634207, 3469.5142680024815, 44937.55062449366, 45002.0, 45065.77467112676, 45410.54589454129, 45550.77224613889, 9596.808063838684, 9997.400155990665, 9999.50002499872, 10041.146502547219, 10057.29598928068, 17071.402500912656, 17120.486385408458, 17151.485455436356, 17173.0, 17389.65220695604, 6669.966650166718, 6716.966415167893, 6785.423239024738, 6818.965905170541, 6878.449724022066, 3519.348920449725, 3535.222251104753, 3554.3424466473784, 3568.91077723059, 3571.8392672329805, 2687.6237326774267, 2730.808843380984, 2743.931401714973, 2748.848813315287, 2756.476269508787, 477.362720767772, 506.7364970215541, 516.9302144210559, 523.9685618862804, 532.82150479589, 575.9452851979055, 648.2415573778596, 654.5385503220218, 657.641585335993, 661.2527843536773, 7930.889675445443, 7970.115801270078, 8356.665733370719, 8473.449225800303, 8533.743987680255, 593.5014587746314, 605.8243109498196, 623.9376062393815, 637.6046850952347, 639.9488040956712, 3852.614738526125, 3885.941710874339, 3929.214157168578, 3937.1928754605237, 4070.4504891839224, 45734.313985290246, 46556.76721616438, 47010.05979880452, 47305.0, 47375.0, 41070.0, 41139.38290925638, 41216.58783412188, 41401.378979315334, 42411.57588424138, 31854.840725796686, 32408.189795254835, 38246.23507529834, 38640.6135938637, 38743.80628096841, 7998.240167184108, 8322.45904016237, 8445.408821382443, 8460.661573537236, 8486.575671216538, 26710.0, 26987.0, 27259.0, 27902.581461278503, 28085.859570702014, 33132.0, 34234.82882585571, 35653.82173089222, 35884.641153589175, 35940.0, 11129.666110016713, 11245.71885702864, 11304.378259195822, 11390.430478476208, 11405.087592992706, 11531.1928165031, 11534.538618455503, 11824.46789894474, 12136.696582585506, 12316.384180790745, 11334.659960201207, 11369.354854750549, 11437.0, 11479.598214062467, 12055.397230138633, 11075.390853503135, 11259.155563332946, 11569.6529104127, 11593.88406115928, 11634.476448560004, 10782.73043173927, 10982.725431864268, 11584.073274138218, 11598.362090085126, 11612.419379031184, 9502.572384242863, 9634.566444509874, 9756.853647195156, 10316.948415257875, 10434.68695939123, 9765.462899540593, 9812.509374531388, 9908.455034973145, 9928.0, 9938.850917236103], "value": 5886.337780775628, "unit": "score"}], "name": "dromaeo_css", "value": 6225.45626185523, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 107.0, 113.0, 113.0, 115.0, 104.0, 114.0, 114.0, 115.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 160.0, 203.0, 131.0, 158.0, 163.0, 137.0, 182.0, 139.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 159.0, 161.0, 160.0, 159.0, 162.0, 159.0, 164.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 102.0, 111.0, 75.0, 74.0, 73.0, 113.0, 103.0, 73.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 150.0, 94.0, 93.0, 93.0, 150.0, 93.0, 93.0, 142.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 123.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 66.0, 66.0, 65.0, 80.0, 62.0, 62.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 63.0, 64.0, 65.0, 64.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 78.0, 79.0, 78.0, 80.0, 78.0, 88.0, 80.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 132.0, 141.0, 134.0, 141.0, 134.0, 131.0, 130.0, 167.0, 137.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 186.0, 172.0, 171.0, 173.0, 174.0, 171.0, 171.0, 178.0, 172.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 73.0, 74.0, 73.0, 72.0, 72.0, 72.0, 71.0, 70.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1579.1000000000001, "alertThreshold": 2.0}]} 17:33:52 INFO - Return code: 0 17:33:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:33:52 ERROR - # TBPL SUCCESS # 17:33:52 INFO - Running post-action listener: _resource_record_post_action 17:33:52 INFO - Running post-run listener: _resource_record_post_run 17:33:53 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 425746432; Read time: 0; Write time: 215836 17:33:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 143183872; Read time: 0; Write time: 78540 17:33:53 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 282562560; Read time: 0; Write time: 137296 17:33:53 INFO - Running post-run listener: _upload_blobber_files 17:33:53 INFO - Blob upload gear active. 17:33:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:33:53 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 17:33:53 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'] 17:33:53 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 17:33:53 INFO - (blobuploader) - INFO - Open directory for files ... 17:33:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:33:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:33:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:54 INFO - (blobuploader) - INFO - Done attempting. 17:33:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:33:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:33:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:55 INFO - (blobuploader) - INFO - Done attempting. 17:33:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:33:55 INFO - Return code: 0 17:33:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:33:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:33:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/634f9fb4ff9399fb6d6b21fbc7d00e6516f6a60f1d0f4719899a6c2661d3c38e3746d372661ba69b9cc39e6818123fd359c9dcbcb31761214312b231b6a5925b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/323dba897320ab47563410694716390c4b2323acd9cc2231f65f557c2cc56c64d69ad73fe53796ce3250a3f2381c41249cff449e3bf97f66c672b1a3b33f8826"} 17:33:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:33:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:33:55 INFO - Contents: 17:33:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/634f9fb4ff9399fb6d6b21fbc7d00e6516f6a60f1d0f4719899a6c2661d3c38e3746d372661ba69b9cc39e6818123fd359c9dcbcb31761214312b231b6a5925b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/323dba897320ab47563410694716390c4b2323acd9cc2231f65f557c2cc56c64d69ad73fe53796ce3250a3f2381c41249cff449e3bf97f66c672b1a3b33f8826"} 17:33:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:33:55 INFO - Copying logs to upload dir... 17:33:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:33:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.852080 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-15 17:33:54.978541) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 17:33:54.982431) ========= 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=aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852 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/634f9fb4ff9399fb6d6b21fbc7d00e6516f6a60f1d0f4719899a6c2661d3c38e3746d372661ba69b9cc39e6818123fd359c9dcbcb31761214312b231b6a5925b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/323dba897320ab47563410694716390c4b2323acd9cc2231f65f557c2cc56c64d69ad73fe53796ce3250a3f2381c41249cff449e3bf97f66c672b1a3b33f8826"} build_url:https://queue.taskcluster.net/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/e6bqZlQ5RPyLqAUQsyVnbw/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/634f9fb4ff9399fb6d6b21fbc7d00e6516f6a60f1d0f4719899a6c2661d3c38e3746d372661ba69b9cc39e6818123fd359c9dcbcb31761214312b231b6a5925b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/323dba897320ab47563410694716390c4b2323acd9cc2231f65f557c2cc56c64d69ad73fe53796ce3250a3f2381c41249cff449e3bf97f66c672b1a3b33f8826"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 17:33:55.006778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:33:55.007082) ========= 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=aa08bb06ff6271ef470a76a4000001be-1460765234.113602-336778852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:33:55.093354) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 17:33:55.093698) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 17:33:55.094020) ========= ========= Total master_lag: 1.03 =========