builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1460786413.38 results: success (0) buildid: 20160415203232 builduid: ece4ea982f834601a2f3f20559df4529 revision: 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.388669) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.389259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.389567) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.441489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.441790) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 23:00:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.6M=0s 2016-04-15 23:00:13 (59.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173148 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.659406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.659726) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014948 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.708571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.708882) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 --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 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 --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=fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 23:00:13,844 truncating revision to first 12 chars 2016-04-15 23:00:13,844 Setting DEBUG logging. 2016-04-15 23:00:13,844 attempt 1/10 2016-04-15 23:00:13,844 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/42a0a7f409d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 23:00:14,118 unpacking tar archive at: fx-team-42a0a7f409d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554317 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:14.276352) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:14.276670) ========= script_repo_revision: 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:14.277111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:14.277386) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:14.286517) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-15 23:00:14.286803) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:00:14 INFO - MultiFileLogger online at 20160415 23:00:14 in /builds/slave/test 23:00:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:00:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:00:14 INFO - {'append_to_log': False, 23:00:14 INFO - 'base_work_dir': '/builds/slave/test', 23:00:14 INFO - 'blob_upload_branch': 'Fx-Team', 23:00:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:00:14 INFO - 'branch': 'Fx-Team', 23:00:14 INFO - 'buildbot_json_path': 'buildprops.json', 23:00:14 INFO - 'config_files': ('talos/linux_config.py',), 23:00:14 INFO - 'default_actions': ('clobber', 23:00:14 INFO - 'read-buildbot-config', 23:00:14 INFO - 'download-and-extract', 23:00:14 INFO - 'populate-webroot', 23:00:14 INFO - 'create-virtualenv', 23:00:14 INFO - 'install', 23:00:14 INFO - 'run-tests'), 23:00:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:00:14 INFO - 'download_minidump_stackwalk': True, 23:00:14 INFO - 'download_symbols': 'ondemand', 23:00:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:00:14 INFO - 'tooltool.py': '/tools/tooltool.py', 23:00:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:00:14 INFO - '/tools/misc-python/virtualenv.py')}, 23:00:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:00:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:00:14 INFO - 'installer_path': 'installer.exe', 23:00:14 INFO - 'log_level': 'info', 23:00:14 INFO - 'log_name': 'talos', 23:00:14 INFO - 'log_to_console': True, 23:00:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:00:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:00:14 INFO - 'opt_config_files': (), 23:00:14 INFO - 'pip_index': False, 23:00:14 INFO - 'sps_profile': False, 23:00:14 INFO - 'sps_profile_interval': 0, 23:00:14 INFO - 'suite': 'dromaeojs-e10s', 23:00:14 INFO - 'system_bits': '32', 23:00:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:00:14 INFO - 'title': 'talos-linux64-ix-014', 23:00:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:00:14 INFO - 'use_talos_json': True, 23:00:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:00:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:00:14 INFO - 'work_dir': 'build'} 23:00:14 INFO - ##### 23:00:14 INFO - ##### Running clobber step. 23:00:14 INFO - ##### 23:00:14 INFO - Running pre-action listener: _resource_record_pre_action 23:00:14 INFO - Running main action method: clobber 23:00:14 INFO - rmtree: /builds/slave/test/build 23:00:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:00:15 INFO - Running post-action listener: _resource_record_post_action 23:00:15 INFO - ##### 23:00:15 INFO - ##### Running read-buildbot-config step. 23:00:15 INFO - ##### 23:00:15 INFO - Running pre-action listener: _resource_record_pre_action 23:00:15 INFO - Running main action method: read_buildbot_config 23:00:15 INFO - Using buildbot properties: 23:00:15 INFO - { 23:00:15 INFO - "project": "", 23:00:15 INFO - "product": "firefox", 23:00:15 INFO - "script_repo_revision": "production", 23:00:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:00:15 INFO - "repository": "", 23:00:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:00:15 INFO - "buildid": "20160415203232", 23:00:15 INFO - "pgo_build": "True", 23:00:15 INFO - "basedir": "/builds/slave/test", 23:00:15 INFO - "buildnumber": 282, 23:00:15 INFO - "slavename": "talos-linux64-ix-014", 23:00:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:00:15 INFO - "platform": "ubuntu64_hw", 23:00:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:00:15 INFO - "branch": "fx-team", 23:00:15 INFO - "repo_path": "integration/fx-team", 23:00:15 INFO - "revision": "42a0a7f409d1b9a40770e36a66af6ccf67539cc4", 23:00:15 INFO - "stage_platform": "linux64-pgo", 23:00:15 INFO - "builduid": "ece4ea982f834601a2f3f20559df4529", 23:00:15 INFO - "slavebuilddir": "test" 23:00:15 INFO - } 23:00:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 23:00:15 INFO - Running post-action listener: _resource_record_post_action 23:00:15 INFO - ##### 23:00:15 INFO - ##### Running download-and-extract step. 23:00:15 INFO - ##### 23:00:15 INFO - Running pre-action listener: _resource_record_pre_action 23:00:15 INFO - Running main action method: download_and_extract 23:00:15 INFO - mkdir: /builds/slave/test/build/tests 23:00: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')]} 23:00:15 INFO - https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:00:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:00:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:00:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/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 23:00:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/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 23:00:20 INFO - Downloaded 1361 bytes. 23:00:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:00:20 INFO - Using the following test package requirements: 23:00:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:00:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:00:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:20 INFO - u'jsshell-linux-x86_64.zip'], 23:00:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:00:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:00:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:00:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:00:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:00:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:00:20 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')]} 23:00:20 INFO - https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/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 23:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/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 23:00:21 INFO - Downloaded 23775043 bytes. 23:00: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'] 23:00: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 23:00:22 INFO - Return code: 0 23:00:22 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 23:00:22 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')]} 23:00:22 INFO - https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/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 23:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/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 23:00:36 INFO - Downloaded 23775043 bytes. 23:00:36 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'] 23:00:36 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 23:00:38 INFO - Return code: 0 23:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:38 INFO - https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/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 23:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/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 23:00:41 INFO - Downloaded 10841076 bytes. 23:00:41 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'] 23:00:41 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 23:00:41 INFO - Return code: 0 23:00:41 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')]} 23:00:41 INFO - https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:00:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:00:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:00:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/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 23:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/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 23:00:43 INFO - Downloaded 58224720 bytes. 23:00:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:00:43 INFO - mkdir: /builds/slave/test/properties 23:00:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:00:43 INFO - Writing to file /builds/slave/test/properties/build_url 23:00:43 INFO - Contents: 23:00:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:00:43 INFO - Running post-action listener: _resource_record_post_action 23:00:43 INFO - Running post-action listener: set_extra_try_arguments 23:00:43 INFO - ##### 23:00:43 INFO - ##### Running populate-webroot step. 23:00:43 INFO - ##### 23:00:43 INFO - Running pre-action listener: _resource_record_pre_action 23:00:43 INFO - Running main action method: populate_webroot 23:00:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:00:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:00:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:00:43 INFO - '--tppagecycles', 23:00:43 INFO - '7'], 23:00:43 INFO - 'tests': ['tsvgm']}}, 23:00:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:00:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:00:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:00:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:00:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:00:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:00:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:43 INFO - 'talos_options': ['--disable-e10s'], 23:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:43 INFO - 'talos_options': ['--disable-e10s'], 23:00:43 INFO - 'tests': ['damp', 'tps']}, 23:00:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:43 INFO - 'tests': ['damp', 'tps']}, 23:00:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:00:43 INFO - 'tests': ['dromaeo_dom']}, 23:00:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:00:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:00:43 INFO - 'tests': ['a11yr', 23:00:43 INFO - 'ts_paint', 23:00:43 INFO - 'tpaint', 23:00:43 INFO - 'sessionrestore', 23:00:43 INFO - 'sessionrestore_no_auto_restore', 23:00:43 INFO - 'tabpaint']}, 23:00:43 INFO - 'other-e10s': {'tests': ['a11yr', 23:00:43 INFO - 'ts_paint', 23:00:43 INFO - 'tpaint', 23:00:43 INFO - 'sessionrestore', 23:00:43 INFO - 'sessionrestore_no_auto_restore', 23:00:43 INFO - 'tabpaint']}, 23:00:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:00:43 INFO - 'ts_paint', 23:00:43 INFO - 'tpaint', 23:00:43 INFO - 'sessionrestore', 23:00:43 INFO - 'sessionrestore_no_auto_restore', 23:00:43 INFO - 'tabpaint']}, 23:00:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:00:43 INFO - 'ts_paint', 23:00:43 INFO - 'tpaint', 23:00:43 INFO - 'sessionrestore', 23:00:43 INFO - 'sessionrestore_no_auto_restore', 23:00:43 INFO - 'tabpaint']}, 23:00:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:00:43 INFO - 'tests': ['a11yr', 23:00:43 INFO - 'ts_paint', 23:00:43 INFO - 'tpaint', 23:00:43 INFO - 'sessionrestore', 23:00:43 INFO - 'sessionrestore_no_auto_restore', 23:00:43 INFO - 'tabpaint']}, 23:00:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:00:43 INFO - 'tests': ['a11yr', 23:00:43 INFO - 'ts_paint', 23:00:43 INFO - 'tpaint', 23:00:43 INFO - 'sessionrestore', 23:00:43 INFO - 'sessionrestore_no_auto_restore', 23:00:43 INFO - 'tabpaint']}, 23:00:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:00:43 INFO - 'tests': ['tsvgx', 23:00:43 INFO - 'tsvgr_opacity', 23:00:43 INFO - 'tart', 23:00:43 INFO - 'tscrollx', 23:00:43 INFO - 'cart']}, 23:00:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:00:43 INFO - 'tsvgr_opacity', 23:00:43 INFO - 'tart', 23:00:43 INFO - 'tscrollx', 23:00:43 INFO - 'cart']}, 23:00:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:43 INFO - 'talos_options': ['--disable-e10s'], 23:00:43 INFO - 'tests': ['tp5o']}, 23:00:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:43 INFO - 'tests': ['tp5o']}, 23:00:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:43 INFO - 'talos_options': ['--disable-e10s', 23:00:43 INFO - '--xperf_path', 23:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:43 INFO - 'tests': ['tp5n']}, 23:00:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:43 INFO - 'talos_options': ['--xperf_path', 23:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:43 INFO - 'tests': ['tp5n']}}, 23:00:43 INFO - 'talos.zip': {'path': '', 23:00:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:00:43 INFO - Running post-action listener: _resource_record_post_action 23:00:43 INFO - ##### 23:00:43 INFO - ##### Running create-virtualenv step. 23:00:43 INFO - ##### 23:00:43 INFO - Running pre-action listener: _resource_record_pre_action 23:00:43 INFO - Running main action method: create_virtualenv 23:00:43 INFO - Creating virtualenv /builds/slave/test/build/venv 23:00:43 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 23:00:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:00:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:00:44 INFO - Using real prefix '/usr' 23:00:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:00:44 INFO - Installing distribute.............................................................................................................................................................................................done. 23:00:47 INFO - Installing pip.................done. 23:00:47 INFO - Return code: 0 23:00:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:00: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')]} 23:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e6e74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d410>, '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 0x250e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', '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 23:00: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', 'pip>=1.5'] in /builds/slave/test/build 23:00: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 pip>=1.5 23:00:47 INFO - Using env: {'DISPLAY': ':0', 23:00:47 INFO - 'HOME': '/home/cltbld', 23:00:47 INFO - 'LANG': 'en_US.UTF-8', 23:00:47 INFO - 'LANGUAGE': 'en_US:en', 23:00:47 INFO - 'LOGNAME': 'cltbld', 23:00:47 INFO - 'MAIL': '/var/mail/cltbld', 23:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:47 INFO - 'MOZ_NO_REMOTE': '1', 23:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:47 INFO - 'NO_EM_RESTART': '1', 23:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:47 INFO - 'PWD': '/builds/slave/test', 23:00:47 INFO - 'SHELL': '/bin/bash', 23:00:47 INFO - 'SHLVL': '1', 23:00:47 INFO - 'TERM': 'linux', 23:00:47 INFO - 'TMOUT': '86400', 23:00:47 INFO - 'USER': 'cltbld', 23:00:47 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', 23:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:47 INFO - '_': '/tools/buildbot/bin/python'} 23:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:47 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 23:00:47 INFO - Cleaning up... 23:00:47 INFO - Return code: 0 23:00:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:00: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')]} 23:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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', '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 0x7f1e6e74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d410>, '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 0x250e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', '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 23:00: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', 'psutil>=0.7.1'] in /builds/slave/test/build 23:00: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 psutil>=0.7.1 23:00:47 INFO - Using env: {'DISPLAY': ':0', 23:00:47 INFO - 'HOME': '/home/cltbld', 23:00:47 INFO - 'LANG': 'en_US.UTF-8', 23:00:47 INFO - 'LANGUAGE': 'en_US:en', 23:00:47 INFO - 'LOGNAME': 'cltbld', 23:00:47 INFO - 'MAIL': '/var/mail/cltbld', 23:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:47 INFO - 'MOZ_NO_REMOTE': '1', 23:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:47 INFO - 'NO_EM_RESTART': '1', 23:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:47 INFO - 'PWD': '/builds/slave/test', 23:00:47 INFO - 'SHELL': '/bin/bash', 23:00:47 INFO - 'SHLVL': '1', 23:00:47 INFO - 'TERM': 'linux', 23:00:47 INFO - 'TMOUT': '86400', 23:00:47 INFO - 'USER': 'cltbld', 23:00:47 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', 23:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:47 INFO - '_': '/tools/buildbot/bin/python'} 23:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:48 INFO - Downloading/unpacking psutil>=0.7.1 23:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:00:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:50 INFO - Installing collected packages: psutil 23:00:50 INFO - Running setup.py install for psutil 23:00:50 INFO - building 'psutil._psutil_linux' extension 23:00:50 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 23:00:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:00:53 INFO - building 'psutil._psutil_posix' extension 23:00:53 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 23:00:53 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 23:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:53 INFO - Successfully installed psutil 23:00:53 INFO - Cleaning up... 23:00:53 INFO - Return code: 0 23:00:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:00:53 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')]} 23:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:53 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')]} 23:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:53 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 0x7f1e6e74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d410>, '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 0x250e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', '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 23:00:53 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 23:00:53 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 23:00:53 INFO - Using env: {'DISPLAY': ':0', 23:00:53 INFO - 'HOME': '/home/cltbld', 23:00:53 INFO - 'LANG': 'en_US.UTF-8', 23:00:53 INFO - 'LANGUAGE': 'en_US:en', 23:00:53 INFO - 'LOGNAME': 'cltbld', 23:00:53 INFO - 'MAIL': '/var/mail/cltbld', 23:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:53 INFO - 'MOZ_NO_REMOTE': '1', 23:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:53 INFO - 'NO_EM_RESTART': '1', 23:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:53 INFO - 'PWD': '/builds/slave/test', 23:00:53 INFO - 'SHELL': '/bin/bash', 23:00:53 INFO - 'SHLVL': '1', 23:00:53 INFO - 'TERM': 'linux', 23:00:53 INFO - 'TMOUT': '86400', 23:00:53 INFO - 'USER': 'cltbld', 23:00:53 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', 23:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:53 INFO - '_': '/tools/buildbot/bin/python'} 23:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:00:55 INFO - Installing collected packages: mozsystemmonitor 23:00:55 INFO - Running setup.py install for mozsystemmonitor 23:00:55 INFO - Successfully installed mozsystemmonitor 23:00:55 INFO - Cleaning up... 23:00:55 INFO - Return code: 0 23:00:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:55 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 0x7f1e6e74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d410>, '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 0x250e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', '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 23:00:55 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 23:00:55 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 23:00:55 INFO - Using env: {'DISPLAY': ':0', 23:00:55 INFO - 'HOME': '/home/cltbld', 23:00:55 INFO - 'LANG': 'en_US.UTF-8', 23:00:55 INFO - 'LANGUAGE': 'en_US:en', 23:00:55 INFO - 'LOGNAME': 'cltbld', 23:00:55 INFO - 'MAIL': '/var/mail/cltbld', 23:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:55 INFO - 'MOZ_NO_REMOTE': '1', 23:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:55 INFO - 'NO_EM_RESTART': '1', 23:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:55 INFO - 'PWD': '/builds/slave/test', 23:00:55 INFO - 'SHELL': '/bin/bash', 23:00:55 INFO - 'SHLVL': '1', 23:00:55 INFO - 'TERM': 'linux', 23:00:55 INFO - 'TMOUT': '86400', 23:00:55 INFO - 'USER': 'cltbld', 23:00:55 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', 23:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:55 INFO - '_': '/tools/buildbot/bin/python'} 23:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:56 INFO - Downloading/unpacking blobuploader==1.2.4 23:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:58 INFO - Downloading blobuploader-1.2.4.tar.gz 23:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:00:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:00:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:58 INFO - Downloading docopt-0.6.1.tar.gz 23:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:00:58 INFO - Installing collected packages: blobuploader, requests, docopt 23:00:58 INFO - Running setup.py install for blobuploader 23:00:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:00:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:00:58 INFO - Running setup.py install for requests 23:00:59 INFO - Running setup.py install for docopt 23:00:59 INFO - Successfully installed blobuploader requests docopt 23:00:59 INFO - Cleaning up... 23:00:59 INFO - Return code: 0 23:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:00:59 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')]} 23:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:59 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')]} 23:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:59 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 0x7f1e6e74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d410>, '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 0x250e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', '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 23:00:59 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 23:00:59 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 23:00:59 INFO - Using env: {'DISPLAY': ':0', 23:00:59 INFO - 'HOME': '/home/cltbld', 23:00:59 INFO - 'LANG': 'en_US.UTF-8', 23:00:59 INFO - 'LANGUAGE': 'en_US:en', 23:00:59 INFO - 'LOGNAME': 'cltbld', 23:00:59 INFO - 'MAIL': '/var/mail/cltbld', 23:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:59 INFO - 'MOZ_NO_REMOTE': '1', 23:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:59 INFO - 'NO_EM_RESTART': '1', 23:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:59 INFO - 'PWD': '/builds/slave/test', 23:00:59 INFO - 'SHELL': '/bin/bash', 23:00:59 INFO - 'SHLVL': '1', 23:00:59 INFO - 'TERM': 'linux', 23:00:59 INFO - 'TMOUT': '86400', 23:00:59 INFO - 'USER': 'cltbld', 23:00:59 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', 23:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:59 INFO - '_': '/tools/buildbot/bin/python'} 23:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:00:59 INFO - Running setup.py (path:/tmp/pip-iBYBYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:00:59 INFO - Running setup.py (path:/tmp/pip-mpwWDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:00:59 INFO - Running setup.py (path:/tmp/pip-DBGtMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:00:59 INFO - Running setup.py (path:/tmp/pip-cSmp55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:00:59 INFO - Running setup.py (path:/tmp/pip-h6fCpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:00:59 INFO - Running setup.py (path:/tmp/pip-sNshR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:00 INFO - Running setup.py (path:/tmp/pip-FaXWm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:00 INFO - Running setup.py (path:/tmp/pip-sbUpgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:00 INFO - Running setup.py (path:/tmp/pip-fZDbOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:00 INFO - Running setup.py (path:/tmp/pip-6WF8RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:00 INFO - Running setup.py (path:/tmp/pip-G5DNZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:00 INFO - Running setup.py (path:/tmp/pip-G1IJmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:00 INFO - Running setup.py (path:/tmp/pip-wzMTRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:00 INFO - Running setup.py (path:/tmp/pip-AuP0Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:00 INFO - Running setup.py (path:/tmp/pip-XgzWi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:00 INFO - Running setup.py (path:/tmp/pip-aSs2OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:00 INFO - Running setup.py (path:/tmp/pip-MrCsjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:01:00 INFO - Running setup.py install for manifestparser 23:01:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:01:00 INFO - Running setup.py install for mozcrash 23:01:01 INFO - Running setup.py install for mozdebug 23:01:01 INFO - Running setup.py install for mozdevice 23:01:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Running setup.py install for mozfile 23:01:01 INFO - Running setup.py install for mozhttpd 23:01:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Running setup.py install for mozinfo 23:01:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Running setup.py install for mozInstall 23:01:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Running setup.py install for mozleak 23:01:01 INFO - Running setup.py install for mozlog 23:01:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Running setup.py install for moznetwork 23:01:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Running setup.py install for mozprocess 23:01:02 INFO - Running setup.py install for mozprofile 23:01:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:01:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:01:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:01:02 INFO - Running setup.py install for mozrunner 23:01:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:01:02 INFO - Running setup.py install for mozscreenshot 23:01:02 INFO - Running setup.py install for moztest 23:01:02 INFO - Running setup.py install for mozversion 23:01:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:01:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:01:02 INFO - Cleaning up... 23:01:02 INFO - Return code: 0 23:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:02 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 0x7f1e6e74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d410>, '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 0x250e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', '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 23:01:02 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 23:01:02 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 23:01:02 INFO - Using env: {'DISPLAY': ':0', 23:01:02 INFO - 'HOME': '/home/cltbld', 23:01:02 INFO - 'LANG': 'en_US.UTF-8', 23:01:02 INFO - 'LANGUAGE': 'en_US:en', 23:01:02 INFO - 'LOGNAME': 'cltbld', 23:01:02 INFO - 'MAIL': '/var/mail/cltbld', 23:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:02 INFO - 'MOZ_NO_REMOTE': '1', 23:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:02 INFO - 'NO_EM_RESTART': '1', 23:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:02 INFO - 'PWD': '/builds/slave/test', 23:01:02 INFO - 'SHELL': '/bin/bash', 23:01:02 INFO - 'SHLVL': '1', 23:01:02 INFO - 'TERM': 'linux', 23:01:02 INFO - 'TMOUT': '86400', 23:01:02 INFO - 'USER': 'cltbld', 23:01:02 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', 23:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:02 INFO - '_': '/tools/buildbot/bin/python'} 23:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:02 INFO - Running setup.py (path:/tmp/pip-1Tjdc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:02 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)) 23:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:02 INFO - Running setup.py (path:/tmp/pip-mJuf4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:02 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)) 23:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:02 INFO - Running setup.py (path:/tmp/pip-Je7xnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:03 INFO - Running setup.py (path:/tmp/pip-aA6yBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:03 INFO - Running setup.py (path:/tmp/pip-UuCCtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:03 INFO - Running setup.py (path:/tmp/pip-qF8hfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:03 INFO - Running setup.py (path:/tmp/pip-_POk5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:03 INFO - Running setup.py (path:/tmp/pip-YtfuvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:03 INFO - Running setup.py (path:/tmp/pip-ex_fkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:03 INFO - Running setup.py (path:/tmp/pip-e0MpdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:03 INFO - Running setup.py (path:/tmp/pip-OkMDxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:03 INFO - Running setup.py (path:/tmp/pip-7g9Bm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:03 INFO - Running setup.py (path:/tmp/pip-JNQTIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:03 INFO - Running setup.py (path:/tmp/pip-ZLwzc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:03 INFO - Running setup.py (path:/tmp/pip-apTUkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:03 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)) 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:03 INFO - Running setup.py (path:/tmp/pip-nAnoSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:04 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)) 23:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:04 INFO - Running setup.py (path:/tmp/pip-AZ6D1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:04 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)) 23:01:04 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)) 23:01:04 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)) 23:01:04 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)) 23:01:04 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)) 23:01:04 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)) 23:01:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:06 INFO - Downloading blessings-1.6.tar.gz 23:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:01:06 INFO - Installing collected packages: blessings 23:01:06 INFO - Running setup.py install for blessings 23:01:06 INFO - Successfully installed blessings 23:01:06 INFO - Cleaning up... 23:01:06 INFO - Return code: 0 23:01:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:06 INFO - Reading from file tmpfile_stdout 23:01:06 INFO - Current package versions: 23:01:06 INFO - argparse == 1.2.1 23:01:06 INFO - blessings == 1.6 23:01:06 INFO - blobuploader == 1.2.4 23:01:06 INFO - docopt == 0.6.1 23:01:06 INFO - manifestparser == 1.1 23:01:06 INFO - mozInstall == 1.12 23:01:06 INFO - mozcrash == 0.17 23:01:06 INFO - mozdebug == 0.1 23:01:06 INFO - mozdevice == 0.48 23:01:06 INFO - mozfile == 1.2 23:01:06 INFO - mozhttpd == 0.7 23:01:06 INFO - mozinfo == 0.9 23:01:06 INFO - mozleak == 0.1 23:01:06 INFO - mozlog == 3.1 23:01:06 INFO - moznetwork == 0.27 23:01:06 INFO - mozprocess == 0.22 23:01:06 INFO - mozprofile == 0.28 23:01:06 INFO - mozrunner == 6.11 23:01:06 INFO - mozscreenshot == 0.1 23:01:06 INFO - mozsystemmonitor == 0.0 23:01:06 INFO - moztest == 0.7 23:01:06 INFO - mozversion == 1.4 23:01:06 INFO - psutil == 3.1.1 23:01:06 INFO - requests == 1.2.3 23:01:06 INFO - wsgiref == 0.1.2 23:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:06 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 0x7f1e6e74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d410>, '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 0x250e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', '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 23:01:06 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 23:01:06 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 23:01:06 INFO - Using env: {'DISPLAY': ':0', 23:01:06 INFO - 'HOME': '/home/cltbld', 23:01:06 INFO - 'LANG': 'en_US.UTF-8', 23:01:06 INFO - 'LANGUAGE': 'en_US:en', 23:01:06 INFO - 'LOGNAME': 'cltbld', 23:01:06 INFO - 'MAIL': '/var/mail/cltbld', 23:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:06 INFO - 'MOZ_NO_REMOTE': '1', 23:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:06 INFO - 'NO_EM_RESTART': '1', 23:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:06 INFO - 'PWD': '/builds/slave/test', 23:01:06 INFO - 'SHELL': '/bin/bash', 23:01:06 INFO - 'SHLVL': '1', 23:01:06 INFO - 'TERM': 'linux', 23:01:06 INFO - 'TMOUT': '86400', 23:01:06 INFO - 'USER': 'cltbld', 23:01:06 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', 23:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:06 INFO - '_': '/tools/buildbot/bin/python'} 23:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:06 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)) 23:01:06 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)) 23:01:06 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)) 23:01:06 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)) 23:01:06 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)) 23:01:06 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)) 23:01:06 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)) 23:01:06 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)) 23:01:06 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)) 23:01:06 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)) 23:01:06 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)) 23:01:06 INFO - Cleaning up... 23:01:06 INFO - Return code: 0 23:01:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:06 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 0x7f1e6e74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d410>, '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 0x250e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', '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 23:01:06 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 23:01:06 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 23:01:06 INFO - Using env: {'DISPLAY': ':0', 23:01:06 INFO - 'HOME': '/home/cltbld', 23:01:06 INFO - 'LANG': 'en_US.UTF-8', 23:01:06 INFO - 'LANGUAGE': 'en_US:en', 23:01:06 INFO - 'LOGNAME': 'cltbld', 23:01:06 INFO - 'MAIL': '/var/mail/cltbld', 23:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:06 INFO - 'MOZ_NO_REMOTE': '1', 23:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:06 INFO - 'NO_EM_RESTART': '1', 23:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:06 INFO - 'PWD': '/builds/slave/test', 23:01:06 INFO - 'SHELL': '/bin/bash', 23:01:06 INFO - 'SHLVL': '1', 23:01:06 INFO - 'TERM': 'linux', 23:01:06 INFO - 'TMOUT': '86400', 23:01:06 INFO - 'USER': 'cltbld', 23:01:06 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', 23:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:06 INFO - '_': '/tools/buildbot/bin/python'} 23:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:07 INFO - Downloading/unpacking jsonschema 23:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:01:08 INFO - Downloading/unpacking functools32 (from jsonschema) 23:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:09 INFO - Downloading functools32-3.2.3-2.tar.gz 23:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:01:09 INFO - warning: no files found matching '*.txt' 23:01:09 INFO - no previously-included directories found matching 'build' 23:01:09 INFO - no previously-included directories found matching 'dist' 23:01:09 INFO - no previously-included directories found matching '.git*' 23:01:09 INFO - Installing collected packages: jsonschema, functools32 23:01:09 INFO - Running setup.py install for functools32 23:01:09 INFO - warning: no files found matching '*.txt' 23:01:09 INFO - no previously-included directories found matching 'build' 23:01:09 INFO - no previously-included directories found matching 'dist' 23:01:09 INFO - no previously-included directories found matching '.git*' 23:01:09 INFO - Successfully installed jsonschema functools32 23:01:09 INFO - Cleaning up... 23:01:09 INFO - Return code: 0 23:01:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:09 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 0x7f1e6e74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d410>, '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 0x250e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', '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 23:01:09 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 23:01:09 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 23:01:09 INFO - Using env: {'DISPLAY': ':0', 23:01:09 INFO - 'HOME': '/home/cltbld', 23:01:09 INFO - 'LANG': 'en_US.UTF-8', 23:01:09 INFO - 'LANGUAGE': 'en_US:en', 23:01:09 INFO - 'LOGNAME': 'cltbld', 23:01:09 INFO - 'MAIL': '/var/mail/cltbld', 23:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:09 INFO - 'MOZ_NO_REMOTE': '1', 23:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:09 INFO - 'NO_EM_RESTART': '1', 23:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:09 INFO - 'PWD': '/builds/slave/test', 23:01:09 INFO - 'SHELL': '/bin/bash', 23:01:09 INFO - 'SHLVL': '1', 23:01:09 INFO - 'TERM': 'linux', 23:01:09 INFO - 'TMOUT': '86400', 23:01:09 INFO - 'USER': 'cltbld', 23:01:09 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', 23:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:09 INFO - '_': '/tools/buildbot/bin/python'} 23:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:09 INFO - Downloading/unpacking flake8 23:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:01:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:01:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:01:12 INFO - no previously-included directories found matching 'docs/_build' 23:01:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:01:12 INFO - Running setup.py install for pep8 23:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:01:12 INFO - no previously-included directories found matching 'docs/_build' 23:01:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:01:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:01:12 INFO - Cleaning up... 23:01:12 INFO - Return code: 0 23:01:12 INFO - Running post-action listener: _resource_record_post_action 23:01:12 INFO - Running post-action listener: _start_resource_monitoring 23:01:12 INFO - Starting resource monitoring. 23:01:12 INFO - ##### 23:01:12 INFO - ##### Running install step. 23:01:12 INFO - ##### 23:01:12 INFO - Running pre-action listener: _resource_record_pre_action 23:01:12 INFO - Running main action method: install 23:01:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:12 INFO - Reading from file tmpfile_stdout 23:01:12 INFO - Detecting whether we're running mozinstall >=1.0... 23:01:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:01:12 INFO - Reading from file tmpfile_stdout 23:01:12 INFO - Output received: 23:01:12 INFO - Usage: mozinstall [options] installer 23:01:12 INFO - Options: 23:01:12 INFO - -h, --help show this help message and exit 23:01:12 INFO - -d DEST, --destination=DEST 23:01:12 INFO - Directory to install application into. [default: 23:01:12 INFO - "/builds/slave/test"] 23:01:12 INFO - --app=APP Application being installed. [default: firefox] 23:01:12 INFO - mkdir: /builds/slave/test/build/application 23:01:12 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'] 23:01:12 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 23:01:29 INFO - Reading from file tmpfile_stdout 23:01:29 INFO - Output received: 23:01:29 INFO - /builds/slave/test/build/application/firefox/firefox 23:01:29 INFO - Running post-action listener: _resource_record_post_action 23:01:29 INFO - ##### 23:01:29 INFO - ##### Running run-tests step. 23:01:29 INFO - ##### 23:01:29 INFO - Running pre-action listener: _resource_record_pre_action 23:01:29 INFO - Running main action method: run_tests 23:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:01:29 INFO - Python 2.7.3 23:01:29 INFO - Return code: 0 23:01:29 INFO - grabbing minidump binary from tooltool 23:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:29 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 0x250d410>, '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 0x250e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:01:29 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 23:01:29 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 23:01:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:01:29 INFO - Return code: 0 23:01:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:01:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:01:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:01:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:01:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:01:30 INFO - Return code: 0 23:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:01:30 INFO - Using env: {'DISPLAY': ':0', 23:01:30 INFO - 'HOME': '/home/cltbld', 23:01:30 INFO - 'LANG': 'en_US.UTF-8', 23:01:30 INFO - 'LANGUAGE': 'en_US:en', 23:01:30 INFO - 'LOGNAME': 'cltbld', 23:01:30 INFO - 'MAIL': '/var/mail/cltbld', 23:01:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:01:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:30 INFO - 'MOZ_NO_REMOTE': '1', 23:01:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:30 INFO - 'NO_EM_RESTART': '1', 23:01:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:30 INFO - 'PWD': '/builds/slave/test', 23:01:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:01:30 INFO - 'SHELL': '/bin/bash', 23:01:30 INFO - 'SHLVL': '1', 23:01:30 INFO - 'TERM': 'linux', 23:01:30 INFO - 'TMOUT': '86400', 23:01:30 INFO - 'USER': 'cltbld', 23:01:30 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682', 23:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:30 INFO - '_': '/tools/buildbot/bin/python'} 23:01:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:01:30 INFO - mozversion application_buildid: 20160415203232 23:01:30 INFO - mozversion application_changeset: 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 23:01:30 INFO - mozversion application_display_name: Nightly 23:01:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:01:30 INFO - mozversion application_name: Firefox 23:01:30 INFO - mozversion application_remotingname: firefox 23:01:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:01:30 INFO - mozversion application_vendor: Mozilla 23:01:30 INFO - mozversion application_version: 48.0a1 23:01:30 INFO - mozversion platform_buildid: 20160415203232 23:01:30 INFO - mozversion platform_changeset: 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 23:01:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:01:30 INFO - mozversion platform_version: 48.0a1 23:01:30 INFO - using testdate: 1460786490 23:01:30 INFO - actual date: 1460786490 23:01:30 INFO - starting webserver on 'localhost:39603' 23:01:30 INFO - SUITE-START | Running 2 tests 23:01:30 INFO - TEST-START | dromaeo_css 23:01:30 INFO - operating with platform_type : linux_ 23:01:30 INFO - Initialising browser for dromaeo_css test... 23:01:30 INFO - TEST-INFO | started process 3292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvp72O3/profile http://localhost:39603/getInfo.html) 23:01:36 INFO - PROCESS | 3292 | 23:01:36 INFO - PROCESS | 3292 | (process:3361): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:01:36 INFO - PROCESS | 3292 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 23:01:37 INFO - PROCESS | 3292 | __metrics Screen width/height:1600/1200 23:01:37 INFO - PROCESS | 3292 | colorDepth:24 23:01:37 INFO - PROCESS | 3292 | Browser inner width/height: 1024/697 23:01:37 INFO - PROCESS | 3292 | __metrics 23:01:37 ERROR - PROCESS | 3292 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 23:01:38 INFO - TEST-INFO | 3292: exit 0 23:01:38 INFO - Browser initialized. 23:01:38 INFO - Running cycle 1/1 for dromaeo_css test... 23:01:38 INFO - TEST-INFO | started process 3412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvp72O3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:40 INFO - PROCESS | 3412 | 23:01:40 INFO - PROCESS | 3412 | (process:3474): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:01:50 INFO - PROCESS | 3412 | RSS: Main: 163213312 23:01:50 INFO - PROCESS | 3412 | 23:02:40 INFO - PROCESS | 3412 | 1460786560016 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] 23:04:47 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39603/tests/dromaeo/cssquery-ext.html) 23:04:47 INFO - PROCESS | 3412 | RSS: Main: 167600128 23:04:47 INFO - PROCESS | 3412 | 23:07:49 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-ext.html (next: http://localhost:39603/tests/dromaeo/cssquery-jquery.html) 23:07:50 INFO - PROCESS | 3412 | RSS: Main: 164876288 23:07:50 INFO - PROCESS | 3412 | 23:10:52 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39603/tests/dromaeo/cssquery-mootools.html) 23:10:52 INFO - PROCESS | 3412 | RSS: Main: 166694912 23:10:52 INFO - PROCESS | 3412 | 23:13:54 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39603/tests/dromaeo/cssquery-prototype.html) 23:13:55 INFO - PROCESS | 3412 | RSS: Main: 164216832 23:13:55 INFO - PROCESS | 3412 | 23:16:57 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39603/tests/dromaeo/cssquery-yui.html) 23:16:58 INFO - PROCESS | 3412 | RSS: Main: 165801984 23:16:58 INFO - PROCESS | 3412 | 23:20:00 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-yui.html (next: http://localhost:39603/tests/dromaeo/cssquery-dojo.html) 23:20:00 INFO - PROCESS | 3412 | RSS: Main: 167776256 23:20:00 INFO - PROCESS | 3412 | 23:20:00 INFO - PROCESS | 3412 | __start_tp_report 23:20:00 INFO - PROCESS | 3412 | _x_x_mozilla_page_load 23:20:00 INFO - PROCESS | 3412 | _x_x_mozilla_page_load_details 23:20:00 INFO - PROCESS | 3412 | |i|pagename|runs| 23:20:00 INFO - PROCESS | 3412 | |0;dojo.html;3076.9692303076968;3086.3210093779376;3112.7821052526306;3127.3119913619003;3134.0597820653797;5311.893762124755;5316.920246196305;5332.786688532464;5353.946460535393;5381.5963802714805;5210.8697282567955;5356.062689029423;5404.810831620894;5456.154296084103;5499.092649712793;4833.419989601252;4861.6353773467135;4917;4946.258061290817;4967.577755890754;584.6311498627178;4873.902521949559;4934.432540257881;4952.975235123819;4966.726830024347;4901.681390709592;4906.975465122669;4916.459189489154;4923.5671961360285;4954.30639710439;4811.158047341702;4922.286268491084;4973.254011898208;5013.172826483626;5050.595952323805;4785.880352991168;4820.758962051918;4831.9275210871865;4839.491853355417;4879.707217566957;5200.869978250536;5206.7917283308625;5225.190095535198;5252.0283747506455;5290.100682883919;5528.723563821793;5605.103183490663;5607.299087614048;5610.775568977236;5634.464725851038;5613.46672066153;5633.6619802811965;5634.774609015634;5663.773449062032;5668.546516278688;5244.947550524522;5247.763850626731;5255.421903590602;5265.315508983846;5305.708186049727;5689.9146512802345;5743.483086522233;5754.108113242454;5814.389489103583;5878;5547.1679248113105;5553.4724201200825;5554.888902221933;5563;5613;5617.494425501643;5621.100623900238;5625.831225063254;5641.041023026095;5641.492265696025;5612.382637909826;5636.774529018875;5637.492625663628;5711.857203569944;5718.027935251017;5606.495415412633;5667.943320566824;5701.486866182064;5710.229119068956;5754;4243.5119961204855;4305.612494875476;4320.524742278347;4324.113556720928;4354.412154359121;3810.1427178885083;3846.1730727893078;3853.7880416576795;3880.5925377835483;3911.3741801311653;5423.159410291411;5456;5457.045017121988;5463.426340234298;5482.890342193134;5690.630109042899;5737.971310143423;5739.512141467939;5747.3677895431465;5748.885022299531;5377.704226267515;5422.15956526739;5434.103372943499;5471.753771080311;5489.2589500417735;4681.742504162304;4712.410948631421;4722.031983443386;4781.235002399669;4792.760361981887;5943.70281485924;5959.553033522503;5961.880762384728;5969.283685957713;5980.192673988956;5651.886962260732;5698.11679189718;5737.254156959569;5744;5770.047942089508;5865.120231965239;5882.499987500939;5889.175515427929;5890.823275301748;5903.675297858487;5460.453954604508;5598.412166722598;5600.131979543177;5618.073017952155;5621.606487545832;5601.467860553241;5665.546756259571;5666.121751128581;5681.431856814285;5719.428057194247;5504.422035686195;5548.805791797267;5549.889002220014;5561.944380556304;5561.972190139023;5437.592180586393;5538.141588053858;5558;5592.86017849557;5594.468525490072;5275.419703832498;5377.408485066718;5413.323334583177;5528.695921724344;5612.410696876769;5524.889502210013;5560.221568980265;5566.554675626021;5574.414686458026;5586.798838249796;5402.864928376822;5487.451254874481;5500.834974950758;5512.090505066619;5518.696471694096 23:20:00 INFO - PROCESS | 3412 | |1;ext.html;599.844040549457;643.4112786800079;658.7463826426825;663.290279401041;670.7954074007429;39011.80494097529;39156;39312.80343598278;39460.60539394609;39618.40572391409;41310;41841.790791046005;42158.36762448558;42321.788391058;42398.57601423985;8572.0570737219;8718.607662655164;8728.650853965833;8734;8834.38159328844;8626.611802468904;8724.171203735666;8761.080086590911;8963.372563920528;8964.14840590143;8889.511076890769;8927.330450216226;8936.151065648754;8953.776155596097;8961.865572016392;8776.824463510726;8814.118588141198;8886.377953543255;8896.777580560505;8929.642814287421;8806.823863522757;8865.290776737846;8879.644814207424;8904.73285801427;8910.732678019669;42284;42397.57602423998;42622;42632;42730.78634606838;3281.885134020322;3465.3935561276676;3522.8590856365713;3761.849526018956;3976.642102210786;31679.683203167904;32165.35669286601;32441.513377299125;32498;32665.51001734976;4242.596953289432;4338.110687309094;4341.261985462447;4362.847300344504;4370.628496577795;293931.9551033681;294940.5252973743;295810;295923;296005;36267.09332266715;59930.700346497986;60724.69637651784;60819;60870.39129608736;34875.476867847;35057.82471087628;35084.824575877465;35183.29633407317;35234;14838.70322593542;14894.776578351333;14952.850471495363;15028.09831410119;15036.17301048431;12038;12075.818862717066;12133.817992729939;12218.633440996784;12270.570530031406;8742.21320081183;8743.475391476532;8772.473651580925;8820.8676869847;8848.46909185451;3233.611966564027;3307.536944827726;3327.6505966873615;3346.7991920484847;3383.5263063171174;1021.371856308365;1036.8548403223556;1057.4983523396795;1068.871735391758;1109.4024604569395;31389.37221255562;31483.425828708932;32075.198120047186;32336.676633233837;32555.837220813744;1115.8493603363443;1145.123980155182;1162.6744511536783;1170.1107158559555;1228.969275768095;16766.83233167677;16824.242909069122;16850.83149168517;17016;17228.569285767706;447712;459365;460529;460823;461594;58205.417945820845;59348.95533879582;59630.10554841681;59785.701071495234;59863.40136598578;1280.206272111297;1287.8132670762686;1289.432649634158;1312.5012495251742;1315.2437348524636;30298.394032119675;32030.199245018128;32096.35807283888;32130.67869321277;32160.51759223567;51705.48294517157;51793.482065180375;51844;51984.220236697234;52196.73901630467;395309;396472;397296;398612;398992;28520;29070;43632;44948.77525612482;45252.321215182455;40903.7954810236;46708.766456167505;46860;47102.528974709814;47182.528174717816;39434.21131577295;40295.39556906708;40378.79810600928;40830.387544187455;41614.16771664489;38824.835254942394;39120.80439597898;40211;41997.79001104975;42503.3624495639;37404.81297593495;38079.61920380872;38751.03122421962;38957.80521097376;39164.80417597894;33719.662803371655;35131.47302790409;35137;35618.46572301469;36057.639423605426;27554.724452755217;27696.861515692293;27864.721352787023;27989.300267493476;28174.85912570424 23:20:00 INFO - PROCESS | 3412 | |2;jquery.html;404.8866317431118;406.7213958438472;407.8592885454519;408.5771226780281;414.59122498284967;13745.65635859104;18004.639907201865;18837.246510139594;18872;18999.145038473267;17242.56893577658;17261.741073883903;17477.12614369283;18450.44648660539;18697.252109915586;4967.379077615298;5329.413764485923;5631.324241091075;5811.099279611667;5848.2689663792025;5285;5290.232916227144;5299.284596579451;5316.441773613773;5324.92012619811;5699.430056994309;6311.842203944892;6332.303446620868;6345.175127233453;6348.492120630339;5643.181738647873;5695.088785794294;6240.656763878008;6287.308396076428;6289.937100628981;5416.9729151353995;5420.457954204548;5435.130379139318;5449.7275136243425;5456.372517160498;12697.682557936034;12841.550545730948;13152.473901043946;13173.34133293341;13202.075854690176;2365.8343915925893;2430.963535546968;2474.208253358926;2689.1260340389454;2912.8590485992777;8463.915360846375;8713.651453941835;8733.606987685569;8801.6039278232;8947.776305592348;1874.6438176746374;1940.8253257206918;1944.0474167657746;1978.307592342683;1995.4013795861329;82335.58832205861;83234;84134;84850;85422.14577854204;9989.900100999042;10001.34991225568;10032.899671003197;10214.846777298346;10381.792364152674;13970.511032113827;14009.85990140106;14056.71886562263;14069.85930140706;14074.71850562983;7852.254035866584;7901.091374491892;7903.604819759104;7932.84134317322;8072.959635201903;7918.2477664621765;7922.247386498273;7975.042994840656;8046.678132874619;8100.635471403801;4255.212785634668;4255.702100852911;4307.655387568987;4465.508794032654;4520.932186017212;1687.4684474390529;1757.7011907975675;1765.618839921536;1772.9468115956543;1817.1277786662477;968.7384406210425;1008.7578981044496;1035.1460045462522;1043.400044974143;1076.839476137539;17528.82471175272;18275.54311142232;18542.536436589195;18711.438656840317;18725;1008.2035192198082;1023.6928921323573;1026.4918865161792;1078.3583767658388;1082.6330113347483;10146.340487868265;10344.586216551254;10351.689449316533;10424.322419042737;10461.476926153662;441243;445785;447762;448685;459330;69412;82862.58568707117;83500.58249708713;91336;94784.52607736917;1049.8110340138849;1060.9045185933303;1083.1172594335592;1119.3955264157428;1127.0420142878652;15736.685266294839;15890.205489725698;15905.681886361977;15917.840821592099;15967;33674.83162584171;33916.83041584776;34764.82617586896;35136.29727405387;35611.82194089013;51405.48594514007;53233.733831332145;54019;54408.183877241085;54469.45530544802;7225.819354516179;7615.581143037186;7679;8349.874751878848;8505;9285.48929808867;12168.695782605506;13351.532696355582;13548.119372240773;13557.186568805902;12109.394530273275;12366.443510042249;12418.875811242133;12448.25310481374;12459.626211213677;11867.406629668309;11907.52369905194;11947.044236460888;12024.218425802295;12399.070069744987;12049.939750301193;12278.263304201777;12374.876251237372;12392.75214495723;12395.93802030984;7198.280171982759;7660;8364.581770911553;8438.409311348147;8611.655533778829;11444.542218311175;11951.521939122338;12208.572699955459;12254;12376.133670642968 23:20:00 INFO - PROCESS | 3412 | |3;mootools.html;1473.5284708893155;1499.880009599232;1632.975505367419;1740.069063051268;1772.8315809998046;7447.441441891866;8002.239787220205;8034.638441270142;8383.035950865653;8429.620667069981;8122.959385203066;8219;8222.835543289146;8296;8304;2268.8071513921336;2294.288770481156;2295.357299956015;2297.3911913342977;2302;2227.086894373307;2242.8093612042994;2243.932682019542;2245.1692873636775;2245.741739699931;2257.7064981552376;2261.163369553259;2282.075759317479;2304.2396009316885;2313.1556981701724;2113.080809847721;2114.598226336999;2114.9577008459746;2126.1176611706123;2131.6056529542084;2154.5798569278995;2155.568886222746;2160.2763074370105;2165.0257384177025;2165.6859755335545;8018.238267364591;8048.31589314909;8057.113717491071;8077.8788318175275;8128.471649342774;5011.724355160465;5172;5181.663191892552;5196.090684130299;5202;3125.2186953261685;3210.4542227821094;3344.3980083584943;3375.696187343151;3387.1532116970757;1059.9364038157735;1073.098597178374;1075.876274228466;1080.5353697909895;1089.2756317049232;11556.422178891105;11722.70693232659;11733.178677492579;11774.411279435993;11802.940985295105;4437.29003359461;4502.144592527409;4619.122366750306;4645.419322584677;4750.049990002013;10129.797404051878;10243.7439064024;10243.897561024443;10249.38503689781;10255.07704306616;5322.148456246982;5333.653312534673;5341.4925582069645;5343.946560534345;5367.838964831061;4091.734037287567;4701.059788042405;4708.458527269408;4871.878203044952;4921.753912304371;4073.9388909166387;4077.039133874912;4094.406311084876;4148.751074935453;4163.146554956226;1309.8166256724066;1313.5271302331153;1340.6112227454123;1356.8168297279938;1359.136948038003;820.2781552234115;953.2612225525273;962.0956301076965;973.3770386952356;992.0823238504355;5670.432956704297;5727;5796.333421656479;5864.589478736533;5949;442;445.44319600499375;474.28383141456646;476.77114984807486;479.3480866022207;3835.7890316032326;3837.501124853807;3862.864799731996;3880.0881792778673;3917.5103112110987;10162.745931351776;10801.459927003618;10811.081058109992;10848.349099053925;10897.67306980792;10617.84073238902;10691.09125724322;10703.892961070445;10705.464726763787;10754.56981720738;7590.7722768317035;8080.4343695940715;8107.837843243102;8167.101618821925;8190.221928916743;5756.481916627524;5765.221695071112;5868.031774757117;5937.91093133612;5958.702064896825;9234.584443699916;9714.757131071497;9796.069373409515;9834.459104749307;9835.164011058854;9553;9690.273229507675;9691.370060946016;9737.513124343895;9822.557984890555;6632.071509988702;7096.077509923677;7159.856802863809;7201.063861697946;7484.25157484269;7985.161558036322;8006.19938006218;8026.638801254075;8058.959705201437;8072.677092916218;7133.928660713326;7395.704171833282;7411.221821708643;7454.6645400956;7468.4398670101045;6847.21257055445;6970.233274339717;6983.3714965653335;7037.753678621224;7236.674349654173;6088.360722124113;6147.600405973598;6162.630242185483;6162.845928851814;6178.783742568989;4694.718316900997;4864.829730959399;4865.659403841697;4876.512348765237;4929.137400954747;4831.178699621002;4840.685355451885;4842.7336496493035;4877.463479017376;4917.090338287285 23:20:00 INFO - PROCESS | 3412 | |4;prototype.html;314.0497510460043;322.95155726641013;324.0343775548864;331.4398666254031;336.11098644086394;5876.5004974577105;5888.470037696607;5903.022487466698;6021.548383871211;6033.896950073948;5980.700964951746;6006.309274433442;6014.909776353358;6028.939710602893;6033.879322413549;4550.931736023946;4566.452025756914;4568.611668008215;4599.080183963204;4600.6549508786975;4395.560443955595;4573.131105090022;4592.816287348502;4596.609288210506;4610.561996610333;4525.818967241323;4532.614727748145;4537.364768932335;4538.727676339414;4541.931871021938;4560.110778398213;4577.725336479822;4585.532629558543;4592.862214133548;4599.356090147382;3679.5032670589394;3836.3286424875537;3858.344081506151;4062.009615288517;4066.715329926906;5706.800261990852;5733.770649174028;5758.280214973129;5765.394633563499;5789.565782566325;5143.12566863634;5167.534921857014;5180.248863914711;5182.352205974254;5198.480151984809;5927.7925272615685;6245.594036387665;6259.37406259375;6267.2165979252595;6285.96857015712;4288.378185163165;4300.118475712503;4311.1808756336195;4313.503947046099;4317.827286908519;6294.8111556653375;6510.316416776265;6566.277709451956;6579.671016449159;6592.406683398469;4332.176886391576;4338.349247612883;4351.108022855307;4361.520232774392;4371.344298355272;4397.736135831797;4402.603765661106;4406.823727050946;4411.250087485071;4412.426384569985;5093.4651861554;5101.744912754348;5141.177411614124;5174.223866419992;5187;5889.734961926638;5971.164037034819;6119.877602448015;6216.720247588779;6303.699149810378;1510.9848901511064;1515.3332533685364;1530.036077271312;1535.4549135057118;1536.784850120984;993.4635296939716;1005.070309963281;1028.1106842581114;1030.1964467715195;1030.3560274828233;6024.27708674953;6041.758329666852;6049;6083.422074902877;6115.663638499926;6444.9355506444335;6452.516061295328;6457.677116144174;6472.773452929125;6474.643894585749;5900.232969713909;6021.367756385516;6096.72564734588;6103.572749907464;6106.358832322631;3459.41189997701;3472.600650925176;3487.633798451126;3488.494168345576;3499.2651543176216;6600.636964966973;6709.29552397001;6718.529702920749;6730.360615741497;6749.312671832042;6550.017497375432;6554.115194448784;6562.245341785756;6576.243731970789;6623.536352455282;6563.573367731177;6705.195376554844;6706.53054286205;6721.26066132725;6726.091977583062;6396.136521569715;6402.679866006588;6421.486281097407;6424.229092508929;6430.324815894451;6128.785492507741;6298.7480500781285;6310.873782524415;6375.936240637534;6393.808185754435;6825.419839313714;6827.965860170667;6877.449804015567;6902.827429314308;6927.411170050602;4369.694121411598;4379.299312110047;4381.211381951151;4394.2749446340995;4408.911821763482;6193.040078787795;6357.4596159326975;6386.882295598159;6533.934660653333;6538.248101468202;6331.556791024584;6338.619682818861;6343.207099112611;6345.428911397997;6351.396617321347;6192.628442293477;6297.96851015742;6333.113364129118;6336.112944187909;6348.9047664286;6184.567080304336;6200.658963757037;6206.875862482815;6211.596246243979;6228.283747369111;6210.472109870711;6333.6882038054855;6349.49204063683;6383.8084857452495;6390.329015453496;6003.789867354796;6162.260528736401;6176.969115154396;6197.4732147767945;6206.286277078013 23:20:00 INFO - PROCESS | 3412 | |5;yui.html;731.7512045904391;747.0922828763053;782.7221336425569;785.0932173339795;791.4697152907552;12204.633860984162;12248.510059597616;12426.130170888042;12566.994640428778;13031.218126912392;13894.652633684163;13928.373223204955;13961.162330260191;13967.231802250897;13974.3711532981;831.3515457942814;835.1231207232412;836.9121242269565;837.7738010737128;839.0770152831867;524.7769697878387;805.2712295372697;825.7729124490783;828.9917100829005;829.8215883585028;869.7651634058832;871.4379225399614;874.3398733955854;875.0199776250577;880.1638443478721;873.1792115411492;873.6767396063466;875.5140896802272;875.689130358723;875.8861348024716;631.343402861024;635.4471609699591;637.3753721353054;638.1353266324156;638.2564312575844;13259.73480530384;13263.801042984363;13310.534131305358;13313.53402630913;13370.665733356744;13028.54400095992;13100.737985240241;13234.139780914209;13288.601341959757;13300.733985320336;10161.441120738356;10515.263931524796;10563.683089507327;10610.098141657969;10676.946615266874;3679.779213247187;3699.741018128732;3738.532683414573;3766.548014238309;3819.026148332185;59087;59099;60343.396566034215;60723.392766072655;60985.39014609841;10396.428196449267;10447.110573922246;10469.738256543495;10559.577616895238;10631.936806319307;18476.907615461838;18484;18519.629607407776;18527;18574.071296435126;7596.8480630387085;7682.385409167253;7707.614619269014;7772.261635144652;7894.64474098667;4791.185498465269;4794.880127996828;4862.367892173995;4871.80512779492;4876.171050921352;3149.3228955774616;3200.3119329343835;3220.0017994421805;3228.8224147672104;3234.3854667613077;539.8920215956746;550.6145698011408;552.3509875895807;552.6811496960726;557.6013150597342;705.5731282573969;709.9112610923635;715.5670819154441;717.7810767715897;726.5459088069956;9133.360664753536;9151.588178531982;9227.538623068955;9415.05849415053;9535.713928582154;646.6992848325457;646.9191351081115;698.979030629082;707.4093132234539;710.0698085508001;4238.978805105955;4408.25059739845;4535.727856328631;4567.977160114178;4622.537746225418;64151;64308.35691643117;65078;65315;65691.34308656852;55595.44404555984;55754.442455575736;56942;58518;58564.707176463846;51993.7400312996;52491.73754131281;53653.463465364846;54452;54554.18168727472;8736.301095912184;8779.385443019182;8867.512286824287;8870.73387798367;8946.507942063248;31951;32114;32258.677413225567;32629.18427039343;32678.509822352207;44162.77918610515;46613.533864660916;46692;46799.76600116977;47655.28517072177;11575.479103440197;11711;11724.70688232801;11772.882271177179;12054.819177712166;12335.259884406963;13118.672033199246;13207.141535800141;13732.244726540137;13779;12708.364581771059;12723.618291451272;13080.607581772561;13247;13393.397297121459;12436.19164754288;12823.102382833486;12983.221006739626;12993.740125197253;13073.934630326787;9771.657991970247;12030.27818330868;12348.073894457772;12467.002639788976;12604.621861344174;10073.496325183565;10122;10361.63734269297;10623.946880265548;10771.246012779031;9638.807223855623;10251.692449226535;10305;10307.278490505592;10368 23:20:00 INFO - PROCESS | 3412 | __end_tp_report 23:20:00 INFO - PROCESS | 3412 | __start_cc_report 23:20:00 INFO - PROCESS | 3412 | _x_x_mozilla_cycle_collect,351 23:20:00 INFO - PROCESS | 3412 | __end_cc_report 23:20:00 INFO - PROCESS | 3412 | __startTimestamp1460787600934__endTimestamp 23:20:00 INFO - PROCESS | 3412 | 23:20:00 INFO - PROCESS | 3412 | ------- Summary: start ------- 23:20:00 INFO - PROCESS | 3412 | Number of tests: 6 23:20:00 INFO - PROCESS | 3412 | 23:20:00 INFO - PROCESS | 3412 | [#0] dojo.html Cycles:165 Average:5257.54 Median:5504.42 stddev:697.01 (12.7%) stddev-sans-first:677.83 23:20:00 INFO - PROCESS | 3412 | Values: 3077.0 3086.3 3112.8 3127.3 3134.1 5311.9 5316.9 5332.8 5353.9 5381.6 5210.9 5356.1 5404.8 5456.2 5499.1 4833.4 4861.6 4917.0 4946.3 4967.6 584.6 4873.9 4934.4 4953.0 4966.7 4901.7 4907.0 4916.5 4923.6 4954.3 4811.2 4922.3 4973.3 5013.2 5050.6 4785.9 4820.8 4831.9 4839.5 4879.7 5200.9 5206.8 5225.2 5252.0 5290.1 5528.7 5605.1 5607.3 5610.8 5634.5 5613.5 5633.7 5634.8 5663.8 5668.5 5244.9 5247.8 5255.4 5265.3 5305.7 5689.9 5743.5 5754.1 5814.4 5878.0 5547.2 5553.5 5554.9 5563.0 5613.0 5617.5 5621.1 5625.8 5641.0 5641.5 5612.4 5636.8 5637.5 5711.9 5718.0 5606.5 5667.9 5701.5 5710.2 5754.0 4243.5 4305.6 4320.5 4324.1 4354.4 3810.1 3846.2 3853.8 3880.6 3911.4 5423.2 5456.0 5457.0 5463.4 5482.9 5690.6 5738.0 5739.5 5747.4 5748.9 5377.7 5422.2 5434.1 5471.8 5489.3 4681.7 4712.4 4722.0 4781.2 4792.8 5943.7 5959.6 5961.9 5969.3 5980.2 5651.9 5698.1 5737.3 5744.0 5770.0 5865.1 5882.5 5889.2 5890.8 5903.7 5460.5 5598.4 5600.1 5618.1 5621.6 5601.5 5665.5 5666.1 5681.4 5719.4 5504.4 5548.8 5549.9 5561.9 5562.0 5437.6 5538.1 5558.0 5592.9 5594.5 5275.4 5377.4 5413.3 5528.7 5612.4 5524.9 5560.2 5566.6 5574.4 5586.8 5402.9 5487.5 5500.8 5512.1 5518.7 23:20:00 INFO - PROCESS | 3412 | 23:20:00 INFO - PROCESS | 3412 | [#1] ext.html Cycles:180 Average:54210.26 Median:218045.20 stddev:102960.69 (47.2%) stddev-sans-first:103170.85 23:20:00 INFO - PROCESS | 3412 | Values: 599.8 643.4 658.7 663.3 670.8 39011.8 39156.0 39312.8 39460.6 39618.4 41310.0 41841.8 42158.4 42321.8 42398.6 8572.1 8718.6 8728.7 8734.0 8834.4 8626.6 8724.2 8761.1 8963.4 8964.1 8889.5 8927.3 8936.2 8953.8 8961.9 8776.8 8814.1 8886.4 8896.8 8929.6 8806.8 8865.3 8879.6 8904.7 8910.7 42284.0 42397.6 42622.0 42632.0 42730.8 3281.9 3465.4 3522.9 3761.8 3976.6 31679.7 32165.4 32441.5 32498.0 32665.5 4242.6 4338.1 4341.3 4362.8 4370.6 293932.0 294940.5 295810.0 295923.0 296005.0 36267.1 59930.7 60724.7 60819.0 60870.4 34875.5 35057.8 35084.8 35183.3 35234.0 14838.7 14894.8 14952.9 15028.1 15036.2 12038.0 12075.8 12133.8 12218.6 12270.6 8742.2 8743.5 8772.5 8820.9 8848.5 3233.6 3307.5 3327.7 3346.8 3383.5 1021.4 1036.9 1057.5 1068.9 1109.4 31389.4 31483.4 32075.2 32336.7 32555.8 1115.8 1145.1 1162.7 1170.1 1229.0 16766.8 16824.2 16850.8 17016.0 17228.6 447712.0 459365.0 460529.0 460823.0 461594.0 58205.4 59349.0 59630.1 59785.7 59863.4 1280.2 1287.8 1289.4 1312.5 1315.2 30298.4 32030.2 32096.4 32130.7 32160.5 51705.5 51793.5 51844.0 51984.2 52196.7 395309.0 396472.0 397296.0 398612.0 398992.0 28520.0 29070.0 43632.0 44948.8 45252.3 40903.8 46708.8 46860.0 47102.5 47182.5 39434.2 40295.4 40378.8 40830.4 41614.2 38824.8 39120.8 40211.0 41997.8 42503.4 37404.8 38079.6 38751.0 38957.8 39164.8 33719.7 35131.5 35137.0 35618.5 36057.6 27554.7 27696.9 27864.7 27989.3 28174.9 23:20:00 INFO - PROCESS | 3412 | 23:20:00 INFO - PROCESS | 3412 | [#2] jquery.html Cycles:180 Average:26854.14 Median:2800.99 stddev:74120.22 (2646.2%) stddev-sans-first:74301.54 23:20:00 INFO - PROCESS | 3412 | Values: 404.9 406.7 407.9 408.6 414.6 13745.7 18004.6 18837.2 18872.0 18999.1 17242.6 17261.7 17477.1 18450.4 18697.3 4967.4 5329.4 5631.3 5811.1 5848.3 5285.0 5290.2 5299.3 5316.4 5324.9 5699.4 6311.8 6332.3 6345.2 6348.5 5643.2 5695.1 6240.7 6287.3 6289.9 5417.0 5420.5 5435.1 5449.7 5456.4 12697.7 12841.6 13152.5 13173.3 13202.1 2365.8 2431.0 2474.2 2689.1 2912.9 8463.9 8713.7 8733.6 8801.6 8947.8 1874.6 1940.8 1944.0 1978.3 1995.4 82335.6 83234.0 84134.0 84850.0 85422.1 9989.9 10001.3 10032.9 10214.8 10381.8 13970.5 14009.9 14056.7 14069.9 14074.7 7852.3 7901.1 7903.6 7932.8 8073.0 7918.2 7922.2 7975.0 8046.7 8100.6 4255.2 4255.7 4307.7 4465.5 4520.9 1687.5 1757.7 1765.6 1772.9 1817.1 968.7 1008.8 1035.1 1043.4 1076.8 17528.8 18275.5 18542.5 18711.4 18725.0 1008.2 1023.7 1026.5 1078.4 1082.6 10146.3 10344.6 10351.7 10424.3 10461.5 441243.0 445785.0 447762.0 448685.0 459330.0 69412.0 82862.6 83500.6 91336.0 94784.5 1049.8 1060.9 1083.1 1119.4 1127.0 15736.7 15890.2 15905.7 15917.8 15967.0 33674.8 33916.8 34764.8 35136.3 35611.8 51405.5 53233.7 54019.0 54408.2 54469.5 7225.8 7615.6 7679.0 8349.9 8505.0 9285.5 12168.7 13351.5 13548.1 13557.2 12109.4 12366.4 12418.9 12448.3 12459.6 11867.4 11907.5 11947.0 12024.2 12399.1 12049.9 12278.3 12374.9 12392.8 12395.9 7198.3 7660.0 8364.6 8438.4 8611.7 11444.5 11951.5 12208.6 12254.0 12376.1 23:20:00 INFO - PROCESS | 3412 | 23:20:00 INFO - PROCESS | 3412 | [#3] mootools.html Cycles:180 Average:5547.30 Median:4841.71 stddev:3158.16 (65.2%) stddev-sans-first:3152.18 23:20:00 INFO - PROCESS | 3412 | Values: 1473.5 1499.9 1633.0 1740.1 1772.8 7447.4 8002.2 8034.6 8383.0 8429.6 8123.0 8219.0 8222.8 8296.0 8304.0 2268.8 2294.3 2295.4 2297.4 2302.0 2227.1 2242.8 2243.9 2245.2 2245.7 2257.7 2261.2 2282.1 2304.2 2313.2 2113.1 2114.6 2115.0 2126.1 2131.6 2154.6 2155.6 2160.3 2165.0 2165.7 8018.2 8048.3 8057.1 8077.9 8128.5 5011.7 5172.0 5181.7 5196.1 5202.0 3125.2 3210.5 3344.4 3375.7 3387.2 1059.9 1073.1 1075.9 1080.5 1089.3 11556.4 11722.7 11733.2 11774.4 11802.9 4437.3 4502.1 4619.1 4645.4 4750.0 10129.8 10243.7 10243.9 10249.4 10255.1 5322.1 5333.7 5341.5 5343.9 5367.8 4091.7 4701.1 4708.5 4871.9 4921.8 4073.9 4077.0 4094.4 4148.8 4163.1 1309.8 1313.5 1340.6 1356.8 1359.1 820.3 953.3 962.1 973.4 992.1 5670.4 5727.0 5796.3 5864.6 5949.0 442.0 445.4 474.3 476.8 479.3 3835.8 3837.5 3862.9 3880.1 3917.5 10162.7 10801.5 10811.1 10848.3 10897.7 10617.8 10691.1 10703.9 10705.5 10754.6 7590.8 8080.4 8107.8 8167.1 8190.2 5756.5 5765.2 5868.0 5937.9 5958.7 9234.6 9714.8 9796.1 9834.5 9835.2 9553.0 9690.3 9691.4 9737.5 9822.6 6632.1 7096.1 7159.9 7201.1 7484.3 7985.2 8006.2 8026.6 8059.0 8072.7 7133.9 7395.7 7411.2 7454.7 7468.4 6847.2 6970.2 6983.4 7037.8 7236.7 6088.4 6147.6 6162.6 6162.8 6178.8 4694.7 4864.8 4865.7 4876.5 4929.1 4831.2 4840.7 4842.7 4877.5 4917.1 23:20:00 INFO - PROCESS | 3412 | 23:20:00 INFO - PROCESS | 3412 | [#4] prototype.html Cycles:180 Average:5239.74 Median:6021.46 stddev:1594.37 (26.5%) stddev-sans-first:1555.39 23:20:00 INFO - PROCESS | 3412 | Values: 314.0 323.0 324.0 331.4 336.1 5876.5 5888.5 5903.0 6021.5 6033.9 5980.7 6006.3 6014.9 6028.9 6033.9 4550.9 4566.5 4568.6 4599.1 4600.7 4395.6 4573.1 4592.8 4596.6 4610.6 4525.8 4532.6 4537.4 4538.7 4541.9 4560.1 4577.7 4585.5 4592.9 4599.4 3679.5 3836.3 3858.3 4062.0 4066.7 5706.8 5733.8 5758.3 5765.4 5789.6 5143.1 5167.5 5180.2 5182.4 5198.5 5927.8 6245.6 6259.4 6267.2 6286.0 4288.4 4300.1 4311.2 4313.5 4317.8 6294.8 6510.3 6566.3 6579.7 6592.4 4332.2 4338.3 4351.1 4361.5 4371.3 4397.7 4402.6 4406.8 4411.3 4412.4 5093.5 5101.7 5141.2 5174.2 5187.0 5889.7 5971.2 6119.9 6216.7 6303.7 1511.0 1515.3 1530.0 1535.5 1536.8 993.5 1005.1 1028.1 1030.2 1030.4 6024.3 6041.8 6049.0 6083.4 6115.7 6444.9 6452.5 6457.7 6472.8 6474.6 5900.2 6021.4 6096.7 6103.6 6106.4 3459.4 3472.6 3487.6 3488.5 3499.3 6600.6 6709.3 6718.5 6730.4 6749.3 6550.0 6554.1 6562.2 6576.2 6623.5 6563.6 6705.2 6706.5 6721.3 6726.1 6396.1 6402.7 6421.5 6424.2 6430.3 6128.8 6298.7 6310.9 6375.9 6393.8 6825.4 6828.0 6877.4 6902.8 6927.4 4369.7 4379.3 4381.2 4394.3 4408.9 6193.0 6357.5 6386.9 6533.9 6538.2 6331.6 6338.6 6343.2 6345.4 6351.4 6192.6 6298.0 6333.1 6336.1 6348.9 6184.6 6200.7 6206.9 6211.6 6228.3 6210.5 6333.7 6349.5 6383.8 6390.3 6003.8 6162.3 6177.0 6197.5 6206.3 23:20:00 INFO - PROCESS | 3412 | 23:20:00 INFO - PROCESS | 3412 | [#5] yui.html Cycles:180 Average:14965.47 Median:46745.88 stddev:18027.51 (38.6%) stddev-sans-first:18046.39 23:20:00 INFO - PROCESS | 3412 | Values: 731.8 747.1 782.7 785.1 791.5 12204.6 12248.5 12426.1 12567.0 13031.2 13894.7 13928.4 13961.2 13967.2 13974.4 831.4 835.1 836.9 837.8 839.1 524.8 805.3 825.8 829.0 829.8 869.8 871.4 874.3 875.0 880.2 873.2 873.7 875.5 875.7 875.9 631.3 635.4 637.4 638.1 638.3 13259.7 13263.8 13310.5 13313.5 13370.7 13028.5 13100.7 13234.1 13288.6 13300.7 10161.4 10515.3 10563.7 10610.1 10676.9 3679.8 3699.7 3738.5 3766.5 3819.0 59087.0 59099.0 60343.4 60723.4 60985.4 10396.4 10447.1 10469.7 10559.6 10631.9 18476.9 18484.0 18519.6 18527.0 18574.1 7596.8 7682.4 7707.6 7772.3 7894.6 4791.2 4794.9 4862.4 4871.8 4876.2 3149.3 3200.3 3220.0 3228.8 3234.4 539.9 550.6 552.4 552.7 557.6 705.6 709.9 715.6 717.8 726.5 9133.4 9151.6 9227.5 9415.1 9535.7 646.7 646.9 699.0 707.4 710.1 4239.0 4408.3 4535.7 4568.0 4622.5 64151.0 64308.4 65078.0 65315.0 65691.3 55595.4 55754.4 56942.0 58518.0 58564.7 51993.7 52491.7 53653.5 54452.0 54554.2 8736.3 8779.4 8867.5 8870.7 8946.5 31951.0 32114.0 32258.7 32629.2 32678.5 44162.8 46613.5 46692.0 46799.8 47655.3 11575.5 11711.0 11724.7 11772.9 12054.8 12335.3 13118.7 13207.1 13732.2 13779.0 12708.4 12723.6 13080.6 13247.0 13393.4 12436.2 12823.1 12983.2 12993.7 13073.9 9771.7 12030.3 12348.1 12467.0 12604.6 10073.5 10122.0 10361.6 10623.9 10771.2 9638.8 10251.7 10305.0 10307.3 10368.0 23:20:00 INFO - PROCESS | 3412 | -------- Summary: end -------- 23:20:00 INFO - PROCESS | 3412 | 23:20:01 INFO - TEST-INFO | 3412: exit 0 23:20:01 INFO - TEST-OK | dromaeo_css | took 1110872ms 23:20:01 INFO - TEST-START | kraken 23:20:01 INFO - operating with platform_type : linux_ 23:20:01 INFO - Initialising browser for kraken test... 23:20:01 INFO - TEST-INFO | started process 3655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprdZ1aW/profile http://localhost:39603/getInfo.html) 23:20:05 INFO - PROCESS | 3655 | 23:20:05 INFO - PROCESS | 3655 | (process:3724): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:20:05 INFO - PROCESS | 3655 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 23:20:06 INFO - PROCESS | 3655 | __metrics Screen width/height:1600/1200 23:20:06 INFO - PROCESS | 3655 | colorDepth:24 23:20:06 INFO - PROCESS | 3655 | Browser inner width/height: 1024/697 23:20:06 INFO - PROCESS | 3655 | __metrics 23:20:06 ERROR - PROCESS | 3655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 23:20:07 INFO - TEST-INFO | 3655: exit 0 23:20:07 INFO - Browser initialized. 23:20:07 INFO - Running cycle 1/1 for kraken test... 23:20:07 INFO - TEST-INFO | started process 3775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprdZ1aW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:09 INFO - PROCESS | 3775 | 23:20:09 INFO - PROCESS | 3775 | (process:3837): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:20:19 INFO - PROCESS | 3775 | RSS: Main: 163356672 23:20:19 INFO - PROCESS | 3775 | 23:20:22 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-beat-detection) 23:20:23 INFO - PROCESS | 3775 | RSS: Main: 168099840 23:20:23 INFO - PROCESS | 3775 | 23:20:25 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-dft) 23:20:26 INFO - PROCESS | 3775 | RSS: Main: 171765760 23:20:26 INFO - PROCESS | 3775 | 23:20:29 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-fft) 23:20:29 INFO - PROCESS | 3775 | RSS: Main: 162697216 23:20:29 INFO - PROCESS | 3775 | 23:20:32 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-oscillator) 23:20:32 INFO - PROCESS | 3775 | RSS: Main: 163115008 23:20:32 INFO - PROCESS | 3775 | 23:20:35 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39603/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:20:35 INFO - PROCESS | 3775 | RSS: Main: 163377152 23:20:35 INFO - PROCESS | 3775 | 23:20:38 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39603/tests/kraken/driver.html?testName=imaging-darkroom) 23:20:39 INFO - PROCESS | 3775 | RSS: Main: 163545088 23:20:39 INFO - PROCESS | 3775 | 23:20:42 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39603/tests/kraken/driver.html?testName=imaging-desaturate) 23:20:43 INFO - PROCESS | 3775 | RSS: Main: 165900288 23:20:43 INFO - PROCESS | 3775 | 23:20:46 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39603/tests/kraken/driver.html?testName=json-parse-financial) 23:20:46 INFO - PROCESS | 3775 | RSS: Main: 167260160 23:20:46 INFO - PROCESS | 3775 | 23:20:48 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39603/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:20:49 INFO - PROCESS | 3775 | RSS: Main: 166961152 23:20:49 INFO - PROCESS | 3775 | 23:20:50 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:20:51 INFO - PROCESS | 3775 | RSS: Main: 166756352 23:20:51 INFO - PROCESS | 3775 | 23:20:53 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:20:54 INFO - PROCESS | 3775 | RSS: Main: 167055360 23:20:54 INFO - PROCESS | 3775 | 23:20:56 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:20:57 INFO - PROCESS | 3775 | RSS: Main: 167444480 23:20:57 INFO - PROCESS | 3775 | 23:21:00 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:21:00 INFO - PROCESS | 3775 | RSS: Main: 167079936 23:21:00 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39603/tests/kraken/driver.html?testName=ai-astar) 23:21:02 INFO - PROCESS | 3775 | RSS: Main: 168304640 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | __start_tp_report 23:21:02 INFO - PROCESS | 3775 | _x_x_mozilla_page_load 23:21:02 INFO - PROCESS | 3775 | _x_x_mozilla_page_load_details 23:21:02 INFO - PROCESS | 3775 | |i|pagename|runs| 23:21:02 INFO - PROCESS | 3775 | |0;ai-astar;113;106;112;113;113;126;112;112;111;110 23:21:02 INFO - PROCESS | 3775 | |1;audio-beat-detection;156;127;156;186;131;155;157;131;189;135 23:21:02 INFO - PROCESS | 3775 | |2;audio-dft;164;162;161;161;165;170;165;159;164;162 23:21:02 INFO - PROCESS | 3775 | |3;audio-fft;74;76;75;156;76;77;76;75;154;77 23:21:02 INFO - PROCESS | 3775 | |4;audio-oscillator;93;93;150;92;93;93;138;92;93;142 23:21:02 INFO - PROCESS | 3775 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;120;118 23:21:02 INFO - PROCESS | 3775 | |6;imaging-darkroom;147;147;147;147;147;148;148;146;147;146 23:21:02 INFO - PROCESS | 3775 | |7;imaging-desaturate;96;96;96;96;96;95;95;95;96;95 23:21:02 INFO - PROCESS | 3775 | |8;json-parse-financial;56;56;63;57;56;56;55;75;55;54 23:21:02 INFO - PROCESS | 3775 | |9;json-stringify-tinderbox;61;61;61;61;61;61;60;61;62;61 23:21:02 INFO - PROCESS | 3775 | |10;stanford-crypto-aes;78;78;76;81;85;79;77;79;79;78 23:21:02 INFO - PROCESS | 3775 | |11;stanford-crypto-ccm;126;131;128;127;128;122;124;133;164;129 23:21:02 INFO - PROCESS | 3775 | |12;stanford-crypto-pbkdf2;169;166;170;167;170;167;172;173;171;165 23:21:02 INFO - PROCESS | 3775 | |13;stanford-crypto-sha256-iterative;70;67;71;71;71;68;67;68;70;66 23:21:02 INFO - PROCESS | 3775 | __end_tp_report 23:21:02 INFO - PROCESS | 3775 | __start_cc_report 23:21:02 INFO - PROCESS | 3775 | _x_x_mozilla_cycle_collect,819 23:21:02 INFO - PROCESS | 3775 | __end_cc_report 23:21:02 INFO - PROCESS | 3775 | __startTimestamp1460787662737__endTimestamp 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | ------- Summary: start ------- 23:21:02 INFO - PROCESS | 3775 | Number of tests: 14 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.50 stddev:5.09 (4.5%) stddev-sans-first:5.40 23:21:02 INFO - PROCESS | 3775 | Values: 113.0 106.0 112.0 113.0 113.0 126.0 112.0 112.0 111.0 110.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:156.00 stddev:22.08 (14.2%) stddev-sans-first:23.37 23:21:02 INFO - PROCESS | 3775 | Values: 156.0 127.0 156.0 186.0 131.0 155.0 157.0 131.0 189.0 135.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:3.06 (1.9%) stddev-sans-first:3.23 23:21:02 INFO - PROCESS | 3775 | Values: 164.0 162.0 161.0 161.0 165.0 170.0 165.0 159.0 164.0 162.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#3] audio-fft Cycles:10 Average:91.60 Median:76.00 stddev:33.43 (44.0%) stddev-sans-first:34.85 23:21:02 INFO - PROCESS | 3775 | Values: 74.0 76.0 75.0 156.0 76.0 77.0 76.0 75.0 154.0 77.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.00 stddev:24.62 (26.5%) stddev-sans-first:25.52 23:21:02 INFO - PROCESS | 3775 | Values: 93.0 93.0 150.0 92.0 93.0 93.0 138.0 92.0 93.0 142.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 23:21:02 INFO - PROCESS | 3775 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 120.0 118.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:21:02 INFO - PROCESS | 3775 | Values: 147.0 147.0 147.0 147.0 147.0 148.0 148.0 146.0 147.0 146.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:21:02 INFO - PROCESS | 3775 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:56.00 stddev:6.36 (11.4%) stddev-sans-first:6.69 23:21:02 INFO - PROCESS | 3775 | Values: 56.0 56.0 63.0 57.0 56.0 56.0 55.0 75.0 55.0 54.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 23:21:02 INFO - PROCESS | 3775 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 62.0 61.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:2.49 (3.2%) stddev-sans-first:2.62 23:21:02 INFO - PROCESS | 3775 | Values: 78.0 78.0 76.0 81.0 85.0 79.0 77.0 79.0 79.0 78.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:128.50 stddev:11.95 (9.3%) stddev-sans-first:12.53 23:21:02 INFO - PROCESS | 3775 | Values: 126.0 131.0 128.0 127.0 128.0 122.0 124.0 133.0 164.0 129.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.00 stddev:2.67 (1.6%) stddev-sans-first:2.83 23:21:02 INFO - PROCESS | 3775 | Values: 169.0 166.0 170.0 167.0 170.0 167.0 172.0 173.0 171.0 165.0 23:21:02 INFO - PROCESS | 3775 | 23:21:02 INFO - PROCESS | 3775 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:70.00 stddev:1.91 (2.7%) stddev-sans-first:1.99 23:21:02 INFO - PROCESS | 3775 | Values: 70.0 67.0 71.0 71.0 71.0 68.0 67.0 68.0 70.0 66.0 23:21:02 INFO - PROCESS | 3775 | -------- Summary: end -------- 23:21:02 INFO - PROCESS | 3775 | 23:21:03 INFO - TEST-INFO | 3775: exit 0 23:21:03 INFO - TEST-OK | kraken | took 62110ms 23:21:03 INFO - SUITE-END | took 1172s 23:21:03 INFO - Completed test suite (00:19:33) 23:21:03 INFO - javascript benchmark 23:21:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3076.9692303076968, 3086.3210093779376, 3112.7821052526306, 3127.3119913619003, 3134.0597820653797, 5311.893762124755, 5316.920246196305, 5332.786688532464, 5353.946460535393, 5381.5963802714805, 5210.8697282567955, 5356.062689029423, 5404.810831620894, 5456.154296084103, 5499.092649712793, 4833.419989601252, 4861.6353773467135, 4917.0, 4946.258061290817, 4967.577755890754, 584.6311498627178, 4873.902521949559, 4934.432540257881, 4952.975235123819, 4966.726830024347, 4901.681390709592, 4906.975465122669, 4916.459189489154, 4923.5671961360285, 4954.30639710439, 4811.158047341702, 4922.286268491084, 4973.254011898208, 5013.172826483626, 5050.595952323805, 4785.880352991168, 4820.758962051918, 4831.9275210871865, 4839.491853355417, 4879.707217566957, 5200.869978250536, 5206.7917283308625, 5225.190095535198, 5252.0283747506455, 5290.100682883919, 5528.723563821793, 5605.103183490663, 5607.299087614048, 5610.775568977236, 5634.464725851038, 5613.46672066153, 5633.6619802811965, 5634.774609015634, 5663.773449062032, 5668.546516278688, 5244.947550524522, 5247.763850626731, 5255.421903590602, 5265.315508983846, 5305.708186049727, 5689.9146512802345, 5743.483086522233, 5754.108113242454, 5814.389489103583, 5878.0, 5547.1679248113105, 5553.4724201200825, 5554.888902221933, 5563.0, 5613.0, 5617.494425501643, 5621.100623900238, 5625.831225063254, 5641.041023026095, 5641.492265696025, 5612.382637909826, 5636.774529018875, 5637.492625663628, 5711.857203569944, 5718.027935251017, 5606.495415412633, 5667.943320566824, 5701.486866182064, 5710.229119068956, 5754.0, 4243.5119961204855, 4305.612494875476, 4320.524742278347, 4324.113556720928, 4354.412154359121, 3810.1427178885083, 3846.1730727893078, 3853.7880416576795, 3880.5925377835483, 3911.3741801311653, 5423.159410291411, 5456.0, 5457.045017121988, 5463.426340234298, 5482.890342193134, 5690.630109042899, 5737.971310143423, 5739.512141467939, 5747.3677895431465, 5748.885022299531, 5377.704226267515, 5422.15956526739, 5434.103372943499, 5471.753771080311, 5489.2589500417735, 4681.742504162304, 4712.410948631421, 4722.031983443386, 4781.235002399669, 4792.760361981887, 5943.70281485924, 5959.553033522503, 5961.880762384728, 5969.283685957713, 5980.192673988956, 5651.886962260732, 5698.11679189718, 5737.254156959569, 5744.0, 5770.047942089508, 5865.120231965239, 5882.499987500939, 5889.175515427929, 5890.823275301748, 5903.675297858487, 5460.453954604508, 5598.412166722598, 5600.131979543177, 5618.073017952155, 5621.606487545832, 5601.467860553241, 5665.546756259571, 5666.121751128581, 5681.431856814285, 5719.428057194247, 5504.422035686195, 5548.805791797267, 5549.889002220014, 5561.944380556304, 5561.972190139023, 5437.592180586393, 5538.141588053858, 5558.0, 5592.86017849557, 5594.468525490072, 5275.419703832498, 5377.408485066718, 5413.323334583177, 5528.695921724344, 5612.410696876769, 5524.889502210013, 5560.221568980265, 5566.554675626021, 5574.414686458026, 5586.798838249796, 5402.864928376822, 5487.451254874481, 5500.834974950758, 5512.090505066619, 5518.696471694096], "value": 5213.433431901727, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.844040549457, 643.4112786800079, 658.7463826426825, 663.290279401041, 670.7954074007429, 39011.80494097529, 39156.0, 39312.80343598278, 39460.60539394609, 39618.40572391409, 41310.0, 41841.790791046005, 42158.36762448558, 42321.788391058, 42398.57601423985, 8572.0570737219, 8718.607662655164, 8728.650853965833, 8734.0, 8834.38159328844, 8626.611802468904, 8724.171203735666, 8761.080086590911, 8963.372563920528, 8964.14840590143, 8889.511076890769, 8927.330450216226, 8936.151065648754, 8953.776155596097, 8961.865572016392, 8776.824463510726, 8814.118588141198, 8886.377953543255, 8896.777580560505, 8929.642814287421, 8806.823863522757, 8865.290776737846, 8879.644814207424, 8904.73285801427, 8910.732678019669, 42284.0, 42397.57602423998, 42622.0, 42632.0, 42730.78634606838, 3281.885134020322, 3465.3935561276676, 3522.8590856365713, 3761.849526018956, 3976.642102210786, 31679.683203167904, 32165.35669286601, 32441.513377299125, 32498.0, 32665.51001734976, 4242.596953289432, 4338.110687309094, 4341.261985462447, 4362.847300344504, 4370.628496577795, 293931.9551033681, 294940.5252973743, 295810.0, 295923.0, 296005.0, 36267.09332266715, 59930.700346497986, 60724.69637651784, 60819.0, 60870.39129608736, 34875.476867847, 35057.82471087628, 35084.824575877465, 35183.29633407317, 35234.0, 14838.70322593542, 14894.776578351333, 14952.850471495363, 15028.09831410119, 15036.17301048431, 12038.0, 12075.818862717066, 12133.817992729939, 12218.633440996784, 12270.570530031406, 8742.21320081183, 8743.475391476532, 8772.473651580925, 8820.8676869847, 8848.46909185451, 3233.611966564027, 3307.536944827726, 3327.6505966873615, 3346.7991920484847, 3383.5263063171174, 1021.371856308365, 1036.8548403223556, 1057.4983523396795, 1068.871735391758, 1109.4024604569395, 31389.37221255562, 31483.425828708932, 32075.198120047186, 32336.676633233837, 32555.837220813744, 1115.8493603363443, 1145.123980155182, 1162.6744511536783, 1170.1107158559555, 1228.969275768095, 16766.83233167677, 16824.242909069122, 16850.83149168517, 17016.0, 17228.569285767706, 447712.0, 459365.0, 460529.0, 460823.0, 461594.0, 58205.417945820845, 59348.95533879582, 59630.10554841681, 59785.701071495234, 59863.40136598578, 1280.206272111297, 1287.8132670762686, 1289.432649634158, 1312.5012495251742, 1315.2437348524636, 30298.394032119675, 32030.199245018128, 32096.35807283888, 32130.67869321277, 32160.51759223567, 51705.48294517157, 51793.482065180375, 51844.0, 51984.220236697234, 52196.73901630467, 395309.0, 396472.0, 397296.0, 398612.0, 398992.0, 28520.0, 29070.0, 43632.0, 44948.77525612482, 45252.321215182455, 40903.7954810236, 46708.766456167505, 46860.0, 47102.528974709814, 47182.528174717816, 39434.21131577295, 40295.39556906708, 40378.79810600928, 40830.387544187455, 41614.16771664489, 38824.835254942394, 39120.80439597898, 40211.0, 41997.79001104975, 42503.3624495639, 37404.81297593495, 38079.61920380872, 38751.03122421962, 38957.80521097376, 39164.80417597894, 33719.662803371655, 35131.47302790409, 35137.0, 35618.46572301469, 36057.639423605426, 27554.724452755217, 27696.861515692293, 27864.721352787023, 27989.300267493476, 28174.85912570424], "value": 18718.187332262416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.8866317431118, 406.7213958438472, 407.8592885454519, 408.5771226780281, 414.59122498284967, 13745.65635859104, 18004.639907201865, 18837.246510139594, 18872.0, 18999.145038473267, 17242.56893577658, 17261.741073883903, 17477.12614369283, 18450.44648660539, 18697.252109915586, 4967.379077615298, 5329.413764485923, 5631.324241091075, 5811.099279611667, 5848.2689663792025, 5285.0, 5290.232916227144, 5299.284596579451, 5316.441773613773, 5324.92012619811, 5699.430056994309, 6311.842203944892, 6332.303446620868, 6345.175127233453, 6348.492120630339, 5643.181738647873, 5695.088785794294, 6240.656763878008, 6287.308396076428, 6289.937100628981, 5416.9729151353995, 5420.457954204548, 5435.130379139318, 5449.7275136243425, 5456.372517160498, 12697.682557936034, 12841.550545730948, 13152.473901043946, 13173.34133293341, 13202.075854690176, 2365.8343915925893, 2430.963535546968, 2474.208253358926, 2689.1260340389454, 2912.8590485992777, 8463.915360846375, 8713.651453941835, 8733.606987685569, 8801.6039278232, 8947.776305592348, 1874.6438176746374, 1940.8253257206918, 1944.0474167657746, 1978.307592342683, 1995.4013795861329, 82335.58832205861, 83234.0, 84134.0, 84850.0, 85422.14577854204, 9989.900100999042, 10001.34991225568, 10032.899671003197, 10214.846777298346, 10381.792364152674, 13970.511032113827, 14009.85990140106, 14056.71886562263, 14069.85930140706, 14074.71850562983, 7852.254035866584, 7901.091374491892, 7903.604819759104, 7932.84134317322, 8072.959635201903, 7918.2477664621765, 7922.247386498273, 7975.042994840656, 8046.678132874619, 8100.635471403801, 4255.212785634668, 4255.702100852911, 4307.655387568987, 4465.508794032654, 4520.932186017212, 1687.4684474390529, 1757.7011907975675, 1765.618839921536, 1772.9468115956543, 1817.1277786662477, 968.7384406210425, 1008.7578981044496, 1035.1460045462522, 1043.400044974143, 1076.839476137539, 17528.82471175272, 18275.54311142232, 18542.536436589195, 18711.438656840317, 18725.0, 1008.2035192198082, 1023.6928921323573, 1026.4918865161792, 1078.3583767658388, 1082.6330113347483, 10146.340487868265, 10344.586216551254, 10351.689449316533, 10424.322419042737, 10461.476926153662, 441243.0, 445785.0, 447762.0, 448685.0, 459330.0, 69412.0, 82862.58568707117, 83500.58249708713, 91336.0, 94784.52607736917, 1049.8110340138849, 1060.9045185933303, 1083.1172594335592, 1119.3955264157428, 1127.0420142878652, 15736.685266294839, 15890.205489725698, 15905.681886361977, 15917.840821592099, 15967.0, 33674.83162584171, 33916.83041584776, 34764.82617586896, 35136.29727405387, 35611.82194089013, 51405.48594514007, 53233.733831332145, 54019.0, 54408.183877241085, 54469.45530544802, 7225.819354516179, 7615.581143037186, 7679.0, 8349.874751878848, 8505.0, 9285.48929808867, 12168.695782605506, 13351.532696355582, 13548.119372240773, 13557.186568805902, 12109.394530273275, 12366.443510042249, 12418.875811242133, 12448.25310481374, 12459.626211213677, 11867.406629668309, 11907.52369905194, 11947.044236460888, 12024.218425802295, 12399.070069744987, 12049.939750301193, 12278.263304201777, 12374.876251237372, 12392.75214495723, 12395.93802030984, 7198.280171982759, 7660.0, 8364.581770911553, 8438.409311348147, 8611.655533778829, 11444.542218311175, 11951.521939122338, 12208.572699955459, 12254.0, 12376.133670642968], "value": 8820.056365554594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.5284708893155, 1499.880009599232, 1632.975505367419, 1740.069063051268, 1772.8315809998046, 7447.441441891866, 8002.239787220205, 8034.638441270142, 8383.035950865653, 8429.620667069981, 8122.959385203066, 8219.0, 8222.835543289146, 8296.0, 8304.0, 2268.8071513921336, 2294.288770481156, 2295.357299956015, 2297.3911913342977, 2302.0, 2227.086894373307, 2242.8093612042994, 2243.932682019542, 2245.1692873636775, 2245.741739699931, 2257.7064981552376, 2261.163369553259, 2282.075759317479, 2304.2396009316885, 2313.1556981701724, 2113.080809847721, 2114.598226336999, 2114.9577008459746, 2126.1176611706123, 2131.6056529542084, 2154.5798569278995, 2155.568886222746, 2160.2763074370105, 2165.0257384177025, 2165.6859755335545, 8018.238267364591, 8048.31589314909, 8057.113717491071, 8077.8788318175275, 8128.471649342774, 5011.724355160465, 5172.0, 5181.663191892552, 5196.090684130299, 5202.0, 3125.2186953261685, 3210.4542227821094, 3344.3980083584943, 3375.696187343151, 3387.1532116970757, 1059.9364038157735, 1073.098597178374, 1075.876274228466, 1080.5353697909895, 1089.2756317049232, 11556.422178891105, 11722.70693232659, 11733.178677492579, 11774.411279435993, 11802.940985295105, 4437.29003359461, 4502.144592527409, 4619.122366750306, 4645.419322584677, 4750.049990002013, 10129.797404051878, 10243.7439064024, 10243.897561024443, 10249.38503689781, 10255.07704306616, 5322.148456246982, 5333.653312534673, 5341.4925582069645, 5343.946560534345, 5367.838964831061, 4091.734037287567, 4701.059788042405, 4708.458527269408, 4871.878203044952, 4921.753912304371, 4073.9388909166387, 4077.039133874912, 4094.406311084876, 4148.751074935453, 4163.146554956226, 1309.8166256724066, 1313.5271302331153, 1340.6112227454123, 1356.8168297279938, 1359.136948038003, 820.2781552234115, 953.2612225525273, 962.0956301076965, 973.3770386952356, 992.0823238504355, 5670.432956704297, 5727.0, 5796.333421656479, 5864.589478736533, 5949.0, 442.0, 445.44319600499375, 474.28383141456646, 476.77114984807486, 479.3480866022207, 3835.7890316032326, 3837.501124853807, 3862.864799731996, 3880.0881792778673, 3917.5103112110987, 10162.745931351776, 10801.459927003618, 10811.081058109992, 10848.349099053925, 10897.67306980792, 10617.84073238902, 10691.09125724322, 10703.892961070445, 10705.464726763787, 10754.56981720738, 7590.7722768317035, 8080.4343695940715, 8107.837843243102, 8167.101618821925, 8190.221928916743, 5756.481916627524, 5765.221695071112, 5868.031774757117, 5937.91093133612, 5958.702064896825, 9234.584443699916, 9714.757131071497, 9796.069373409515, 9834.459104749307, 9835.164011058854, 9553.0, 9690.273229507675, 9691.370060946016, 9737.513124343895, 9822.557984890555, 6632.071509988702, 7096.077509923677, 7159.856802863809, 7201.063861697946, 7484.25157484269, 7985.161558036322, 8006.19938006218, 8026.638801254075, 8058.959705201437, 8072.677092916218, 7133.928660713326, 7395.704171833282, 7411.221821708643, 7454.6645400956, 7468.4398670101045, 6847.21257055445, 6970.233274339717, 6983.3714965653335, 7037.753678621224, 7236.674349654173, 6088.360722124113, 6147.600405973598, 6162.630242185483, 6162.845928851814, 6178.783742568989, 4694.718316900997, 4864.829730959399, 4865.659403841697, 4876.512348765237, 4929.137400954747, 4831.178699621002, 4840.685355451885, 4842.7336496493035, 4877.463479017376, 4917.090338287285], "value": 4391.213200868419, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.0497510460043, 322.95155726641013, 324.0343775548864, 331.4398666254031, 336.11098644086394, 5876.5004974577105, 5888.470037696607, 5903.022487466698, 6021.548383871211, 6033.896950073948, 5980.700964951746, 6006.309274433442, 6014.909776353358, 6028.939710602893, 6033.879322413549, 4550.931736023946, 4566.452025756914, 4568.611668008215, 4599.080183963204, 4600.6549508786975, 4395.560443955595, 4573.131105090022, 4592.816287348502, 4596.609288210506, 4610.561996610333, 4525.818967241323, 4532.614727748145, 4537.364768932335, 4538.727676339414, 4541.931871021938, 4560.110778398213, 4577.725336479822, 4585.532629558543, 4592.862214133548, 4599.356090147382, 3679.5032670589394, 3836.3286424875537, 3858.344081506151, 4062.009615288517, 4066.715329926906, 5706.800261990852, 5733.770649174028, 5758.280214973129, 5765.394633563499, 5789.565782566325, 5143.12566863634, 5167.534921857014, 5180.248863914711, 5182.352205974254, 5198.480151984809, 5927.7925272615685, 6245.594036387665, 6259.37406259375, 6267.2165979252595, 6285.96857015712, 4288.378185163165, 4300.118475712503, 4311.1808756336195, 4313.503947046099, 4317.827286908519, 6294.8111556653375, 6510.316416776265, 6566.277709451956, 6579.671016449159, 6592.406683398469, 4332.176886391576, 4338.349247612883, 4351.108022855307, 4361.520232774392, 4371.344298355272, 4397.736135831797, 4402.603765661106, 4406.823727050946, 4411.250087485071, 4412.426384569985, 5093.4651861554, 5101.744912754348, 5141.177411614124, 5174.223866419992, 5187.0, 5889.734961926638, 5971.164037034819, 6119.877602448015, 6216.720247588779, 6303.699149810378, 1510.9848901511064, 1515.3332533685364, 1530.036077271312, 1535.4549135057118, 1536.784850120984, 993.4635296939716, 1005.070309963281, 1028.1106842581114, 1030.1964467715195, 1030.3560274828233, 6024.27708674953, 6041.758329666852, 6049.0, 6083.422074902877, 6115.663638499926, 6444.9355506444335, 6452.516061295328, 6457.677116144174, 6472.773452929125, 6474.643894585749, 5900.232969713909, 6021.367756385516, 6096.72564734588, 6103.572749907464, 6106.358832322631, 3459.41189997701, 3472.600650925176, 3487.633798451126, 3488.494168345576, 3499.2651543176216, 6600.636964966973, 6709.29552397001, 6718.529702920749, 6730.360615741497, 6749.312671832042, 6550.017497375432, 6554.115194448784, 6562.245341785756, 6576.243731970789, 6623.536352455282, 6563.573367731177, 6705.195376554844, 6706.53054286205, 6721.26066132725, 6726.091977583062, 6396.136521569715, 6402.679866006588, 6421.486281097407, 6424.229092508929, 6430.324815894451, 6128.785492507741, 6298.7480500781285, 6310.873782524415, 6375.936240637534, 6393.808185754435, 6825.419839313714, 6827.965860170667, 6877.449804015567, 6902.827429314308, 6927.411170050602, 4369.694121411598, 4379.299312110047, 4381.211381951151, 4394.2749446340995, 4408.911821763482, 6193.040078787795, 6357.4596159326975, 6386.882295598159, 6533.934660653333, 6538.248101468202, 6331.556791024584, 6338.619682818861, 6343.207099112611, 6345.428911397997, 6351.396617321347, 6192.628442293477, 6297.96851015742, 6333.113364129118, 6336.112944187909, 6348.9047664286, 6184.567080304336, 6200.658963757037, 6206.875862482815, 6211.596246243979, 6228.283747369111, 6210.472109870711, 6333.6882038054855, 6349.49204063683, 6383.8084857452495, 6390.329015453496, 6003.789867354796, 6162.260528736401, 6176.969115154396, 6197.4732147767945, 6206.286277078013], "value": 4713.662958953334, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.7512045904391, 747.0922828763053, 782.7221336425569, 785.0932173339795, 791.4697152907552, 12204.633860984162, 12248.510059597616, 12426.130170888042, 12566.994640428778, 13031.218126912392, 13894.652633684163, 13928.373223204955, 13961.162330260191, 13967.231802250897, 13974.3711532981, 831.3515457942814, 835.1231207232412, 836.9121242269565, 837.7738010737128, 839.0770152831867, 524.7769697878387, 805.2712295372697, 825.7729124490783, 828.9917100829005, 829.8215883585028, 869.7651634058832, 871.4379225399614, 874.3398733955854, 875.0199776250577, 880.1638443478721, 873.1792115411492, 873.6767396063466, 875.5140896802272, 875.689130358723, 875.8861348024716, 631.343402861024, 635.4471609699591, 637.3753721353054, 638.1353266324156, 638.2564312575844, 13259.73480530384, 13263.801042984363, 13310.534131305358, 13313.53402630913, 13370.665733356744, 13028.54400095992, 13100.737985240241, 13234.139780914209, 13288.601341959757, 13300.733985320336, 10161.441120738356, 10515.263931524796, 10563.683089507327, 10610.098141657969, 10676.946615266874, 3679.779213247187, 3699.741018128732, 3738.532683414573, 3766.548014238309, 3819.026148332185, 59087.0, 59099.0, 60343.396566034215, 60723.392766072655, 60985.39014609841, 10396.428196449267, 10447.110573922246, 10469.738256543495, 10559.577616895238, 10631.936806319307, 18476.907615461838, 18484.0, 18519.629607407776, 18527.0, 18574.071296435126, 7596.8480630387085, 7682.385409167253, 7707.614619269014, 7772.261635144652, 7894.64474098667, 4791.185498465269, 4794.880127996828, 4862.367892173995, 4871.80512779492, 4876.171050921352, 3149.3228955774616, 3200.3119329343835, 3220.0017994421805, 3228.8224147672104, 3234.3854667613077, 539.8920215956746, 550.6145698011408, 552.3509875895807, 552.6811496960726, 557.6013150597342, 705.5731282573969, 709.9112610923635, 715.5670819154441, 717.7810767715897, 726.5459088069956, 9133.360664753536, 9151.588178531982, 9227.538623068955, 9415.05849415053, 9535.713928582154, 646.6992848325457, 646.9191351081115, 698.979030629082, 707.4093132234539, 710.0698085508001, 4238.978805105955, 4408.25059739845, 4535.727856328631, 4567.977160114178, 4622.537746225418, 64151.0, 64308.35691643117, 65078.0, 65315.0, 65691.34308656852, 55595.44404555984, 55754.442455575736, 56942.0, 58518.0, 58564.707176463846, 51993.7400312996, 52491.73754131281, 53653.463465364846, 54452.0, 54554.18168727472, 8736.301095912184, 8779.385443019182, 8867.512286824287, 8870.73387798367, 8946.507942063248, 31951.0, 32114.0, 32258.677413225567, 32629.18427039343, 32678.509822352207, 44162.77918610515, 46613.533864660916, 46692.0, 46799.76600116977, 47655.28517072177, 11575.479103440197, 11711.0, 11724.70688232801, 11772.882271177179, 12054.819177712166, 12335.259884406963, 13118.672033199246, 13207.141535800141, 13732.244726540137, 13779.0, 12708.364581771059, 12723.618291451272, 13080.607581772561, 13247.0, 13393.397297121459, 12436.19164754288, 12823.102382833486, 12983.221006739626, 12993.740125197253, 13073.934630326787, 9771.657991970247, 12030.27818330868, 12348.073894457772, 12467.002639788976, 12604.621861344174, 10073.496325183565, 10122.0, 10361.63734269297, 10623.946880265548, 10771.246012779031, 9638.807223855623, 10251.692449226535, 10305.0, 10307.278490505592, 10368.0], "value": 6635.847353021436, "unit": "score"}], "name": "dromaeo_css", "value": 7005.779243391917, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 113.0, 113.0, 126.0, 112.0, 112.0, 111.0, 110.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 156.0, 186.0, 131.0, 155.0, 157.0, 131.0, 189.0, 135.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 161.0, 165.0, 170.0, 165.0, 159.0, 164.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 156.0, 76.0, 77.0, 76.0, 75.0, 154.0, 77.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 150.0, 92.0, 93.0, 93.0, 138.0, 92.0, 93.0, 142.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 120.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 146.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 63.0, 57.0, 56.0, 56.0, 55.0, 75.0, 55.0, 54.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 62.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 81.0, 85.0, 79.0, 77.0, 79.0, 79.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 128.0, 127.0, 128.0, 122.0, 124.0, 133.0, 164.0, 129.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 170.0, 167.0, 170.0, 167.0, 172.0, 173.0, 171.0, 165.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 71.0, 71.0, 71.0, 68.0, 67.0, 68.0, 70.0, 66.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1555.4, "alertThreshold": 2.0}]} 23:21:03 INFO - Return code: 0 23:21:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:21:04 ERROR - # TBPL SUCCESS # 23:21:04 INFO - Running post-action listener: _resource_record_post_action 23:21:04 INFO - Running post-run listener: _resource_record_post_run 23:21:05 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7802880; Write bytes: 290533376; Read time: 1592; Write time: 269844 23:21:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 35201024; Read time: 0; Write time: 18572 23:21:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6041600; Write bytes: 237072384; Read time: 1544; Write time: 240768 23:21:05 INFO - Running post-run listener: _upload_blobber_files 23:21:05 INFO - Blob upload gear active. 23:21:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:21:05 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 23:21:05 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:21:05 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:21:05 INFO - (blobuploader) - INFO - Open directory for files ... 23:21:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:21:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:21:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:06 INFO - (blobuploader) - INFO - Done attempting. 23:21:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:21:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:21:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:07 INFO - (blobuploader) - INFO - Done attempting. 23:21:07 INFO - (blobuploader) - INFO - Iteration through files over. 23:21:07 INFO - Return code: 0 23:21:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:21:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:21:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31bbcbd2c0769fe0883a9860049daba7cba55dd3cfd8ee126cb099afc6234169844219c1f93e505a5f600aac7d7914aa2f3b8f6cd6b6de654a4af6ec657cc538", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff2776d455ba188d6ac44305d261814c0afd317ef5db269d7a7689ccde56710763d94ed277730924e5c9b8508c885c84603a6e531b9cb5ec7b23c32c18e1d67"} 23:21:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:21:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:21:07 INFO - Contents: 23:21:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31bbcbd2c0769fe0883a9860049daba7cba55dd3cfd8ee126cb099afc6234169844219c1f93e505a5f600aac7d7914aa2f3b8f6cd6b6de654a4af6ec657cc538", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff2776d455ba188d6ac44305d261814c0afd317ef5db269d7a7689ccde56710763d94ed277730924e5c9b8508c885c84603a6e531b9cb5ec7b23c32c18e1d67"} 23:21:07 INFO - Running post-run listener: copy_logs_to_upload_dir 23:21:07 INFO - Copying logs to upload dir... 23:21:07 INFO - mkdir: /builds/slave/test/build/upload/logs 23:21:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.014509 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-15 23:21:07.320172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 23:21:07.323505) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31bbcbd2c0769fe0883a9860049daba7cba55dd3cfd8ee126cb099afc6234169844219c1f93e505a5f600aac7d7914aa2f3b8f6cd6b6de654a4af6ec657cc538", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff2776d455ba188d6ac44305d261814c0afd317ef5db269d7a7689ccde56710763d94ed277730924e5c9b8508c885c84603a6e531b9cb5ec7b23c32c18e1d67"} build_url:https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31bbcbd2c0769fe0883a9860049daba7cba55dd3cfd8ee126cb099afc6234169844219c1f93e505a5f600aac7d7914aa2f3b8f6cd6b6de654a4af6ec657cc538", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff2776d455ba188d6ac44305d261814c0afd317ef5db269d7a7689ccde56710763d94ed277730924e5c9b8508c885c84603a6e531b9cb5ec7b23c32c18e1d67"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 23:21:07.350186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:21:07.350914) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1460778461.159667-1090045682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004323 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:21:07.436004) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 23:21:07.436764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 23:21:07.437190) ========= ========= Total master_lag: 0.21 =========