builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1461285733.34 results: success (0) buildid: 20160421143016 builduid: f1fa9d5be8184b519847b8826bf2e3f0 revision: 2570cd8ec0bddf821299063db4094dbbaeccea04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:13.344301) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:13.361543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:13.361859) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:13.386428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:13.386773) ========= 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=1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 17:42:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.4M=0s 2016-04-21 17:42:13 (34.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:13.516385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:13.516706) ========= 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=1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017313 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:13.566075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 17:42:13.566428) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2570cd8ec0bddf821299063db4094dbbaeccea04 --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 2570cd8ec0bddf821299063db4094dbbaeccea04 --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=1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 17:42:13,844 truncating revision to first 12 chars 2016-04-21 17:42:13,844 Setting DEBUG logging. 2016-04-21 17:42:13,844 attempt 1/10 2016-04-21 17:42:13,844 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2570cd8ec0bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 17:42:14,680 unpacking tar archive at: fx-team-2570cd8ec0bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.140887 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 17:42:14.739915) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:14.740458) ========= script_repo_revision: 2570cd8ec0bddf821299063db4094dbbaeccea04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:14.741256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:14.741740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 17:42:14.785369) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-21 17:42:14.785852) ========= /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=1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:42:15 INFO - MultiFileLogger online at 20160421 17:42:15 in /builds/slave/test 17:42:15 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 17:42:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:15 INFO - {'append_to_log': False, 17:42:15 INFO - 'base_work_dir': '/builds/slave/test', 17:42:15 INFO - 'blob_upload_branch': 'Fx-Team', 17:42:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:15 INFO - 'branch': 'Fx-Team', 17:42:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:15 INFO - 'config_files': ('talos/linux_config.py',), 17:42:15 INFO - 'default_actions': ('clobber', 17:42:15 INFO - 'read-buildbot-config', 17:42:15 INFO - 'download-and-extract', 17:42:15 INFO - 'populate-webroot', 17:42:15 INFO - 'create-virtualenv', 17:42:15 INFO - 'install', 17:42:15 INFO - 'run-tests'), 17:42:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:15 INFO - 'download_minidump_stackwalk': True, 17:42:15 INFO - 'download_symbols': 'ondemand', 17:42:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:15 INFO - 'installer_path': 'installer.exe', 17:42:15 INFO - 'log_level': 'info', 17:42:15 INFO - 'log_name': 'talos', 17:42:15 INFO - 'log_to_console': True, 17:42:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:42:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:42:15 INFO - 'opt_config_files': (), 17:42:15 INFO - 'pip_index': False, 17:42:15 INFO - 'sps_profile': False, 17:42:15 INFO - 'sps_profile_interval': 0, 17:42:15 INFO - 'suite': 'dromaeojs-e10s', 17:42:15 INFO - 'system_bits': '32', 17:42:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:15 INFO - 'title': 'talos-linux64-ix-027', 17:42:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:15 INFO - 'use_talos_json': True, 17:42:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:15 INFO - 'work_dir': 'build'} 17:42:15 INFO - ##### 17:42:15 INFO - ##### Running clobber step. 17:42:15 INFO - ##### 17:42:15 INFO - Running pre-action listener: _resource_record_pre_action 17:42:15 INFO - Running main action method: clobber 17:42:15 INFO - rmtree: /builds/slave/test/build 17:42:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:42:15 INFO - Running post-action listener: _resource_record_post_action 17:42:15 INFO - ##### 17:42:15 INFO - ##### Running read-buildbot-config step. 17:42:15 INFO - ##### 17:42:15 INFO - Running pre-action listener: _resource_record_pre_action 17:42:15 INFO - Running main action method: read_buildbot_config 17:42:15 INFO - Using buildbot properties: 17:42:15 INFO - { 17:42:15 INFO - "project": "", 17:42:15 INFO - "product": "firefox", 17:42:15 INFO - "script_repo_revision": "production", 17:42:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:42:15 INFO - "repository": "", 17:42:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:42:15 INFO - "buildid": "20160421143016", 17:42:15 INFO - "pgo_build": "True", 17:42:15 INFO - "basedir": "/builds/slave/test", 17:42:15 INFO - "buildnumber": 674, 17:42:15 INFO - "slavename": "talos-linux64-ix-027", 17:42:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:42:15 INFO - "platform": "ubuntu64_hw", 17:42:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:42:15 INFO - "branch": "fx-team", 17:42:15 INFO - "repo_path": "integration/fx-team", 17:42:15 INFO - "revision": "2570cd8ec0bddf821299063db4094dbbaeccea04", 17:42:15 INFO - "stage_platform": "linux64-pgo", 17:42:15 INFO - "builduid": "f1fa9d5be8184b519847b8826bf2e3f0", 17:42:15 INFO - "slavebuilddir": "test" 17:42:15 INFO - } 17:42:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:42:15 INFO - Running post-action listener: _resource_record_post_action 17:42:15 INFO - ##### 17:42:15 INFO - ##### Running download-and-extract step. 17:42:15 INFO - ##### 17:42:15 INFO - Running pre-action listener: _resource_record_pre_action 17:42:15 INFO - Running main action method: download_and_extract 17:42:15 INFO - mkdir: /builds/slave/test/build/tests 17:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:15 INFO - https://queue.taskcluster.net/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:42:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:42:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:42:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:42:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:42:17 INFO - Downloaded 1361 bytes. 17:42:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:42:17 INFO - Using the following test package requirements: 17:42:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:42:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:42:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:42:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:17 INFO - u'jsshell-linux-x86_64.zip'], 17:42:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:42:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:42:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:42:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:42:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:42:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:42:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:17 INFO - https://queue.taskcluster.net/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:42:18 INFO - Downloaded 23847841 bytes. 17:42:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:42:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:42:19 INFO - Return code: 0 17:42:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:19 INFO - https://queue.taskcluster.net/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:42:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:42:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:42:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:42:21 INFO - Downloaded 23847841 bytes. 17:42:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:42:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:42:23 INFO - Return code: 0 17:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:23 INFO - https://queue.taskcluster.net/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:42:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:42:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:42:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:42:23 INFO - Downloaded 10845952 bytes. 17:42:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:42:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:42:24 INFO - Return code: 0 17:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:24 INFO - https://queue.taskcluster.net/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:42:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:42:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:42:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:42:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:42:27 INFO - Downloaded 58329382 bytes. 17:42:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:42:27 INFO - mkdir: /builds/slave/test/properties 17:42:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:42:27 INFO - Writing to file /builds/slave/test/properties/build_url 17:42:27 INFO - Contents: 17:42:27 INFO - build_url:https://queue.taskcluster.net/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:42:27 INFO - Running post-action listener: _resource_record_post_action 17:42:27 INFO - Running post-action listener: set_extra_try_arguments 17:42:27 INFO - ##### 17:42:27 INFO - ##### Running populate-webroot step. 17:42:27 INFO - ##### 17:42:27 INFO - Running pre-action listener: _resource_record_pre_action 17:42:27 INFO - Running main action method: populate_webroot 17:42:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:42:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:42:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:42:27 INFO - '--tppagecycles', 17:42:27 INFO - '7'], 17:42:27 INFO - 'tests': ['tsvgm']}}, 17:42:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:42:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:42:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:42:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:42:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:42:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:42:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:27 INFO - 'talos_options': ['--disable-e10s'], 17:42:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:27 INFO - 'talos_options': ['--disable-e10s'], 17:42:27 INFO - 'tests': ['damp', 'tps']}, 17:42:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:27 INFO - 'tests': ['damp', 'tps']}, 17:42:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:42:27 INFO - 'tests': ['dromaeo_dom']}, 17:42:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:42:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:42:27 INFO - 'tests': ['a11yr', 17:42:27 INFO - 'ts_paint', 17:42:27 INFO - 'tpaint', 17:42:27 INFO - 'sessionrestore', 17:42:27 INFO - 'sessionrestore_no_auto_restore', 17:42:27 INFO - 'tabpaint']}, 17:42:27 INFO - 'other-e10s': {'tests': ['a11yr', 17:42:27 INFO - 'ts_paint', 17:42:27 INFO - 'tpaint', 17:42:27 INFO - 'sessionrestore', 17:42:27 INFO - 'sessionrestore_no_auto_restore', 17:42:27 INFO - 'tabpaint']}, 17:42:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:42:27 INFO - 'ts_paint', 17:42:27 INFO - 'tpaint', 17:42:27 INFO - 'sessionrestore', 17:42:27 INFO - 'sessionrestore_no_auto_restore', 17:42:27 INFO - 'tabpaint']}, 17:42:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:42:27 INFO - 'ts_paint', 17:42:27 INFO - 'tpaint', 17:42:27 INFO - 'sessionrestore', 17:42:27 INFO - 'sessionrestore_no_auto_restore', 17:42:27 INFO - 'tabpaint']}, 17:42:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:42:27 INFO - 'tests': ['a11yr', 17:42:27 INFO - 'ts_paint', 17:42:27 INFO - 'tpaint', 17:42:27 INFO - 'sessionrestore', 17:42:27 INFO - 'sessionrestore_no_auto_restore', 17:42:27 INFO - 'tabpaint']}, 17:42:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:42:27 INFO - 'tests': ['a11yr', 17:42:27 INFO - 'ts_paint', 17:42:27 INFO - 'tpaint', 17:42:27 INFO - 'sessionrestore', 17:42:27 INFO - 'sessionrestore_no_auto_restore', 17:42:27 INFO - 'tabpaint']}, 17:42:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:42:27 INFO - 'tests': ['tsvgx', 17:42:27 INFO - 'tsvgr_opacity', 17:42:27 INFO - 'tart', 17:42:27 INFO - 'tscrollx', 17:42:27 INFO - 'cart']}, 17:42:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:42:27 INFO - 'tsvgr_opacity', 17:42:27 INFO - 'tart', 17:42:27 INFO - 'tscrollx', 17:42:27 INFO - 'cart']}, 17:42:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:27 INFO - 'talos_options': ['--disable-e10s'], 17:42:27 INFO - 'tests': ['tp5o']}, 17:42:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:27 INFO - 'tests': ['tp5o']}, 17:42:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:27 INFO - 'talos_options': ['--disable-e10s', 17:42:27 INFO - '--xperf_path', 17:42:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:27 INFO - 'tests': ['tp5n']}, 17:42:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:27 INFO - 'talos_options': ['--xperf_path', 17:42:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:27 INFO - 'tests': ['tp5n']}}, 17:42:27 INFO - 'talos.zip': {'path': '', 17:42:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:42:27 INFO - Running post-action listener: _resource_record_post_action 17:42:27 INFO - ##### 17:42:27 INFO - ##### Running create-virtualenv step. 17:42:27 INFO - ##### 17:42:27 INFO - Running pre-action listener: _resource_record_pre_action 17:42:27 INFO - Running main action method: create_virtualenv 17:42:27 INFO - Creating virtualenv /builds/slave/test/build/venv 17:42:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:42:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:42:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:42:28 INFO - Using real prefix '/usr' 17:42:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:42:28 INFO - Installing distribute.............................................................................................................................................................................................done. 17:42:30 INFO - Installing pip.................done. 17:42:30 INFO - Return code: 0 17:42:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:30 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 0x7f80ac436f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb410>, '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 0x22fc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fc7a0>, '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': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:42:30 INFO - Using env: {'DISPLAY': ':0', 17:42:30 INFO - 'HOME': '/home/cltbld', 17:42:30 INFO - 'LANG': 'en_US.UTF-8', 17:42:30 INFO - 'LANGUAGE': 'en_US:en', 17:42:30 INFO - 'LOGNAME': 'cltbld', 17:42:30 INFO - 'MAIL': '/var/mail/cltbld', 17:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:30 INFO - 'MOZ_NO_REMOTE': '1', 17:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:30 INFO - 'NO_EM_RESTART': '1', 17:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:30 INFO - 'PWD': '/builds/slave/test', 17:42:30 INFO - 'SHELL': '/bin/bash', 17:42:30 INFO - 'SHLVL': '1', 17:42:30 INFO - 'TERM': 'linux', 17:42:30 INFO - 'TMOUT': '86400', 17:42:30 INFO - 'USER': 'cltbld', 17:42:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 17:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:30 INFO - '_': '/tools/buildbot/bin/python'} 17:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:42:30 INFO - Cleaning up... 17:42:30 INFO - Return code: 0 17:42:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:30 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 0x7f80ac436f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb410>, '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 0x22fc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fc7a0>, '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': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:42:30 INFO - Using env: {'DISPLAY': ':0', 17:42:30 INFO - 'HOME': '/home/cltbld', 17:42:30 INFO - 'LANG': 'en_US.UTF-8', 17:42:30 INFO - 'LANGUAGE': 'en_US:en', 17:42:30 INFO - 'LOGNAME': 'cltbld', 17:42:30 INFO - 'MAIL': '/var/mail/cltbld', 17:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:30 INFO - 'MOZ_NO_REMOTE': '1', 17:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:30 INFO - 'NO_EM_RESTART': '1', 17:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:30 INFO - 'PWD': '/builds/slave/test', 17:42:30 INFO - 'SHELL': '/bin/bash', 17:42:30 INFO - 'SHLVL': '1', 17:42:30 INFO - 'TERM': 'linux', 17:42:30 INFO - 'TMOUT': '86400', 17:42:30 INFO - 'USER': 'cltbld', 17:42:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 17:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:30 INFO - '_': '/tools/buildbot/bin/python'} 17:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:30 INFO - Downloading/unpacking psutil>=0.7.1 17:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:42:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:32 INFO - Installing collected packages: psutil 17:42:32 INFO - Running setup.py install for psutil 17:42:32 INFO - building 'psutil._psutil_linux' extension 17:42:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:42:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:42:33 INFO - building 'psutil._psutil_posix' extension 17:42:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:42:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:42:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:33 INFO - Successfully installed psutil 17:42:33 INFO - Cleaning up... 17:42:33 INFO - Return code: 0 17:42:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:33 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 0x7f80ac436f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb410>, '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 0x22fc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fc7a0>, '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': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:42:33 INFO - Using env: {'DISPLAY': ':0', 17:42:33 INFO - 'HOME': '/home/cltbld', 17:42:33 INFO - 'LANG': 'en_US.UTF-8', 17:42:33 INFO - 'LANGUAGE': 'en_US:en', 17:42:33 INFO - 'LOGNAME': 'cltbld', 17:42:33 INFO - 'MAIL': '/var/mail/cltbld', 17:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:33 INFO - 'MOZ_NO_REMOTE': '1', 17:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:33 INFO - 'NO_EM_RESTART': '1', 17:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:33 INFO - 'PWD': '/builds/slave/test', 17:42:33 INFO - 'SHELL': '/bin/bash', 17:42:33 INFO - 'SHLVL': '1', 17:42:33 INFO - 'TERM': 'linux', 17:42:33 INFO - 'TMOUT': '86400', 17:42:33 INFO - 'USER': 'cltbld', 17:42:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 17:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:33 INFO - '_': '/tools/buildbot/bin/python'} 17:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:42:35 INFO - Installing collected packages: mozsystemmonitor 17:42:35 INFO - Running setup.py install for mozsystemmonitor 17:42:35 INFO - Successfully installed mozsystemmonitor 17:42:35 INFO - Cleaning up... 17:42:35 INFO - Return code: 0 17:42:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:35 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 0x7f80ac436f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb410>, '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 0x22fc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fc7a0>, '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': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:42:35 INFO - Using env: {'DISPLAY': ':0', 17:42:35 INFO - 'HOME': '/home/cltbld', 17:42:35 INFO - 'LANG': 'en_US.UTF-8', 17:42:35 INFO - 'LANGUAGE': 'en_US:en', 17:42:35 INFO - 'LOGNAME': 'cltbld', 17:42:35 INFO - 'MAIL': '/var/mail/cltbld', 17:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:35 INFO - 'MOZ_NO_REMOTE': '1', 17:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:35 INFO - 'NO_EM_RESTART': '1', 17:42:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:35 INFO - 'PWD': '/builds/slave/test', 17:42:35 INFO - 'SHELL': '/bin/bash', 17:42:35 INFO - 'SHLVL': '1', 17:42:35 INFO - 'TERM': 'linux', 17:42:35 INFO - 'TMOUT': '86400', 17:42:35 INFO - 'USER': 'cltbld', 17:42:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 17:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:35 INFO - '_': '/tools/buildbot/bin/python'} 17:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:35 INFO - Downloading/unpacking blobuploader==1.2.4 17:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:38 INFO - Downloading docopt-0.6.1.tar.gz 17:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:38 INFO - Running setup.py install for blobuploader 17:42:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:38 INFO - Running setup.py install for requests 17:42:39 INFO - Running setup.py install for docopt 17:42:39 INFO - Successfully installed blobuploader requests docopt 17:42:39 INFO - Cleaning up... 17:42:39 INFO - Return code: 0 17:42:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:39 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 0x7f80ac436f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb410>, '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 0x22fc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fc7a0>, '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': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:42:39 INFO - Using env: {'DISPLAY': ':0', 17:42:39 INFO - 'HOME': '/home/cltbld', 17:42:39 INFO - 'LANG': 'en_US.UTF-8', 17:42:39 INFO - 'LANGUAGE': 'en_US:en', 17:42:39 INFO - 'LOGNAME': 'cltbld', 17:42:39 INFO - 'MAIL': '/var/mail/cltbld', 17:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:39 INFO - 'MOZ_NO_REMOTE': '1', 17:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:39 INFO - 'NO_EM_RESTART': '1', 17:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:39 INFO - 'PWD': '/builds/slave/test', 17:42:39 INFO - 'SHELL': '/bin/bash', 17:42:39 INFO - 'SHLVL': '1', 17:42:39 INFO - 'TERM': 'linux', 17:42:39 INFO - 'TMOUT': '86400', 17:42:39 INFO - 'USER': 'cltbld', 17:42:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 17:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:39 INFO - '_': '/tools/buildbot/bin/python'} 17:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:39 INFO - Running setup.py (path:/tmp/pip-W_lgBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:39 INFO - Running setup.py (path:/tmp/pip-Tt7Yqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:39 INFO - Running setup.py (path:/tmp/pip-q9wx20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:39 INFO - Running setup.py (path:/tmp/pip-PUkjLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:39 INFO - Running setup.py (path:/tmp/pip-jtg6SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:39 INFO - Running setup.py (path:/tmp/pip-IbiK4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:39 INFO - Running setup.py (path:/tmp/pip-GImFzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:39 INFO - Running setup.py (path:/tmp/pip-SgJJpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:39 INFO - Running setup.py (path:/tmp/pip-nHTNeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:40 INFO - Running setup.py (path:/tmp/pip-hfCLaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:40 INFO - Running setup.py (path:/tmp/pip-Y_pDxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:40 INFO - Running setup.py (path:/tmp/pip-gNAVn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:40 INFO - Running setup.py (path:/tmp/pip-EtSmEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:40 INFO - Running setup.py (path:/tmp/pip-F3ilts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:40 INFO - Running setup.py (path:/tmp/pip-bbBwme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:40 INFO - Running setup.py (path:/tmp/pip-nB_UsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:40 INFO - Running setup.py (path:/tmp/pip-PttqzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:42:40 INFO - Running setup.py install for manifestparser 17:42:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:42:40 INFO - Running setup.py install for mozcrash 17:42:40 INFO - Running setup.py install for mozdebug 17:42:40 INFO - Running setup.py install for mozdevice 17:42:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Running setup.py install for mozfile 17:42:41 INFO - Running setup.py install for mozhttpd 17:42:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Running setup.py install for mozinfo 17:42:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Running setup.py install for mozInstall 17:42:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Running setup.py install for mozleak 17:42:41 INFO - Running setup.py install for mozlog 17:42:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Running setup.py install for moznetwork 17:42:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Running setup.py install for mozprocess 17:42:41 INFO - Running setup.py install for mozprofile 17:42:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:42:41 INFO - Running setup.py install for mozrunner 17:42:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:42:42 INFO - Running setup.py install for mozscreenshot 17:42:42 INFO - Running setup.py install for moztest 17:42:42 INFO - Running setup.py install for mozversion 17:42:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:42:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:42:42 INFO - Cleaning up... 17:42:42 INFO - Return code: 0 17:42:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:42 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 0x7f80ac436f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb410>, '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 0x22fc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fc7a0>, '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': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:42:42 INFO - Using env: {'DISPLAY': ':0', 17:42:42 INFO - 'HOME': '/home/cltbld', 17:42:42 INFO - 'LANG': 'en_US.UTF-8', 17:42:42 INFO - 'LANGUAGE': 'en_US:en', 17:42:42 INFO - 'LOGNAME': 'cltbld', 17:42:42 INFO - 'MAIL': '/var/mail/cltbld', 17:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:42 INFO - 'MOZ_NO_REMOTE': '1', 17:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:42 INFO - 'NO_EM_RESTART': '1', 17:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:42 INFO - 'PWD': '/builds/slave/test', 17:42:42 INFO - 'SHELL': '/bin/bash', 17:42:42 INFO - 'SHLVL': '1', 17:42:42 INFO - 'TERM': 'linux', 17:42:42 INFO - 'TMOUT': '86400', 17:42:42 INFO - 'USER': 'cltbld', 17:42:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 17:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:42 INFO - '_': '/tools/buildbot/bin/python'} 17:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:42 INFO - Running setup.py (path:/tmp/pip-LcdMdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:42 INFO - Running setup.py (path:/tmp/pip-0KHJny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:42 INFO - Running setup.py (path:/tmp/pip-h_ig7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:42 INFO - Running setup.py (path:/tmp/pip-cUwOgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:42 INFO - Running setup.py (path:/tmp/pip-gtceIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:42 INFO - Running setup.py (path:/tmp/pip-yrRWqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:43 INFO - Running setup.py (path:/tmp/pip-AvOaD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:43 INFO - Running setup.py (path:/tmp/pip-hyFP0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:43 INFO - Running setup.py (path:/tmp/pip-NmwXJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:43 INFO - Running setup.py (path:/tmp/pip-G5iYmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:43 INFO - Running setup.py (path:/tmp/pip-XlXukY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:43 INFO - Running setup.py (path:/tmp/pip-auRlJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:43 INFO - Running setup.py (path:/tmp/pip-222jqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:43 INFO - Running setup.py (path:/tmp/pip-AjtyOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:43 INFO - Running setup.py (path:/tmp/pip-iPRzNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:43 INFO - Running setup.py (path:/tmp/pip-oGmhNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:43 INFO - Running setup.py (path:/tmp/pip-yNbbky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:45 INFO - Downloading blessings-1.6.tar.gz 17:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:42:45 INFO - Installing collected packages: blessings 17:42:45 INFO - Running setup.py install for blessings 17:42:45 INFO - Successfully installed blessings 17:42:45 INFO - Cleaning up... 17:42:46 INFO - Return code: 0 17:42:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:42:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:46 INFO - Reading from file tmpfile_stdout 17:42:46 INFO - Current package versions: 17:42:46 INFO - argparse == 1.2.1 17:42:46 INFO - blessings == 1.6 17:42:46 INFO - blobuploader == 1.2.4 17:42:46 INFO - docopt == 0.6.1 17:42:46 INFO - manifestparser == 1.1 17:42:46 INFO - mozInstall == 1.12 17:42:46 INFO - mozcrash == 0.17 17:42:46 INFO - mozdebug == 0.1 17:42:46 INFO - mozdevice == 0.48 17:42:46 INFO - mozfile == 1.2 17:42:46 INFO - mozhttpd == 0.7 17:42:46 INFO - mozinfo == 0.9 17:42:46 INFO - mozleak == 0.1 17:42:46 INFO - mozlog == 3.1 17:42:46 INFO - moznetwork == 0.27 17:42:46 INFO - mozprocess == 0.22 17:42:46 INFO - mozprofile == 0.28 17:42:46 INFO - mozrunner == 6.11 17:42:46 INFO - mozscreenshot == 0.1 17:42:46 INFO - mozsystemmonitor == 0.0 17:42:46 INFO - moztest == 0.7 17:42:46 INFO - mozversion == 1.4 17:42:46 INFO - psutil == 3.1.1 17:42:46 INFO - requests == 1.2.3 17:42:46 INFO - wsgiref == 0.1.2 17:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:46 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 0x7f80ac436f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb410>, '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 0x22fc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fc7a0>, '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': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:42:46 INFO - Using env: {'DISPLAY': ':0', 17:42:46 INFO - 'HOME': '/home/cltbld', 17:42:46 INFO - 'LANG': 'en_US.UTF-8', 17:42:46 INFO - 'LANGUAGE': 'en_US:en', 17:42:46 INFO - 'LOGNAME': 'cltbld', 17:42:46 INFO - 'MAIL': '/var/mail/cltbld', 17:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:46 INFO - 'MOZ_NO_REMOTE': '1', 17:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:46 INFO - 'NO_EM_RESTART': '1', 17:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:46 INFO - 'PWD': '/builds/slave/test', 17:42:46 INFO - 'SHELL': '/bin/bash', 17:42:46 INFO - 'SHLVL': '1', 17:42:46 INFO - 'TERM': 'linux', 17:42:46 INFO - 'TMOUT': '86400', 17:42:46 INFO - 'USER': 'cltbld', 17:42:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 17:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:46 INFO - '_': '/tools/buildbot/bin/python'} 17:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:42:46 INFO - Cleaning up... 17:42:46 INFO - Return code: 0 17:42:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:46 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 0x7f80ac436f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb410>, '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 0x22fc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fc7a0>, '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': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:42:46 INFO - Using env: {'DISPLAY': ':0', 17:42:46 INFO - 'HOME': '/home/cltbld', 17:42:46 INFO - 'LANG': 'en_US.UTF-8', 17:42:46 INFO - 'LANGUAGE': 'en_US:en', 17:42:46 INFO - 'LOGNAME': 'cltbld', 17:42:46 INFO - 'MAIL': '/var/mail/cltbld', 17:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:46 INFO - 'MOZ_NO_REMOTE': '1', 17:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:46 INFO - 'NO_EM_RESTART': '1', 17:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:46 INFO - 'PWD': '/builds/slave/test', 17:42:46 INFO - 'SHELL': '/bin/bash', 17:42:46 INFO - 'SHLVL': '1', 17:42:46 INFO - 'TERM': 'linux', 17:42:46 INFO - 'TMOUT': '86400', 17:42:46 INFO - 'USER': 'cltbld', 17:42:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 17:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:46 INFO - '_': '/tools/buildbot/bin/python'} 17:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:46 INFO - Downloading/unpacking jsonschema 17:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:48 INFO - Downloading/unpacking functools32 (from jsonschema) 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:48 INFO - warning: no files found matching '*.txt' 17:42:48 INFO - no previously-included directories found matching 'build' 17:42:48 INFO - no previously-included directories found matching 'dist' 17:42:48 INFO - no previously-included directories found matching '.git*' 17:42:48 INFO - Installing collected packages: jsonschema, functools32 17:42:48 INFO - Running setup.py install for functools32 17:42:48 INFO - warning: no files found matching '*.txt' 17:42:48 INFO - no previously-included directories found matching 'build' 17:42:48 INFO - no previously-included directories found matching 'dist' 17:42:48 INFO - no previously-included directories found matching '.git*' 17:42:48 INFO - Successfully installed jsonschema functools32 17:42:48 INFO - Cleaning up... 17:42:49 INFO - Return code: 0 17:42:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80ac436f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb410>, '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 0x22fc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fc7a0>, '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': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:42:49 INFO - Using env: {'DISPLAY': ':0', 17:42:49 INFO - 'HOME': '/home/cltbld', 17:42:49 INFO - 'LANG': 'en_US.UTF-8', 17:42:49 INFO - 'LANGUAGE': 'en_US:en', 17:42:49 INFO - 'LOGNAME': 'cltbld', 17:42:49 INFO - 'MAIL': '/var/mail/cltbld', 17:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:49 INFO - 'MOZ_NO_REMOTE': '1', 17:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:49 INFO - 'NO_EM_RESTART': '1', 17:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:49 INFO - 'PWD': '/builds/slave/test', 17:42:49 INFO - 'SHELL': '/bin/bash', 17:42:49 INFO - 'SHLVL': '1', 17:42:49 INFO - 'TERM': 'linux', 17:42:49 INFO - 'TMOUT': '86400', 17:42:49 INFO - 'USER': 'cltbld', 17:42:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 17:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:49 INFO - '_': '/tools/buildbot/bin/python'} 17:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:49 INFO - Downloading/unpacking flake8 17:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:42:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:42:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:42:51 INFO - no previously-included directories found matching 'docs/_build' 17:42:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:42:51 INFO - Running setup.py install for pep8 17:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:42:51 INFO - no previously-included directories found matching 'docs/_build' 17:42:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:42:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:42:51 INFO - Cleaning up... 17:42:52 INFO - Return code: 0 17:42:52 INFO - Running post-action listener: _resource_record_post_action 17:42:52 INFO - Running post-action listener: _start_resource_monitoring 17:42:52 INFO - Starting resource monitoring. 17:42:52 INFO - ##### 17:42:52 INFO - ##### Running install step. 17:42:52 INFO - ##### 17:42:52 INFO - Running pre-action listener: _resource_record_pre_action 17:42:52 INFO - Running main action method: install 17:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:52 INFO - Reading from file tmpfile_stdout 17:42:52 INFO - Detecting whether we're running mozinstall >=1.0... 17:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:42:52 INFO - Reading from file tmpfile_stdout 17:42:52 INFO - Output received: 17:42:52 INFO - Usage: mozinstall [options] installer 17:42:52 INFO - Options: 17:42:52 INFO - -h, --help show this help message and exit 17:42:52 INFO - -d DEST, --destination=DEST 17:42:52 INFO - Directory to install application into. [default: 17:42:52 INFO - "/builds/slave/test"] 17:42:52 INFO - --app=APP Application being installed. [default: firefox] 17:42:52 INFO - mkdir: /builds/slave/test/build/application 17:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:43:08 INFO - Reading from file tmpfile_stdout 17:43:08 INFO - Output received: 17:43:08 INFO - /builds/slave/test/build/application/firefox/firefox 17:43:08 INFO - Running post-action listener: _resource_record_post_action 17:43:08 INFO - ##### 17:43:08 INFO - ##### Running run-tests step. 17:43:08 INFO - ##### 17:43:08 INFO - Running pre-action listener: _resource_record_pre_action 17:43:08 INFO - Running main action method: run_tests 17:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:43:08 INFO - Python 2.7.3 17:43:08 INFO - Return code: 0 17:43:08 INFO - grabbing minidump binary from tooltool 17:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:08 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 0x22fb410>, '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 0x22fc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:43:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:43:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:43:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:43:08 INFO - Return code: 0 17:43:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:43:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:43:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:43:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:43:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:43:09 INFO - Return code: 0 17:43:09 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/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 17:43:09 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/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 17:43:09 INFO - Using env: {'DISPLAY': ':0', 17:43:09 INFO - 'HOME': '/home/cltbld', 17:43:09 INFO - 'LANG': 'en_US.UTF-8', 17:43:09 INFO - 'LANGUAGE': 'en_US:en', 17:43:09 INFO - 'LOGNAME': 'cltbld', 17:43:09 INFO - 'MAIL': '/var/mail/cltbld', 17:43:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:43:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:09 INFO - 'MOZ_NO_REMOTE': '1', 17:43:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:09 INFO - 'NO_EM_RESTART': '1', 17:43:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:09 INFO - 'PWD': '/builds/slave/test', 17:43:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:43:09 INFO - 'SHELL': '/bin/bash', 17:43:09 INFO - 'SHLVL': '1', 17:43:09 INFO - 'TERM': 'linux', 17:43:09 INFO - 'TMOUT': '86400', 17:43:09 INFO - 'USER': 'cltbld', 17:43:09 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627', 17:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:09 INFO - '_': '/tools/buildbot/bin/python'} 17:43:09 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/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 17:43:10 INFO - mozversion application_buildid: 20160421143016 17:43:10 INFO - mozversion application_changeset: 2570cd8ec0bddf821299063db4094dbbaeccea04 17:43:10 INFO - mozversion application_display_name: Nightly 17:43:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:43:10 INFO - mozversion application_name: Firefox 17:43:10 INFO - mozversion application_remotingname: firefox 17:43:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:43:10 INFO - mozversion application_vendor: Mozilla 17:43:10 INFO - mozversion application_version: 48.0a1 17:43:10 INFO - mozversion platform_buildid: 20160421143016 17:43:10 INFO - mozversion platform_changeset: 2570cd8ec0bddf821299063db4094dbbaeccea04 17:43:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:43:10 INFO - mozversion platform_version: 48.0a1 17:43:10 INFO - using testdate: 1461285790 17:43:10 INFO - actual date: 1461285790 17:43:10 INFO - starting webserver on 'localhost:58268' 17:43:10 INFO - SUITE-START | Running 2 tests 17:43:10 INFO - TEST-START | dromaeo_css 17:43:10 INFO - operating with platform_type : linux_ 17:43:10 INFO - Initialising browser for dromaeo_css test... 17:43:10 INFO - TEST-INFO | started process 30475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKToBhH/profile http://localhost:58268/getInfo.html) 17:43:13 INFO - PROCESS | 30475 | 17:43:13 INFO - PROCESS | 30475 | (process:30541): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:43:14 INFO - PROCESS | 30475 | __metrics Screen width/height:1600/1200 17:43:14 INFO - PROCESS | 30475 | colorDepth:24 17:43:14 INFO - PROCESS | 30475 | Browser inner width/height: 1024/697 17:43:14 INFO - PROCESS | 30475 | __metrics 17:43:14 ERROR - PROCESS | 30475 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:43:15 INFO - TEST-INFO | 30475: exit 0 17:43:15 INFO - Browser initialized. 17:43:15 INFO - Running cycle 1/1 for dromaeo_css test... 17:43:15 INFO - TEST-INFO | started process 30592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKToBhH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:17 INFO - PROCESS | 30592 | 17:43:17 INFO - PROCESS | 30592 | (process:30654): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:43:27 INFO - PROCESS | 30592 | RSS: Main: 163721216 17:43:27 INFO - PROCESS | 30592 | 17:44:17 INFO - PROCESS | 30592 | 1461285857017 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:46:24 INFO - PROCESS | 30592 | Cycle 1(1): loaded http://localhost:58268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58268/tests/dromaeo/cssquery-ext.html) 17:46:25 INFO - PROCESS | 30592 | RSS: Main: 168779776 17:46:25 INFO - PROCESS | 30592 | 17:49:27 INFO - PROCESS | 30592 | Cycle 1(1): loaded http://localhost:58268/tests/dromaeo/cssquery-ext.html (next: http://localhost:58268/tests/dromaeo/cssquery-jquery.html) 17:49:28 INFO - PROCESS | 30592 | RSS: Main: 165679104 17:49:28 INFO - PROCESS | 30592 | 17:52:30 INFO - PROCESS | 30592 | Cycle 1(1): loaded http://localhost:58268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58268/tests/dromaeo/cssquery-mootools.html) 17:52:30 INFO - PROCESS | 30592 | RSS: Main: 166543360 17:52:30 INFO - PROCESS | 30592 | 17:55:32 INFO - PROCESS | 30592 | Cycle 1(1): loaded http://localhost:58268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58268/tests/dromaeo/cssquery-prototype.html) 17:55:32 INFO - PROCESS | 30592 | RSS: Main: 164184064 17:55:32 INFO - PROCESS | 30592 | 17:58:35 INFO - PROCESS | 30592 | Cycle 1(1): loaded http://localhost:58268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58268/tests/dromaeo/cssquery-yui.html) 17:58:35 INFO - PROCESS | 30592 | RSS: Main: 165818368 17:58:35 INFO - PROCESS | 30592 | 18:01:38 INFO - PROCESS | 30592 | Cycle 1(1): loaded http://localhost:58268/tests/dromaeo/cssquery-yui.html (next: http://localhost:58268/tests/dromaeo/cssquery-dojo.html) 18:01:38 INFO - PROCESS | 30592 | RSS: Main: 167653376 18:01:38 INFO - PROCESS | 30592 | 18:01:38 INFO - PROCESS | 30592 | __start_tp_report 18:01:38 INFO - PROCESS | 30592 | _x_x_mozilla_page_load 18:01:38 INFO - PROCESS | 30592 | _x_x_mozilla_page_load_details 18:01:38 INFO - PROCESS | 30592 | |i|pagename|runs| 18:01:38 INFO - PROCESS | 30592 | |0;dojo.html;3088.9227769305767;3153.905382838514;3179.936401271973;3206.342699746551;3207.3424947885687;5248.89502209956;5303.178007408857;5344.919826202605;5347.545458636011;5371.113766228573;5230;5236.188390799422;5321.4412486688825;5346.4118946915905;5361.624686271963;4816.783244753986;4835.975820120894;4877.244027175776;4927.088488629597;4929.5316944890355;856.1437356806945;4803.231482962727;4852.514748525155;4870.293807397925;4891.975540122312;4831.347768051339;4837.467878533376;4848.17581011229;4860.975695121537;4905.730184839832;4672.766361681936;4910.263460480921;4933.975330123362;4944.579710724593;4986.4265609455015;4642.86071417858;4679.766011699401;4810.278458231258;4846.7576621169155;4861.295112208745;5214;5216.37403511581;5224.582033437316;5254.894902101974;5302.92045619316;5648.3222013358245;5653.293338332708;5671.943280567183;5672.744726487318;5750;5586.13414920688;5590.832275031756;5594.468525490112;5595.496405323541;5644.6330988485615;5227.26818245446;5231.136862417697;5234.6335756497065;5236.81671141512;5292.417834038252;5702.2301989231755;5739.196512488255;5814.680192589448;5839.211706419664;5863.20846685692;5449.509544141047;5471;5493.313335833021;5498.5876059294915;5501.202325662756;5571.470710282517;5571.9721401392735;5580.441955804387;5590.832275031756;5621.213030175779;5459.153831156177;5531.778728850801;5616.129499927518;5700;5707.600467967285;5430.945690543123;5587.552995760329;5598.44015598445;5658.179563963202;5700.344460387026;4256.553061928515;4275.8882690500695;4300.849470268526;4301.913961720748;4326.524082350938;3816.8740221634685;3830.540335159743;3861.1119442528375;3887.028242939265;3913.099987002948;5433.7774000849495;5436.483534064258;5453.754581043862;5454.1546060359915;5461.535769459561;5694.9430505695245;5709.314882214161;5712.428757124254;5739.311282646109;5746.994276001683;5325.813596524103;5326.493983071602;5348.866278343073;5394.109971854678;5419.132938729785;4616.307553866947;4652.930206046912;4655.976720116378;4670.883227919329;4698.506656801055;5764.971175144181;5825.097109947965;5829.271341082364;5833.329167145747;5842.59101862874;5651.660900345993;5676.772929082956;5683.9715801420725;5735.655860648208;5747.080467125407;5847.795327163529;5861.120831875252;5863.032599621015;5868.853278668067;5878.764849405976;5469.070258056219;5531.778728850801;5595.468430499096;5617.213590097308;5640.041192997118;5470.288862447856;5479.232907393048;5683.635927377482;5765.106408506688;5790.334111577223;5569.637973531708;5599.580031497735;5618.381977982501;5633.324001119892;5640.85897852557;5532.197831314356;5572.9411411831625;5597;5620.550355971431;5628.718564071698;5372.167314066326;5456.727163641882;5470.124780035176;5527.143292789624;5580.023495888285;5573.275474188492;5597.832065038056;5606.131049687305;5647.29408823897;5648.181013753065;5313.920291195713;5498.065328894178;5509.834704958857;5521.282233309644;5576.77692892296 18:01:38 INFO - PROCESS | 30592 | |1;ext.html;582.4175824175824;642.0337392224702;645.2676212498812;648.3322178156501;657.0604036228198;31218.375632487336;37712.245755084914;38985.41521877174;39196.21607567847;39250.607493925054;40957.18085638285;41555;41563.58436415635;41693.37459938104;41758.79120604393;8787.165219304188;8942.73171804847;8965.775855603597;8990.10098990099;9026.052264512231;8766.035736069027;8824;8836.690715824947;8897.377183597151;8938.731838044869;8885.95557022214;8894.73315800527;8984.595693193789;9029.729108126734;9039.457632542035;8809.515476648781;8860.424072435271;8870.955645221766;8915.509646969414;8923.241524470428;8859.512726800023;8944.731658050205;8962.103789621051;8965.058668839743;8973.10268973104;40519;40928.79535602333;40949;40978;41006.58993410088;3459.8616055357757;3579.391503444395;3666.0651533858695;3823.4264860270905;3965.365541513373;29806.85096574525;30966.38067238665;32096.839515802505;32148.196295092577;32224.516632250536;4176.498820141572;4205.179989901971;4230.450041494586;4245.087306229145;4324.891877703051;272483.999999998;274668;275947;276577;276714;34930.65069349274;59199.704001480575;59211.11183332253;59304;59390.406095939354;34149.48775768365;34257.48613770796;34365.828170858986;34441.31117377638;34563.654363456546;14686.485972990895;14897.77653335201;14962.251887405586;14998.700025999418;15019.324130414157;12046.397680115959;12170.695732606579;12194.756104877853;12198.451069701885;12238.571649992207;8247.917520824714;8382.748517544484;8396.740488926587;8420.157984201653;8459.873101903477;3220.967790322067;3306.206510437478;3345.4647256438852;3349.7655164138278;3354.547136136639;1091.317926296065;1106.280917403678;1143.7369405036889;1178.128185142988;1215.2647648172906;31358.84320578428;31670.524942125885;32269.838650806596;32537.349253014807;33100;1157.3981529604728;1173.6244401791346;1215.398377802993;1231.1628092896738;1292.825468561751;16363.836361636231;16849;16975.320987160376;17143.57141071483;17253.654926901392;406008;413877;414928;414980;415060;57280.42719572751;57865.71067144637;57888.13167802486;58049.41950580524;58699;1357.1924704800629;1397.76936805428;1398.3008495752326;1411.4142630808099;1514.871235944935;28042;28761.424771504033;28929.710702892702;29305.267368315963;29410.852945735136;51263.48736512737;55897.72051139718;57631;58114;58425.12362314654;395039;397054;398323;401152;401998;43238.351424728025;43965;44109;44319.55680443283;44385.33421998608;48669.5133048665;49347.25979110244;49483;49908.25137622866;50626.240606390194;39215.80392098135;41503.169936601706;41624.16751664889;41711.37432938569;42475.787621061696;39100.41349379819;40151.3977290335;41225;41772.79113604413;42164;42374;42884.571154289304;43637.56362436335;44292.33561496516;44446.11107777891;30949.381012380076;32628.34743305168;35160.80520012607;35529.467057993636;35636;27746;28171.859140704986;28403.857980709963;28512.714872851837;28577 18:01:38 INFO - PROCESS | 30592 | |2;jquery.html;383.10735985154594;383.32152090799286;392.9705272104592;400.5133762478588;411.0709795861354;13824.861751382483;15176.392944282215;17830.197641106148;18569.535761605966;18605.906970465145;17200.483985480456;17410.129493525306;17637.911810440928;17968.460946171635;19125.90437047813;5277.182036784305;5303.496167864066;5421.620486565942;5447.400785913546;5451.591130665196;5541.695206763627;5565.749541270652;5601.831945041635;5605.1872478490595;5616.85957851055;5182.974085129569;5530.834074977757;5531.778728850841;5533.861653458655;5538.833834984957;5454.1546060360315;5484.177373393983;5508.944910550903;5518.227448157261;5529.778808847641;5203.583713302926;5413.53984911283;5445.754941027663;5463.7814487420455;5466.453354664542;12123.87876121245;12169.817452738127;12287.017038636888;12361.938190309082;12842.422091005927;2308.792208701208;2326.918557850467;2338.1582630253097;2362.893669784864;2533.227365653475;9221;9223.723288301362;9558.522073896278;9870.161036311922;9923.305368624198;1762.8677849161363;1889.4803928919519;1921.692529195336;1931.507465596264;1935.3032908153054;78300.60849695772;82529;83766.58116709438;83794;84268.15731842726;9575;10857.34855908648;10883.129349652008;11089.667309980714;11182.496787644575;14933.328000240015;15186.46847360337;15280.847191527942;15453.768193477106;15493.225338733244;7938.841223175504;7978.042634883851;8026.638801253957;8143.348532117417;8145.389095817837;7609.239076092346;7665.731699390494;7794.571298578632;7813.609319534001;7831.490953088031;4431.490378606437;4499.492669955602;4611.289984948005;4715.3869996900185;4802.567768900746;1957.8042195780308;1975.2197881836594;1975.4666240115089;1994.122586062128;2009.5578972626;1009.4952523738131;1016.8474728790741;1021.7177193907517;1062.585591619269;1104.6153234305725;16768.6646267074;18538;18653.720194197096;18983.525411864815;19116.522086947938;1044.613493007592;1051.7686109055996;1058.222206678091;1069.3637285814928;1091.8689757229183;10196.592136314614;10639.361638301727;10659.84010239847;10760.686452412769;10764;413081;424580;445855;470197;478109;90995.54502227447;91431;92905.53547232221;93375;93427;1043.6399442192583;1057.1595581512715;1075.2043487818958;1103.3986477369854;1109.6615532262738;16593.66812663716;16641.750373744646;16776.74834877502;16966.49100526986;17202.053887035832;35444.64555354517;37755.49345169572;38760;38786.0303492415;39259.21481570295;52392.73803630957;53692.463075368745;54002.72998634982;55637;56209;7790.805229869298;8016.118226995142;8176.100628930694;8207.548584827891;8262.628181731716;12962;13275.468981241029;13409;13478.73042539124;13517.121387109806;11779.234349767237;11817.290962542274;11865.347405892759;11880.625579378482;11986.64040078799;11455.255408398427;11582.768344633228;11680.591179308683;12003.579874704343;12247.69380765488;11884.286942783461;12017.09871759604;12092.395380230777;12123.575674851338;12243.571474998333;8147.9185208147155;8332.875006874781;8669.739907802776;8706.129387061243;8715.30277577805;10963.50664220096;11382.487788049391;11656.475458604213;11735.485254584555;11833.230839995373 18:01:38 INFO - PROCESS | 30592 | |3;mootools.html;1473.7568301230297;1509.0342181004155;1660.69277183721;1753.4476639858435;1786.3658401267558;7613.543187408759;8110.188981101895;8152.307053900411;8368.958155209231;8373.288270497;8208.384371172157;8226.054003789566;8248;8259.628316725746;8342.874856877152;2253.5380247049316;2293.4495721026915;2294.73610534789;2295.8737269450176;2311;2257.413072601127;2264.320703788865;2326.534693061386;2330.5105927755108;2334.743178250391;2303.09027933966;2303.8963246653857;2306.9077236910503;2309.4688221709016;2316.721993360799;2233.9888300558473;2241.3051953894264;2242.7757224277607;2243.181238847809;2244.4052326133587;2198.4613769626385;2205.0408072488517;2205.1840818897113;2205.900734466953;2206.735191776981;8390.958045209734;8467.830643387098;8482.618282177316;8520.659173633047;8526.957365213197;5064.721440320818;5256.395514515842;5267.236250743621;5269.473052694738;5269.736513174326;3060.969390306113;3081.938361232763;3116.626004879406;3142.135912624047;3159.2259896325318;1041.5625437316346;1048.7640280936805;1051.574112484445;1068.2789117345837;1085.4138765066855;11769.117316201233;11831.290122592585;11854.762904741943;11862.466189021514;11872.287662740264;4498.325251212279;4592.954070459319;4726.527347265246;4762.618990480753;4768.856934291976;9915.553800079013;9944.502774861228;9988;10016.699499014896;10032.598696052222;5239.580833533384;5255.211718242218;5255.684658920477;5264.789408423697;5292;4045.8786236412957;4698.389209402756;4772.5227477252;4825.30033145192;4842.903141937141;3786.1859700164046;3878.7866667333005;3893;3894.844206231776;3918.0792513759243;1257.3838818978634;1257.7170136719164;1264.6206138158516;1268.2010333490027;1275.0883118570266;820.7332616899412;915.624593916491;1004.9346792458467;1034.8024603973756;1039.2257767962917;5783.855403614859;5790.826275211751;5870.090136028923;5887.028640274307;5970.313413957364;449.0480182014151;452.86187712747267;456.7145534041224;459.05205750125884;459.74254417526294;3907.1404291055924;3950.367941129463;3974.463447434617;3989.5412027616617;3990.68074554035;10097.646582369582;10174;10334.483275836328;10347.4308913009;10419.843702344471;10182.541785619665;10225.59097636101;10298.17614590831;10311.948440257751;10363.32638378503;7759.650815713307;7943.761687149395;7968.800779980431;7973.920260797434;8039.115697273295;5886.205362276038;5967.880642387215;6044.607100538451;6046.516278697605;6106.816795496142;9436.723115876463;9682.177014953808;9688.079632434907;9754.658586949707;9807.656732014631;9716.222702183666;9856.901430985597;9909.900900991186;9995.400275983464;10027.448490333101;7141.821454463472;7318.194998550049;7394.926050739424;7542.358899493604;7585.165631780389;8056.355491560544;8112.513249204831;8162.102168761313;8165.469244499089;8202.589870506332;7212.639368031682;7409.592472414069;7423.072115985502;7483.812904677427;7490.775276741707;7195;7400.111986561432;7414.740484083031;7426.554406735613;7482.925170748441;6579.638119903259;6617.503687223574;6665.966670166618;6671.8665626686225;6687;4775.379200703886;4917.655764096479;4922.089413458521;4929.13740095489;4978.2034874419915;4919.606431485401;4945.4807245238735;4958.107540642719;5053.4946505350645;5079.3650793650795 18:01:38 INFO - PROCESS | 30592 | |4;prototype.html;324.4371016286744;326.9509573563965;329.6522169111587;337.86140705821384;344.30106883027463;5922.141289513018;6026.849328766783;6059.697015149241;6125.601835880665;6169.537284703654;5949.196858424111;5981.760729570812;5989.520838332934;6020.75916963322;6027.909581356273;4614.100250451163;4624.213883639773;4630.606398456135;4648.186567350717;4652.674312798105;4495.325701144821;4610.285405762095;4619.630429565644;4642.210824159901;4645.69802962808;4571.222892108333;4575.4738205106505;4589.449266088074;4610.9308360374625;4615.976920115395;4608.861734147981;4616.376789133475;4632.536746325374;4651.790669419867;4655.162070827249;3768.4158955361963;3951.9012024699323;3960.8019599019935;3966.5835087315704;4089.5297040840387;5749.8275051748515;5774.335951365562;5793.4785869271545;5804.680742559158;5812.418758124154;5251.212318152269;5262.2632831403635;5266.526012658841;5273.86815329616;5275.314209152824;6142.972818969729;6308.369163083701;6320.273168585625;6340.3342649022115;6342.682865856735;4353.325234588612;4353.564643535653;4375.124975005012;4382.123575284956;4406.53731358206;5878.26481272457;6503;6617.31258529072;6689;6697.966510167418;4422.977885110554;4433.578810013044;4437.511873693891;4439.578240067189;4446.73319600825;4481.7535035573355;4491.079328737666;4509;4511.390962220124;4527.615152712056;5109.897802043938;5182.896342073137;5261.026710058652;5264.263003179558;5277.894442111213;6320.62076275425;6328.171456268891;6340.968295158587;6343.809685709436;6377.553571249968;1532.3334349557979;1556.1674504140458;1558.6493039066347;1559.2983157579135;1566.968660626781;1011.9576835859077;1028.0901402259055;1037.9672226135044;1041.146260066738;1044.0603456888862;6061.6666083365835;6062.181605483292;6073.331933487313;6075.453209211104;6086.817395478142;6443.935560644427;6456.063870738717;6465.321141280192;6485.643289619116;6544.662222266678;5974.133750606138;6075.696215189223;6096.359882212304;6133.509319254449;6136.7852125175405;3412.539307193547;3474.4961980512685;3482.9303413932084;3491.546099007113;3501.4047611906035;6423.756003218438;6627.138471998705;6640.369164929324;6748.325167483213;6759.5606285591275;6582.3746744059235;6620.437262832616;6638.302978187317;6655.667216639149;6657.234418041987;6399.8080057598345;6540.803775886731;6693.966530167416;6828.453723702092;6845.657717114124;6504.772332968323;6506.284308725942;6508.479321654351;6515.087887695821;6530.542861999615;6251.124842521959;6464.4828413725845;6489.156409666713;6509.934900650933;6535.57518761279;6829.7023565522395;6848.2124555674745;6857.382835544825;6860.622665753432;6877.209120951155;4222.387753775747;4459.331100334975;4495.955040449554;4503.144402563503;4503.572160644733;6512.73949042033;6575;6581.177352830896;6592.901106483502;6599.373059559334;6392.776252831129;6400.359964003748;6402.167718196604;6414.454771344488;6430.196225471816;6191.81424557264;6274.905876411949;6355.618662880242;6383.680815959091;6386.840328991812;6227.439530442282;6243.656598887105;6273.74905003813;6303.527235457451;6320.304766475776;6193.380661933951;6375.266844312778;6411.230652321751;6444.8388790280615;6485.675716214265;6254.499640028877;6258.843528911813;6266.618684899709;6271.216097987752;6279 18:01:38 INFO - PROCESS | 30592 | |5;yui.html;769.4114002787867;853.1212850763714;854.3464249848871;865.1435079271523;873.6549063120063;12838.550650727204;12912.806307905388;13118.081734278605;13280.535181268657;13320.267385293817;11372;12959.935200323986;13027.15323503974;13100.73798524029;13106;794.0114557376061;815.0667485728837;815.09524427885;816.8202995341015;818.7257268814955;797.6769408389582;800.1958032177653;801.2468279816983;803.8633432316491;805.8952336196286;853.2193043365313;856.6616186606318;857.661223816592;859.9011113721908;861.2507118806616;847.9830403391928;849.8512760266959;852.7782776478099;856.9185927336893;861.2248975921658;619.1610367951406;622.2564035977009;622.8972219583763;624.7126321891935;627.5387590121258;13134.86865131346;13141;13155.210687358789;13186.208827470382;13259.138156019828;13088.47646094155;13199.538016169485;13252.46990120394;13282.269475178862;13313.400896959563;10793.136549076133;10807.729806754816;10903.454827258605;10974.341539507655;11010.669679909615;3317.6848199421015;3667.651573100551;3691.298653255873;3764.3224219640456;3828.578856325802;59559;60076;61670.38329616736;61794.69102654503;62019.37980620226;9266.44401335922;9536.380135291183;9660.661876834278;9866.358686685342;9871.75320616976;17732.468025959242;17750.20124094419;18162;18178.818211817976;18179.636407272046;7981.800454988672;7983.640736166886;8030.9196908031345;8088.352931765445;8197.959010204911;4463.196624607602;4485.506594274627;4489.483709373399;4561.749103799323;4578.6794924355645;3199.744020478356;3276.262840860787;3276.885309014173;3283.6387997320276;3289.7697161198967;632.7563887903191;634.660456655687;641.3298103481873;643;651.7458191305394;670.6546128743701;720.3085038363125;760.3385055002072;763.0995425398083;788.9526628402199;9040.457572545669;9061.54692265384;9166.17504424605;9236.676716314896;9258.213051890665;651.2250421997808;676.8510927595921;738.9371903388164;746.3096635612037;751.1511991449627;4358.302671572533;4505.359618739059;4528.569785870337;4573.771311434415;4663.533646635377;68407;68705.65647171832;70556.6472167636;71011.64494177495;71301.2869871305;52721.2091818623;53620.65948351323;57029;57954;59658.40341596529;48320.27519587209;51058.23412648813;53228.73385633047;54171.18743218855;54219.18671219935;8929.241014513838;9021.729348119567;9023.774405639911;9161.587728552364;9201.677941272023;32657.836710816293;32956.34087318192;33141.50287745734;33151.50272745959;33257.16857078592;41192.588074118874;42719.3592096125;44539;45511.31733023941;45709.31436028529;11317.660470185907;11324.094072474347;11394.601188958346;11480.655580332603;11631.47658355359;12798.488060477848;13147.211167329991;13176.670583235496;13272.601821945356;13280.089338238668;11649.825252621387;11905.464254108412;12226.633201003984;12340.876591233973;12598.937005314914;11102.500387482422;11244.775104498029;11423.314601123959;11463.885361146615;11468.885311146782;11526.250793698382;12088.697782555506;12096.637100886988;12492.43784029739;12956.676083097998;9451.432914025181;9518.857217141609;9605.663801767185;9674.806503870024;10004.949975250078;9479.146876781122;9489.124027057664;9972.700818975442;9976.650817221362;10011.149052330633 18:01:38 INFO - PROCESS | 30592 | __end_tp_report 18:01:38 INFO - PROCESS | 30592 | __start_cc_report 18:01:38 INFO - PROCESS | 30592 | _x_x_mozilla_cycle_collect,320 18:01:38 INFO - PROCESS | 30592 | __end_cc_report 18:01:38 INFO - PROCESS | 30592 | __startTimestamp1461286898523__endTimestamp 18:01:38 INFO - PROCESS | 30592 | 18:01:38 INFO - PROCESS | 30592 | ------- Summary: start ------- 18:01:38 INFO - PROCESS | 30592 | Number of tests: 6 18:01:38 INFO - PROCESS | 30592 | 18:01:38 INFO - PROCESS | 30592 | [#0] dojo.html Cycles:165 Average:5235.81 Median:5470.29 stddev:680.89 (12.4%) stddev-sans-first:661.82 18:01:38 INFO - PROCESS | 30592 | Values: 3088.9 3153.9 3179.9 3206.3 3207.3 5248.9 5303.2 5344.9 5347.5 5371.1 5230.0 5236.2 5321.4 5346.4 5361.6 4816.8 4836.0 4877.2 4927.1 4929.5 856.1 4803.2 4852.5 4870.3 4892.0 4831.3 4837.5 4848.2 4861.0 4905.7 4672.8 4910.3 4934.0 4944.6 4986.4 4642.9 4679.8 4810.3 4846.8 4861.3 5214.0 5216.4 5224.6 5254.9 5302.9 5648.3 5653.3 5671.9 5672.7 5750.0 5586.1 5590.8 5594.5 5595.5 5644.6 5227.3 5231.1 5234.6 5236.8 5292.4 5702.2 5739.2 5814.7 5839.2 5863.2 5449.5 5471.0 5493.3 5498.6 5501.2 5571.5 5572.0 5580.4 5590.8 5621.2 5459.2 5531.8 5616.1 5700.0 5707.6 5430.9 5587.6 5598.4 5658.2 5700.3 4256.6 4275.9 4300.8 4301.9 4326.5 3816.9 3830.5 3861.1 3887.0 3913.1 5433.8 5436.5 5453.8 5454.2 5461.5 5694.9 5709.3 5712.4 5739.3 5747.0 5325.8 5326.5 5348.9 5394.1 5419.1 4616.3 4652.9 4656.0 4670.9 4698.5 5765.0 5825.1 5829.3 5833.3 5842.6 5651.7 5676.8 5684.0 5735.7 5747.1 5847.8 5861.1 5863.0 5868.9 5878.8 5469.1 5531.8 5595.5 5617.2 5640.0 5470.3 5479.2 5683.6 5765.1 5790.3 5569.6 5599.6 5618.4 5633.3 5640.9 5532.2 5572.9 5597.0 5620.6 5628.7 5372.2 5456.7 5470.1 5527.1 5580.0 5573.3 5597.8 5606.1 5647.3 5648.2 5313.9 5498.1 5509.8 5521.3 5576.8 18:01:38 INFO - PROCESS | 30592 | 18:01:38 INFO - PROCESS | 30592 | [#1] ext.html Cycles:180 Average:52676.09 Median:223468.40 stddev:96972.20 (43.4%) stddev-sans-first:97165.35 18:01:38 INFO - PROCESS | 30592 | Values: 582.4 642.0 645.3 648.3 657.1 31218.4 37712.2 38985.4 39196.2 39250.6 40957.2 41555.0 41563.6 41693.4 41758.8 8787.2 8942.7 8965.8 8990.1 9026.1 8766.0 8824.0 8836.7 8897.4 8938.7 8886.0 8894.7 8984.6 9029.7 9039.5 8809.5 8860.4 8871.0 8915.5 8923.2 8859.5 8944.7 8962.1 8965.1 8973.1 40519.0 40928.8 40949.0 40978.0 41006.6 3459.9 3579.4 3666.1 3823.4 3965.4 29806.9 30966.4 32096.8 32148.2 32224.5 4176.5 4205.2 4230.5 4245.1 4324.9 272484.0 274668.0 275947.0 276577.0 276714.0 34930.7 59199.7 59211.1 59304.0 59390.4 34149.5 34257.5 34365.8 34441.3 34563.7 14686.5 14897.8 14962.3 14998.7 15019.3 12046.4 12170.7 12194.8 12198.5 12238.6 8247.9 8382.7 8396.7 8420.2 8459.9 3221.0 3306.2 3345.5 3349.8 3354.5 1091.3 1106.3 1143.7 1178.1 1215.3 31358.8 31670.5 32269.8 32537.3 33100.0 1157.4 1173.6 1215.4 1231.2 1292.8 16363.8 16849.0 16975.3 17143.6 17253.7 406008.0 413877.0 414928.0 414980.0 415060.0 57280.4 57865.7 57888.1 58049.4 58699.0 1357.2 1397.8 1398.3 1411.4 1514.9 28042.0 28761.4 28929.7 29305.3 29410.9 51263.5 55897.7 57631.0 58114.0 58425.1 395039.0 397054.0 398323.0 401152.0 401998.0 43238.4 43965.0 44109.0 44319.6 44385.3 48669.5 49347.3 49483.0 49908.3 50626.2 39215.8 41503.2 41624.2 41711.4 42475.8 39100.4 40151.4 41225.0 41772.8 42164.0 42374.0 42884.6 43637.6 44292.3 44446.1 30949.4 32628.3 35160.8 35529.5 35636.0 27746.0 28171.9 28403.9 28512.7 28577.0 18:01:38 INFO - PROCESS | 30592 | 18:01:38 INFO - PROCESS | 30592 | [#2] jquery.html Cycles:180 Average:27135.23 Median:2332.54 stddev:74039.76 (3174.2%) stddev-sans-first:74220.22 18:01:38 INFO - PROCESS | 30592 | Values: 383.1 383.3 393.0 400.5 411.1 13824.9 15176.4 17830.2 18569.5 18605.9 17200.5 17410.1 17637.9 17968.5 19125.9 5277.2 5303.5 5421.6 5447.4 5451.6 5541.7 5565.7 5601.8 5605.2 5616.9 5183.0 5530.8 5531.8 5533.9 5538.8 5454.2 5484.2 5508.9 5518.2 5529.8 5203.6 5413.5 5445.8 5463.8 5466.5 12123.9 12169.8 12287.0 12361.9 12842.4 2308.8 2326.9 2338.2 2362.9 2533.2 9221.0 9223.7 9558.5 9870.2 9923.3 1762.9 1889.5 1921.7 1931.5 1935.3 78300.6 82529.0 83766.6 83794.0 84268.2 9575.0 10857.3 10883.1 11089.7 11182.5 14933.3 15186.5 15280.8 15453.8 15493.2 7938.8 7978.0 8026.6 8143.3 8145.4 7609.2 7665.7 7794.6 7813.6 7831.5 4431.5 4499.5 4611.3 4715.4 4802.6 1957.8 1975.2 1975.5 1994.1 2009.6 1009.5 1016.8 1021.7 1062.6 1104.6 16768.7 18538.0 18653.7 18983.5 19116.5 1044.6 1051.8 1058.2 1069.4 1091.9 10196.6 10639.4 10659.8 10760.7 10764.0 413081.0 424580.0 445855.0 470197.0 478109.0 90995.5 91431.0 92905.5 93375.0 93427.0 1043.6 1057.2 1075.2 1103.4 1109.7 16593.7 16641.8 16776.7 16966.5 17202.1 35444.6 37755.5 38760.0 38786.0 39259.2 52392.7 53692.5 54002.7 55637.0 56209.0 7790.8 8016.1 8176.1 8207.5 8262.6 12962.0 13275.5 13409.0 13478.7 13517.1 11779.2 11817.3 11865.3 11880.6 11986.6 11455.3 11582.8 11680.6 12003.6 12247.7 11884.3 12017.1 12092.4 12123.6 12243.6 8147.9 8332.9 8669.7 8706.1 8715.3 10963.5 11382.5 11656.5 11735.5 11833.2 18:01:38 INFO - PROCESS | 30592 | 18:01:38 INFO - PROCESS | 30592 | [#3] mootools.html Cycles:180 Average:5581.71 Median:4834.10 stddev:3149.79 (65.2%) stddev-sans-first:3143.50 18:01:38 INFO - PROCESS | 30592 | Values: 1473.8 1509.0 1660.7 1753.4 1786.4 7613.5 8110.2 8152.3 8369.0 8373.3 8208.4 8226.1 8248.0 8259.6 8342.9 2253.5 2293.4 2294.7 2295.9 2311.0 2257.4 2264.3 2326.5 2330.5 2334.7 2303.1 2303.9 2306.9 2309.5 2316.7 2234.0 2241.3 2242.8 2243.2 2244.4 2198.5 2205.0 2205.2 2205.9 2206.7 8391.0 8467.8 8482.6 8520.7 8527.0 5064.7 5256.4 5267.2 5269.5 5269.7 3061.0 3081.9 3116.6 3142.1 3159.2 1041.6 1048.8 1051.6 1068.3 1085.4 11769.1 11831.3 11854.8 11862.5 11872.3 4498.3 4593.0 4726.5 4762.6 4768.9 9915.6 9944.5 9988.0 10016.7 10032.6 5239.6 5255.2 5255.7 5264.8 5292.0 4045.9 4698.4 4772.5 4825.3 4842.9 3786.2 3878.8 3893.0 3894.8 3918.1 1257.4 1257.7 1264.6 1268.2 1275.1 820.7 915.6 1004.9 1034.8 1039.2 5783.9 5790.8 5870.1 5887.0 5970.3 449.0 452.9 456.7 459.1 459.7 3907.1 3950.4 3974.5 3989.5 3990.7 10097.6 10174.0 10334.5 10347.4 10419.8 10182.5 10225.6 10298.2 10311.9 10363.3 7759.7 7943.8 7968.8 7973.9 8039.1 5886.2 5967.9 6044.6 6046.5 6106.8 9436.7 9682.2 9688.1 9754.7 9807.7 9716.2 9856.9 9909.9 9995.4 10027.4 7141.8 7318.2 7394.9 7542.4 7585.2 8056.4 8112.5 8162.1 8165.5 8202.6 7212.6 7409.6 7423.1 7483.8 7490.8 7195.0 7400.1 7414.7 7426.6 7482.9 6579.6 6617.5 6666.0 6671.9 6687.0 4775.4 4917.7 4922.1 4929.1 4978.2 4919.6 4945.5 4958.1 5053.5 5079.4 18:01:38 INFO - PROCESS | 30592 | 18:01:38 INFO - PROCESS | 30592 | [#4] prototype.html Cycles:180 Average:5294.31 Median:6061.92 stddev:1603.79 (26.5%) stddev-sans-first:1564.31 18:01:38 INFO - PROCESS | 30592 | Values: 324.4 327.0 329.7 337.9 344.3 5922.1 6026.8 6059.7 6125.6 6169.5 5949.2 5981.8 5989.5 6020.8 6027.9 4614.1 4624.2 4630.6 4648.2 4652.7 4495.3 4610.3 4619.6 4642.2 4645.7 4571.2 4575.5 4589.4 4610.9 4616.0 4608.9 4616.4 4632.5 4651.8 4655.2 3768.4 3951.9 3960.8 3966.6 4089.5 5749.8 5774.3 5793.5 5804.7 5812.4 5251.2 5262.3 5266.5 5273.9 5275.3 6143.0 6308.4 6320.3 6340.3 6342.7 4353.3 4353.6 4375.1 4382.1 4406.5 5878.3 6503.0 6617.3 6689.0 6698.0 4423.0 4433.6 4437.5 4439.6 4446.7 4481.8 4491.1 4509.0 4511.4 4527.6 5109.9 5182.9 5261.0 5264.3 5277.9 6320.6 6328.2 6341.0 6343.8 6377.6 1532.3 1556.2 1558.6 1559.3 1567.0 1012.0 1028.1 1038.0 1041.1 1044.1 6061.7 6062.2 6073.3 6075.5 6086.8 6443.9 6456.1 6465.3 6485.6 6544.7 5974.1 6075.7 6096.4 6133.5 6136.8 3412.5 3474.5 3482.9 3491.5 3501.4 6423.8 6627.1 6640.4 6748.3 6759.6 6582.4 6620.4 6638.3 6655.7 6657.2 6399.8 6540.8 6694.0 6828.5 6845.7 6504.8 6506.3 6508.5 6515.1 6530.5 6251.1 6464.5 6489.2 6509.9 6535.6 6829.7 6848.2 6857.4 6860.6 6877.2 4222.4 4459.3 4496.0 4503.1 4503.6 6512.7 6575.0 6581.2 6592.9 6599.4 6392.8 6400.4 6402.2 6414.5 6430.2 6191.8 6274.9 6355.6 6383.7 6386.8 6227.4 6243.7 6273.7 6303.5 6320.3 6193.4 6375.3 6411.2 6444.8 6485.7 6254.5 6258.8 6266.6 6271.2 6279.0 18:01:38 INFO - PROCESS | 30592 | 18:01:38 INFO - PROCESS | 30592 | [#5] yui.html Cycles:180 Average:14888.18 Median:53424.70 stddev:18310.55 (34.3%) stddev-sans-first:18331.22 18:01:38 INFO - PROCESS | 30592 | Values: 769.4 853.1 854.3 865.1 873.7 12838.6 12912.8 13118.1 13280.5 13320.3 11372.0 12959.9 13027.2 13100.7 13106.0 794.0 815.1 815.1 816.8 818.7 797.7 800.2 801.2 803.9 805.9 853.2 856.7 857.7 859.9 861.3 848.0 849.9 852.8 856.9 861.2 619.2 622.3 622.9 624.7 627.5 13134.9 13141.0 13155.2 13186.2 13259.1 13088.5 13199.5 13252.5 13282.3 13313.4 10793.1 10807.7 10903.5 10974.3 11010.7 3317.7 3667.7 3691.3 3764.3 3828.6 59559.0 60076.0 61670.4 61794.7 62019.4 9266.4 9536.4 9660.7 9866.4 9871.8 17732.5 17750.2 18162.0 18178.8 18179.6 7981.8 7983.6 8030.9 8088.4 8198.0 4463.2 4485.5 4489.5 4561.7 4578.7 3199.7 3276.3 3276.9 3283.6 3289.8 632.8 634.7 641.3 643.0 651.7 670.7 720.3 760.3 763.1 789.0 9040.5 9061.5 9166.2 9236.7 9258.2 651.2 676.9 738.9 746.3 751.2 4358.3 4505.4 4528.6 4573.8 4663.5 68407.0 68705.7 70556.6 71011.6 71301.3 52721.2 53620.7 57029.0 57954.0 59658.4 48320.3 51058.2 53228.7 54171.2 54219.2 8929.2 9021.7 9023.8 9161.6 9201.7 32657.8 32956.3 33141.5 33151.5 33257.2 41192.6 42719.4 44539.0 45511.3 45709.3 11317.7 11324.1 11394.6 11480.7 11631.5 12798.5 13147.2 13176.7 13272.6 13280.1 11649.8 11905.5 12226.6 12340.9 12598.9 11102.5 11244.8 11423.3 11463.9 11468.9 11526.3 12088.7 12096.6 12492.4 12956.7 9451.4 9518.9 9605.7 9674.8 10004.9 9479.1 9489.1 9972.7 9976.7 10011.1 18:01:38 INFO - PROCESS | 30592 | -------- Summary: end -------- 18:01:38 INFO - PROCESS | 30592 | 18:01:39 INFO - TEST-INFO | 30592: exit 0 18:01:39 INFO - TEST-OK | dromaeo_css | took 1109019ms 18:01:39 INFO - TEST-START | kraken 18:01:39 INFO - operating with platform_type : linux_ 18:01:39 INFO - Initialising browser for kraken test... 18:01:39 INFO - TEST-INFO | started process 30828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZr4XRh/profile http://localhost:58268/getInfo.html) 18:01:42 INFO - PROCESS | 30828 | 18:01:42 INFO - PROCESS | 30828 | (process:30900): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:01:43 INFO - PROCESS | 30828 | __metrics Screen width/height:1600/1200 18:01:43 INFO - PROCESS | 30828 | colorDepth:24 18:01:43 INFO - PROCESS | 30828 | Browser inner width/height: 1024/697 18:01:43 INFO - PROCESS | 30828 | __metrics 18:01:43 ERROR - PROCESS | 30828 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:01:44 INFO - TEST-INFO | 30828: exit 0 18:01:44 INFO - Browser initialized. 18:01:44 INFO - Running cycle 1/1 for kraken test... 18:01:44 INFO - TEST-INFO | started process 30951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZr4XRh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:46 INFO - PROCESS | 30951 | 18:01:46 INFO - PROCESS | 30951 | (process:31011): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:01:56 INFO - PROCESS | 30951 | RSS: Main: 163528704 18:01:56 INFO - PROCESS | 30951 | 18:01:58 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58268/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:59 INFO - PROCESS | 30951 | RSS: Main: 168235008 18:01:59 INFO - PROCESS | 30951 | 18:02:02 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58268/tests/kraken/driver.html?testName=audio-dft) 18:02:03 INFO - PROCESS | 30951 | RSS: Main: 171749376 18:02:03 INFO - PROCESS | 30951 | 18:02:06 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58268/tests/kraken/driver.html?testName=audio-fft) 18:02:06 INFO - PROCESS | 30951 | RSS: Main: 163069952 18:02:06 INFO - PROCESS | 30951 | 18:02:09 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58268/tests/kraken/driver.html?testName=audio-oscillator) 18:02:09 INFO - PROCESS | 30951 | RSS: Main: 163586048 18:02:09 INFO - PROCESS | 30951 | 18:02:11 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:02:12 INFO - PROCESS | 30951 | RSS: Main: 164405248 18:02:12 INFO - PROCESS | 30951 | 18:02:15 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58268/tests/kraken/driver.html?testName=imaging-darkroom) 18:02:16 INFO - PROCESS | 30951 | RSS: Main: 164327424 18:02:16 INFO - PROCESS | 30951 | 18:02:19 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58268/tests/kraken/driver.html?testName=imaging-desaturate) 18:02:20 INFO - PROCESS | 30951 | RSS: Main: 166461440 18:02:20 INFO - PROCESS | 30951 | 18:02:23 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58268/tests/kraken/driver.html?testName=json-parse-financial) 18:02:23 INFO - PROCESS | 30951 | RSS: Main: 166985728 18:02:23 INFO - PROCESS | 30951 | 18:02:25 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:02:25 INFO - PROCESS | 30951 | RSS: Main: 166682624 18:02:25 INFO - PROCESS | 30951 | 18:02:27 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58268/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:02:28 INFO - PROCESS | 30951 | RSS: Main: 166604800 18:02:28 INFO - PROCESS | 30951 | 18:02:30 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:02:30 INFO - PROCESS | 30951 | RSS: Main: 167059456 18:02:30 INFO - PROCESS | 30951 | 18:02:33 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:02:34 INFO - PROCESS | 30951 | RSS: Main: 167436288 18:02:34 INFO - PROCESS | 30951 | 18:02:36 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:02:37 INFO - PROCESS | 30951 | RSS: Main: 167698432 18:02:37 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | Cycle 1(1): loaded http://localhost:58268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58268/tests/kraken/driver.html?testName=ai-astar) 18:02:39 INFO - PROCESS | 30951 | RSS: Main: 168755200 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | __start_tp_report 18:02:39 INFO - PROCESS | 30951 | _x_x_mozilla_page_load 18:02:39 INFO - PROCESS | 30951 | _x_x_mozilla_page_load_details 18:02:39 INFO - PROCESS | 30951 | |i|pagename|runs| 18:02:39 INFO - PROCESS | 30951 | |0;ai-astar;113;106;112;112;112;123;111;113;111;112 18:02:39 INFO - PROCESS | 30951 | |1;audio-beat-detection;161;128;153;181;133;171;162;130;187;131 18:02:39 INFO - PROCESS | 30951 | |2;audio-dft;165;162;164;163;162;164;174;164;167;169 18:02:39 INFO - PROCESS | 30951 | |3;audio-fft;76;74;73;165;77;78;78;77;165;77 18:02:39 INFO - PROCESS | 30951 | |4;audio-oscillator;93;93;150;93;93;93;141;94;93;142 18:02:39 INFO - PROCESS | 30951 | |5;imaging-gaussian-blur;120;118;118;117;117;117;118;118;117;118 18:02:39 INFO - PROCESS | 30951 | |6;imaging-darkroom;148;147;148;146;147;148;148;147;147;148 18:02:39 INFO - PROCESS | 30951 | |7;imaging-desaturate;97;95;95;95;95;96;95;96;95;95 18:02:39 INFO - PROCESS | 30951 | |8;json-parse-financial;57;57;57;56;58;58;59;76;56;56 18:02:39 INFO - PROCESS | 30951 | |9;json-stringify-tinderbox;62;62;61;61;61;62;62;62;61;61 18:02:39 INFO - PROCESS | 30951 | |10;stanford-crypto-aes;76;77;77;77;79;80;79;77;80;78 18:02:39 INFO - PROCESS | 30951 | |11;stanford-crypto-ccm;134;125;124;137;128;132;124;133;159;148 18:02:39 INFO - PROCESS | 30951 | |12;stanford-crypto-pbkdf2;164;169;166;167;164;170;165;169;171;161 18:02:39 INFO - PROCESS | 30951 | |13;stanford-crypto-sha256-iterative;70;68;69;75;70;67;77;69;67;67 18:02:39 INFO - PROCESS | 30951 | __end_tp_report 18:02:39 INFO - PROCESS | 30951 | __start_cc_report 18:02:39 INFO - PROCESS | 30951 | _x_x_mozilla_cycle_collect,836 18:02:39 INFO - PROCESS | 30951 | __end_cc_report 18:02:39 INFO - PROCESS | 30951 | __startTimestamp1461286959551__endTimestamp 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | ------- Summary: start ------- 18:02:39 INFO - PROCESS | 30951 | Number of tests: 14 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:4.20 (3.7%) stddev-sans-first:4.45 18:02:39 INFO - PROCESS | 30951 | Values: 113.0 106.0 112.0 112.0 112.0 123.0 111.0 113.0 111.0 112.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:161.50 stddev:22.22 (13.8%) stddev-sans-first:23.41 18:02:39 INFO - PROCESS | 30951 | Values: 161.0 128.0 153.0 181.0 133.0 171.0 162.0 130.0 187.0 131.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.50 stddev:3.72 (2.3%) stddev-sans-first:3.94 18:02:39 INFO - PROCESS | 30951 | Values: 165.0 162.0 164.0 163.0 162.0 164.0 174.0 164.0 167.0 169.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#3] audio-fft Cycles:10 Average:94.00 Median:77.00 stddev:37.46 (48.6%) stddev-sans-first:39.16 18:02:39 INFO - PROCESS | 30951 | Values: 76.0 74.0 73.0 165.0 77.0 78.0 78.0 77.0 165.0 77.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.00 stddev:24.84 (26.7%) stddev-sans-first:25.70 18:02:39 INFO - PROCESS | 30951 | Values: 93.0 93.0 150.0 93.0 93.0 93.0 141.0 94.0 93.0 142.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.53 18:02:39 INFO - PROCESS | 30951 | Values: 120.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 18:02:39 INFO - PROCESS | 30951 | Values: 148.0 147.0 148.0 146.0 147.0 148.0 148.0 147.0 147.0 148.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.44 18:02:39 INFO - PROCESS | 30951 | Values: 97.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:57.50 stddev:6.06 (10.5%) stddev-sans-first:6.38 18:02:39 INFO - PROCESS | 30951 | Values: 57.0 57.0 57.0 56.0 58.0 58.0 59.0 76.0 56.0 56.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 18:02:39 INFO - PROCESS | 30951 | Values: 62.0 62.0 61.0 61.0 61.0 62.0 62.0 62.0 61.0 61.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.50 stddev:1.41 (1.8%) stddev-sans-first:1.30 18:02:39 INFO - PROCESS | 30951 | Values: 76.0 77.0 77.0 77.0 79.0 80.0 79.0 77.0 80.0 78.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:133.50 stddev:11.31 (8.5%) stddev-sans-first:11.99 18:02:39 INFO - PROCESS | 30951 | Values: 134.0 125.0 124.0 137.0 128.0 132.0 124.0 133.0 159.0 148.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:168.00 stddev:3.17 (1.9%) stddev-sans-first:3.22 18:02:39 INFO - PROCESS | 30951 | Values: 164.0 169.0 166.0 167.0 164.0 170.0 165.0 169.0 171.0 161.0 18:02:39 INFO - PROCESS | 30951 | 18:02:39 INFO - PROCESS | 30951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.50 stddev:3.45 (5.0%) stddev-sans-first:3.66 18:02:39 INFO - PROCESS | 30951 | Values: 70.0 68.0 69.0 75.0 70.0 67.0 77.0 69.0 67.0 67.0 18:02:39 INFO - PROCESS | 30951 | -------- Summary: end -------- 18:02:39 INFO - PROCESS | 30951 | 18:02:40 INFO - TEST-INFO | 30951: exit 0 18:02:40 INFO - TEST-OK | kraken | took 61269ms 18:02:40 INFO - SUITE-END | took 1170s 18:02:40 INFO - Completed test suite (00:19:30) 18:02:40 INFO - javascript benchmark 18:02:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.9227769305767, 3153.905382838514, 3179.936401271973, 3206.342699746551, 3207.3424947885687, 5248.89502209956, 5303.178007408857, 5344.919826202605, 5347.545458636011, 5371.113766228573, 5230.0, 5236.188390799422, 5321.4412486688825, 5346.4118946915905, 5361.624686271963, 4816.783244753986, 4835.975820120894, 4877.244027175776, 4927.088488629597, 4929.5316944890355, 856.1437356806945, 4803.231482962727, 4852.514748525155, 4870.293807397925, 4891.975540122312, 4831.347768051339, 4837.467878533376, 4848.17581011229, 4860.975695121537, 4905.730184839832, 4672.766361681936, 4910.263460480921, 4933.975330123362, 4944.579710724593, 4986.4265609455015, 4642.86071417858, 4679.766011699401, 4810.278458231258, 4846.7576621169155, 4861.295112208745, 5214.0, 5216.37403511581, 5224.582033437316, 5254.894902101974, 5302.92045619316, 5648.3222013358245, 5653.293338332708, 5671.943280567183, 5672.744726487318, 5750.0, 5586.13414920688, 5590.832275031756, 5594.468525490112, 5595.496405323541, 5644.6330988485615, 5227.26818245446, 5231.136862417697, 5234.6335756497065, 5236.81671141512, 5292.417834038252, 5702.2301989231755, 5739.196512488255, 5814.680192589448, 5839.211706419664, 5863.20846685692, 5449.509544141047, 5471.0, 5493.313335833021, 5498.5876059294915, 5501.202325662756, 5571.470710282517, 5571.9721401392735, 5580.441955804387, 5590.832275031756, 5621.213030175779, 5459.153831156177, 5531.778728850801, 5616.129499927518, 5700.0, 5707.600467967285, 5430.945690543123, 5587.552995760329, 5598.44015598445, 5658.179563963202, 5700.344460387026, 4256.553061928515, 4275.8882690500695, 4300.849470268526, 4301.913961720748, 4326.524082350938, 3816.8740221634685, 3830.540335159743, 3861.1119442528375, 3887.028242939265, 3913.099987002948, 5433.7774000849495, 5436.483534064258, 5453.754581043862, 5454.1546060359915, 5461.535769459561, 5694.9430505695245, 5709.314882214161, 5712.428757124254, 5739.311282646109, 5746.994276001683, 5325.813596524103, 5326.493983071602, 5348.866278343073, 5394.109971854678, 5419.132938729785, 4616.307553866947, 4652.930206046912, 4655.976720116378, 4670.883227919329, 4698.506656801055, 5764.971175144181, 5825.097109947965, 5829.271341082364, 5833.329167145747, 5842.59101862874, 5651.660900345993, 5676.772929082956, 5683.9715801420725, 5735.655860648208, 5747.080467125407, 5847.795327163529, 5861.120831875252, 5863.032599621015, 5868.853278668067, 5878.764849405976, 5469.070258056219, 5531.778728850801, 5595.468430499096, 5617.213590097308, 5640.041192997118, 5470.288862447856, 5479.232907393048, 5683.635927377482, 5765.106408506688, 5790.334111577223, 5569.637973531708, 5599.580031497735, 5618.381977982501, 5633.324001119892, 5640.85897852557, 5532.197831314356, 5572.9411411831625, 5597.0, 5620.550355971431, 5628.718564071698, 5372.167314066326, 5456.727163641882, 5470.124780035176, 5527.143292789624, 5580.023495888285, 5573.275474188492, 5597.832065038056, 5606.131049687305, 5647.29408823897, 5648.181013753065, 5313.920291195713, 5498.065328894178, 5509.834704958857, 5521.282233309644, 5576.77692892296], "value": 5193.031375870435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.4175824175824, 642.0337392224702, 645.2676212498812, 648.3322178156501, 657.0604036228198, 31218.375632487336, 37712.245755084914, 38985.41521877174, 39196.21607567847, 39250.607493925054, 40957.18085638285, 41555.0, 41563.58436415635, 41693.37459938104, 41758.79120604393, 8787.165219304188, 8942.73171804847, 8965.775855603597, 8990.10098990099, 9026.052264512231, 8766.035736069027, 8824.0, 8836.690715824947, 8897.377183597151, 8938.731838044869, 8885.95557022214, 8894.73315800527, 8984.595693193789, 9029.729108126734, 9039.457632542035, 8809.515476648781, 8860.424072435271, 8870.955645221766, 8915.509646969414, 8923.241524470428, 8859.512726800023, 8944.731658050205, 8962.103789621051, 8965.058668839743, 8973.10268973104, 40519.0, 40928.79535602333, 40949.0, 40978.0, 41006.58993410088, 3459.8616055357757, 3579.391503444395, 3666.0651533858695, 3823.4264860270905, 3965.365541513373, 29806.85096574525, 30966.38067238665, 32096.839515802505, 32148.196295092577, 32224.516632250536, 4176.498820141572, 4205.179989901971, 4230.450041494586, 4245.087306229145, 4324.891877703051, 272483.999999998, 274668.0, 275947.0, 276577.0, 276714.0, 34930.65069349274, 59199.704001480575, 59211.11183332253, 59304.0, 59390.406095939354, 34149.48775768365, 34257.48613770796, 34365.828170858986, 34441.31117377638, 34563.654363456546, 14686.485972990895, 14897.77653335201, 14962.251887405586, 14998.700025999418, 15019.324130414157, 12046.397680115959, 12170.695732606579, 12194.756104877853, 12198.451069701885, 12238.571649992207, 8247.917520824714, 8382.748517544484, 8396.740488926587, 8420.157984201653, 8459.873101903477, 3220.967790322067, 3306.206510437478, 3345.4647256438852, 3349.7655164138278, 3354.547136136639, 1091.317926296065, 1106.280917403678, 1143.7369405036889, 1178.128185142988, 1215.2647648172906, 31358.84320578428, 31670.524942125885, 32269.838650806596, 32537.349253014807, 33100.0, 1157.3981529604728, 1173.6244401791346, 1215.398377802993, 1231.1628092896738, 1292.825468561751, 16363.836361636231, 16849.0, 16975.320987160376, 17143.57141071483, 17253.654926901392, 406008.0, 413877.0, 414928.0, 414980.0, 415060.0, 57280.42719572751, 57865.71067144637, 57888.13167802486, 58049.41950580524, 58699.0, 1357.1924704800629, 1397.76936805428, 1398.3008495752326, 1411.4142630808099, 1514.871235944935, 28042.0, 28761.424771504033, 28929.710702892702, 29305.267368315963, 29410.852945735136, 51263.48736512737, 55897.72051139718, 57631.0, 58114.0, 58425.12362314654, 395039.0, 397054.0, 398323.0, 401152.0, 401998.0, 43238.351424728025, 43965.0, 44109.0, 44319.55680443283, 44385.33421998608, 48669.5133048665, 49347.25979110244, 49483.0, 49908.25137622866, 50626.240606390194, 39215.80392098135, 41503.169936601706, 41624.16751664889, 41711.37432938569, 42475.787621061696, 39100.41349379819, 40151.3977290335, 41225.0, 41772.79113604413, 42164.0, 42374.0, 42884.571154289304, 43637.56362436335, 44292.33561496516, 44446.11107777891, 30949.381012380076, 32628.34743305168, 35160.80520012607, 35529.467057993636, 35636.0, 27746.0, 28171.859140704986, 28403.857980709963, 28512.714872851837, 28577.0], "value": 18803.66167452231, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.10735985154594, 383.32152090799286, 392.9705272104592, 400.5133762478588, 411.0709795861354, 13824.861751382483, 15176.392944282215, 17830.197641106148, 18569.535761605966, 18605.906970465145, 17200.483985480456, 17410.129493525306, 17637.911810440928, 17968.460946171635, 19125.90437047813, 5277.182036784305, 5303.496167864066, 5421.620486565942, 5447.400785913546, 5451.591130665196, 5541.695206763627, 5565.749541270652, 5601.831945041635, 5605.1872478490595, 5616.85957851055, 5182.974085129569, 5530.834074977757, 5531.778728850841, 5533.861653458655, 5538.833834984957, 5454.1546060360315, 5484.177373393983, 5508.944910550903, 5518.227448157261, 5529.778808847641, 5203.583713302926, 5413.53984911283, 5445.754941027663, 5463.7814487420455, 5466.453354664542, 12123.87876121245, 12169.817452738127, 12287.017038636888, 12361.938190309082, 12842.422091005927, 2308.792208701208, 2326.918557850467, 2338.1582630253097, 2362.893669784864, 2533.227365653475, 9221.0, 9223.723288301362, 9558.522073896278, 9870.161036311922, 9923.305368624198, 1762.8677849161363, 1889.4803928919519, 1921.692529195336, 1931.507465596264, 1935.3032908153054, 78300.60849695772, 82529.0, 83766.58116709438, 83794.0, 84268.15731842726, 9575.0, 10857.34855908648, 10883.129349652008, 11089.667309980714, 11182.496787644575, 14933.328000240015, 15186.46847360337, 15280.847191527942, 15453.768193477106, 15493.225338733244, 7938.841223175504, 7978.042634883851, 8026.638801253957, 8143.348532117417, 8145.389095817837, 7609.239076092346, 7665.731699390494, 7794.571298578632, 7813.609319534001, 7831.490953088031, 4431.490378606437, 4499.492669955602, 4611.289984948005, 4715.3869996900185, 4802.567768900746, 1957.8042195780308, 1975.2197881836594, 1975.4666240115089, 1994.122586062128, 2009.5578972626, 1009.4952523738131, 1016.8474728790741, 1021.7177193907517, 1062.585591619269, 1104.6153234305725, 16768.6646267074, 18538.0, 18653.720194197096, 18983.525411864815, 19116.522086947938, 1044.613493007592, 1051.7686109055996, 1058.222206678091, 1069.3637285814928, 1091.8689757229183, 10196.592136314614, 10639.361638301727, 10659.84010239847, 10760.686452412769, 10764.0, 413081.0, 424580.0, 445855.0, 470197.0, 478109.0, 90995.54502227447, 91431.0, 92905.53547232221, 93375.0, 93427.0, 1043.6399442192583, 1057.1595581512715, 1075.2043487818958, 1103.3986477369854, 1109.6615532262738, 16593.66812663716, 16641.750373744646, 16776.74834877502, 16966.49100526986, 17202.053887035832, 35444.64555354517, 37755.49345169572, 38760.0, 38786.0303492415, 39259.21481570295, 52392.73803630957, 53692.463075368745, 54002.72998634982, 55637.0, 56209.0, 7790.805229869298, 8016.118226995142, 8176.100628930694, 8207.548584827891, 8262.628181731716, 12962.0, 13275.468981241029, 13409.0, 13478.73042539124, 13517.121387109806, 11779.234349767237, 11817.290962542274, 11865.347405892759, 11880.625579378482, 11986.64040078799, 11455.255408398427, 11582.768344633228, 11680.591179308683, 12003.579874704343, 12247.69380765488, 11884.286942783461, 12017.09871759604, 12092.395380230777, 12123.575674851338, 12243.571474998333, 8147.9185208147155, 8332.875006874781, 8669.739907802776, 8706.129387061243, 8715.30277577805, 10963.50664220096, 11382.487788049391, 11656.475458604213, 11735.485254584555, 11833.230839995373], "value": 8884.326524552574, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.7568301230297, 1509.0342181004155, 1660.69277183721, 1753.4476639858435, 1786.3658401267558, 7613.543187408759, 8110.188981101895, 8152.307053900411, 8368.958155209231, 8373.288270497, 8208.384371172157, 8226.054003789566, 8248.0, 8259.628316725746, 8342.874856877152, 2253.5380247049316, 2293.4495721026915, 2294.73610534789, 2295.8737269450176, 2311.0, 2257.413072601127, 2264.320703788865, 2326.534693061386, 2330.5105927755108, 2334.743178250391, 2303.09027933966, 2303.8963246653857, 2306.9077236910503, 2309.4688221709016, 2316.721993360799, 2233.9888300558473, 2241.3051953894264, 2242.7757224277607, 2243.181238847809, 2244.4052326133587, 2198.4613769626385, 2205.0408072488517, 2205.1840818897113, 2205.900734466953, 2206.735191776981, 8390.958045209734, 8467.830643387098, 8482.618282177316, 8520.659173633047, 8526.957365213197, 5064.721440320818, 5256.395514515842, 5267.236250743621, 5269.473052694738, 5269.736513174326, 3060.969390306113, 3081.938361232763, 3116.626004879406, 3142.135912624047, 3159.2259896325318, 1041.5625437316346, 1048.7640280936805, 1051.574112484445, 1068.2789117345837, 1085.4138765066855, 11769.117316201233, 11831.290122592585, 11854.762904741943, 11862.466189021514, 11872.287662740264, 4498.325251212279, 4592.954070459319, 4726.527347265246, 4762.618990480753, 4768.856934291976, 9915.553800079013, 9944.502774861228, 9988.0, 10016.699499014896, 10032.598696052222, 5239.580833533384, 5255.211718242218, 5255.684658920477, 5264.789408423697, 5292.0, 4045.8786236412957, 4698.389209402756, 4772.5227477252, 4825.30033145192, 4842.903141937141, 3786.1859700164046, 3878.7866667333005, 3893.0, 3894.844206231776, 3918.0792513759243, 1257.3838818978634, 1257.7170136719164, 1264.6206138158516, 1268.2010333490027, 1275.0883118570266, 820.7332616899412, 915.624593916491, 1004.9346792458467, 1034.8024603973756, 1039.2257767962917, 5783.855403614859, 5790.826275211751, 5870.090136028923, 5887.028640274307, 5970.313413957364, 449.0480182014151, 452.86187712747267, 456.7145534041224, 459.05205750125884, 459.74254417526294, 3907.1404291055924, 3950.367941129463, 3974.463447434617, 3989.5412027616617, 3990.68074554035, 10097.646582369582, 10174.0, 10334.483275836328, 10347.4308913009, 10419.843702344471, 10182.541785619665, 10225.59097636101, 10298.17614590831, 10311.948440257751, 10363.32638378503, 7759.650815713307, 7943.761687149395, 7968.800779980431, 7973.920260797434, 8039.115697273295, 5886.205362276038, 5967.880642387215, 6044.607100538451, 6046.516278697605, 6106.816795496142, 9436.723115876463, 9682.177014953808, 9688.079632434907, 9754.658586949707, 9807.656732014631, 9716.222702183666, 9856.901430985597, 9909.900900991186, 9995.400275983464, 10027.448490333101, 7141.821454463472, 7318.194998550049, 7394.926050739424, 7542.358899493604, 7585.165631780389, 8056.355491560544, 8112.513249204831, 8162.102168761313, 8165.469244499089, 8202.589870506332, 7212.639368031682, 7409.592472414069, 7423.072115985502, 7483.812904677427, 7490.775276741707, 7195.0, 7400.111986561432, 7414.740484083031, 7426.554406735613, 7482.925170748441, 6579.638119903259, 6617.503687223574, 6665.966670166618, 6671.8665626686225, 6687.0, 4775.379200703886, 4917.655764096479, 4922.089413458521, 4929.13740095489, 4978.2034874419915, 4919.606431485401, 4945.4807245238735, 4958.107540642719, 5053.4946505350645, 5079.3650793650795], "value": 4417.078190177677, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.4371016286744, 326.9509573563965, 329.6522169111587, 337.86140705821384, 344.30106883027463, 5922.141289513018, 6026.849328766783, 6059.697015149241, 6125.601835880665, 6169.537284703654, 5949.196858424111, 5981.760729570812, 5989.520838332934, 6020.75916963322, 6027.909581356273, 4614.100250451163, 4624.213883639773, 4630.606398456135, 4648.186567350717, 4652.674312798105, 4495.325701144821, 4610.285405762095, 4619.630429565644, 4642.210824159901, 4645.69802962808, 4571.222892108333, 4575.4738205106505, 4589.449266088074, 4610.9308360374625, 4615.976920115395, 4608.861734147981, 4616.376789133475, 4632.536746325374, 4651.790669419867, 4655.162070827249, 3768.4158955361963, 3951.9012024699323, 3960.8019599019935, 3966.5835087315704, 4089.5297040840387, 5749.8275051748515, 5774.335951365562, 5793.4785869271545, 5804.680742559158, 5812.418758124154, 5251.212318152269, 5262.2632831403635, 5266.526012658841, 5273.86815329616, 5275.314209152824, 6142.972818969729, 6308.369163083701, 6320.273168585625, 6340.3342649022115, 6342.682865856735, 4353.325234588612, 4353.564643535653, 4375.124975005012, 4382.123575284956, 4406.53731358206, 5878.26481272457, 6503.0, 6617.31258529072, 6689.0, 6697.966510167418, 4422.977885110554, 4433.578810013044, 4437.511873693891, 4439.578240067189, 4446.73319600825, 4481.7535035573355, 4491.079328737666, 4509.0, 4511.390962220124, 4527.615152712056, 5109.897802043938, 5182.896342073137, 5261.026710058652, 5264.263003179558, 5277.894442111213, 6320.62076275425, 6328.171456268891, 6340.968295158587, 6343.809685709436, 6377.553571249968, 1532.3334349557979, 1556.1674504140458, 1558.6493039066347, 1559.2983157579135, 1566.968660626781, 1011.9576835859077, 1028.0901402259055, 1037.9672226135044, 1041.146260066738, 1044.0603456888862, 6061.6666083365835, 6062.181605483292, 6073.331933487313, 6075.453209211104, 6086.817395478142, 6443.935560644427, 6456.063870738717, 6465.321141280192, 6485.643289619116, 6544.662222266678, 5974.133750606138, 6075.696215189223, 6096.359882212304, 6133.509319254449, 6136.7852125175405, 3412.539307193547, 3474.4961980512685, 3482.9303413932084, 3491.546099007113, 3501.4047611906035, 6423.756003218438, 6627.138471998705, 6640.369164929324, 6748.325167483213, 6759.5606285591275, 6582.3746744059235, 6620.437262832616, 6638.302978187317, 6655.667216639149, 6657.234418041987, 6399.8080057598345, 6540.803775886731, 6693.966530167416, 6828.453723702092, 6845.657717114124, 6504.772332968323, 6506.284308725942, 6508.479321654351, 6515.087887695821, 6530.542861999615, 6251.124842521959, 6464.4828413725845, 6489.156409666713, 6509.934900650933, 6535.57518761279, 6829.7023565522395, 6848.2124555674745, 6857.382835544825, 6860.622665753432, 6877.209120951155, 4222.387753775747, 4459.331100334975, 4495.955040449554, 4503.144402563503, 4503.572160644733, 6512.73949042033, 6575.0, 6581.177352830896, 6592.901106483502, 6599.373059559334, 6392.776252831129, 6400.359964003748, 6402.167718196604, 6414.454771344488, 6430.196225471816, 6191.81424557264, 6274.905876411949, 6355.618662880242, 6383.680815959091, 6386.840328991812, 6227.439530442282, 6243.656598887105, 6273.74905003813, 6303.527235457451, 6320.304766475776, 6193.380661933951, 6375.266844312778, 6411.230652321751, 6444.8388790280615, 6485.675716214265, 6254.499640028877, 6258.843528911813, 6266.618684899709, 6271.216097987752, 6279.0], "value": 4766.616852619474, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.4114002787867, 853.1212850763714, 854.3464249848871, 865.1435079271523, 873.6549063120063, 12838.550650727204, 12912.806307905388, 13118.081734278605, 13280.535181268657, 13320.267385293817, 11372.0, 12959.935200323986, 13027.15323503974, 13100.73798524029, 13106.0, 794.0114557376061, 815.0667485728837, 815.09524427885, 816.8202995341015, 818.7257268814955, 797.6769408389582, 800.1958032177653, 801.2468279816983, 803.8633432316491, 805.8952336196286, 853.2193043365313, 856.6616186606318, 857.661223816592, 859.9011113721908, 861.2507118806616, 847.9830403391928, 849.8512760266959, 852.7782776478099, 856.9185927336893, 861.2248975921658, 619.1610367951406, 622.2564035977009, 622.8972219583763, 624.7126321891935, 627.5387590121258, 13134.86865131346, 13141.0, 13155.210687358789, 13186.208827470382, 13259.138156019828, 13088.47646094155, 13199.538016169485, 13252.46990120394, 13282.269475178862, 13313.400896959563, 10793.136549076133, 10807.729806754816, 10903.454827258605, 10974.341539507655, 11010.669679909615, 3317.6848199421015, 3667.651573100551, 3691.298653255873, 3764.3224219640456, 3828.578856325802, 59559.0, 60076.0, 61670.38329616736, 61794.69102654503, 62019.37980620226, 9266.44401335922, 9536.380135291183, 9660.661876834278, 9866.358686685342, 9871.75320616976, 17732.468025959242, 17750.20124094419, 18162.0, 18178.818211817976, 18179.636407272046, 7981.800454988672, 7983.640736166886, 8030.9196908031345, 8088.352931765445, 8197.959010204911, 4463.196624607602, 4485.506594274627, 4489.483709373399, 4561.749103799323, 4578.6794924355645, 3199.744020478356, 3276.262840860787, 3276.885309014173, 3283.6387997320276, 3289.7697161198967, 632.7563887903191, 634.660456655687, 641.3298103481873, 643.0, 651.7458191305394, 670.6546128743701, 720.3085038363125, 760.3385055002072, 763.0995425398083, 788.9526628402199, 9040.457572545669, 9061.54692265384, 9166.17504424605, 9236.676716314896, 9258.213051890665, 651.2250421997808, 676.8510927595921, 738.9371903388164, 746.3096635612037, 751.1511991449627, 4358.302671572533, 4505.359618739059, 4528.569785870337, 4573.771311434415, 4663.533646635377, 68407.0, 68705.65647171832, 70556.6472167636, 71011.64494177495, 71301.2869871305, 52721.2091818623, 53620.65948351323, 57029.0, 57954.0, 59658.40341596529, 48320.27519587209, 51058.23412648813, 53228.73385633047, 54171.18743218855, 54219.18671219935, 8929.241014513838, 9021.729348119567, 9023.774405639911, 9161.587728552364, 9201.677941272023, 32657.836710816293, 32956.34087318192, 33141.50287745734, 33151.50272745959, 33257.16857078592, 41192.588074118874, 42719.3592096125, 44539.0, 45511.31733023941, 45709.31436028529, 11317.660470185907, 11324.094072474347, 11394.601188958346, 11480.655580332603, 11631.47658355359, 12798.488060477848, 13147.211167329991, 13176.670583235496, 13272.601821945356, 13280.089338238668, 11649.825252621387, 11905.464254108412, 12226.633201003984, 12340.876591233973, 12598.937005314914, 11102.500387482422, 11244.775104498029, 11423.314601123959, 11463.885361146615, 11468.885311146782, 11526.250793698382, 12088.697782555506, 12096.637100886988, 12492.43784029739, 12956.676083097998, 9451.432914025181, 9518.857217141609, 9605.663801767185, 9674.806503870024, 10004.949975250078, 9479.146876781122, 9489.124027057664, 9972.700818975442, 9976.650817221362, 10011.149052330633], "value": 6607.5964349957, "unit": "score"}], "name": "dromaeo_css", "value": 7029.959184341869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 112.0, 112.0, 123.0, 111.0, 113.0, 111.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 153.0, 181.0, 133.0, 171.0, 162.0, 130.0, 187.0, 131.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 164.0, 163.0, 162.0, 164.0, 174.0, 164.0, 167.0, 169.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 73.0, 165.0, 77.0, 78.0, 78.0, 77.0, 165.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 150.0, 93.0, 93.0, 93.0, 141.0, 94.0, 93.0, 142.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 146.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 58.0, 58.0, 59.0, 76.0, 56.0, 56.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 77.0, 79.0, 80.0, 79.0, 77.0, 80.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 125.0, 124.0, 137.0, 128.0, 132.0, 124.0, 133.0, 159.0, 148.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 166.0, 167.0, 164.0, 170.0, 165.0, 169.0, 171.0, 161.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 75.0, 70.0, 67.0, 77.0, 69.0, 67.0, 67.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1564.1, "alertThreshold": 2.0}]} 18:02:40 INFO - Return code: 0 18:02:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:02:40 ERROR - # TBPL SUCCESS # 18:02:40 INFO - Running post-action listener: _resource_record_post_action 18:02:40 INFO - Running post-run listener: _resource_record_post_run 18:02:41 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 543531008; Read time: 0; Write time: 557624 18:02:41 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251576320; Read time: 0; Write time: 323060 18:02:41 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 291954688; Read time: 0; Write time: 234564 18:02:41 INFO - Running post-run listener: _upload_blobber_files 18:02:41 INFO - Blob upload gear active. 18:02:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:02:41 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 18:02:41 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'] 18:02:41 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 18:02:42 INFO - (blobuploader) - INFO - Open directory for files ... 18:02:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:02:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:02:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:43 INFO - (blobuploader) - INFO - Done attempting. 18:02:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:02:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:02:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:44 INFO - (blobuploader) - INFO - Done attempting. 18:02:44 INFO - (blobuploader) - INFO - Iteration through files over. 18:02:44 INFO - Return code: 0 18:02:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:02:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:02:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3326311ef9bc999919e649cc1e05bcceb7c909f77b590749f5a9395079376201ec3e1ef8d9ba90537e8ac73b238f6d81a43675ff132f32059ecf16a03f0b6553", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcda4a4bf1b1715b0b8041aa86d6dce7e25910937add1e815f3fd46d63a14b17c0cd9603ac40faf67aefa0ad1be6ec1103291842fee7d886c00d02f12ecaeb59"} 18:02:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:02:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:02:44 INFO - Contents: 18:02:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3326311ef9bc999919e649cc1e05bcceb7c909f77b590749f5a9395079376201ec3e1ef8d9ba90537e8ac73b238f6d81a43675ff132f32059ecf16a03f0b6553", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcda4a4bf1b1715b0b8041aa86d6dce7e25910937add1e815f3fd46d63a14b17c0cd9603ac40faf67aefa0ad1be6ec1103291842fee7d886c00d02f12ecaeb59"} 18:02:44 INFO - Running post-run listener: copy_logs_to_upload_dir 18:02:44 INFO - Copying logs to upload dir... 18:02:44 INFO - mkdir: /builds/slave/test/build/upload/logs 18:02:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.192084 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-21 18:02:44.021848) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 18:02:44.025780) ========= 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=1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627 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/3326311ef9bc999919e649cc1e05bcceb7c909f77b590749f5a9395079376201ec3e1ef8d9ba90537e8ac73b238f6d81a43675ff132f32059ecf16a03f0b6553", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcda4a4bf1b1715b0b8041aa86d6dce7e25910937add1e815f3fd46d63a14b17c0cd9603ac40faf67aefa0ad1be6ec1103291842fee7d886c00d02f12ecaeb59"} build_url:https://queue.taskcluster.net/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/OiUJ-5RdRqGaj_tcGwnG-g/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/3326311ef9bc999919e649cc1e05bcceb7c909f77b590749f5a9395079376201ec3e1ef8d9ba90537e8ac73b238f6d81a43675ff132f32059ecf16a03f0b6553", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcda4a4bf1b1715b0b8041aa86d6dce7e25910937add1e815f3fd46d63a14b17c0cd9603ac40faf67aefa0ad1be6ec1103291842fee7d886c00d02f12ecaeb59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 18:02:44.056944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 18:02:44.057475) ========= 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=1f5564757af27664ca02d71f000001b0-1461285262.945109-1310102627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 18:02:44.139416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 18:02:44.139756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 18:02:44.140109) ========= ========= Total master_lag: 0.22 =========