builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1461856963.99 results: success (0) buildid: 20160428053013 builduid: 38359ca627664e50a7a4561cb50a7ad3 revision: 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:43.993774) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:43.994243) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:43.994519) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.028069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.028435) ========= 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=aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 08:22:44-- 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% 45.8M=0s 2016-04-28 08:22:44 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097901 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.139361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.139703) ========= 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=aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022926 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.189413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.189774) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e --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 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e --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=aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 08:22:44,426 truncating revision to first 12 chars 2016-04-28 08:22:44,426 Setting DEBUG logging. 2016-04-28 08:22:44,426 attempt 1/10 2016-04-28 08:22:44,426 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/03eac758d8d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 08:22:44,671 unpacking tar archive at: fx-team-03eac758d8d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.713420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.713744) ========= script_repo_revision: 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.714131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.714402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:44.725429) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-28 08:22:44.725839) ========= /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=aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:22:45 INFO - MultiFileLogger online at 20160428 08:22:45 in /builds/slave/test 08:22:45 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 08:22:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:45 INFO - {'append_to_log': False, 08:22:45 INFO - 'base_work_dir': '/builds/slave/test', 08:22:45 INFO - 'blob_upload_branch': 'Fx-Team', 08:22:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:45 INFO - 'branch': 'Fx-Team', 08:22:45 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:45 INFO - 'config_files': ('talos/linux_config.py',), 08:22:45 INFO - 'default_actions': ('clobber', 08:22:45 INFO - 'read-buildbot-config', 08:22:45 INFO - 'download-and-extract', 08:22:45 INFO - 'populate-webroot', 08:22:45 INFO - 'create-virtualenv', 08:22:45 INFO - 'install', 08:22:45 INFO - 'run-tests'), 08:22:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:45 INFO - 'download_minidump_stackwalk': True, 08:22:45 INFO - 'download_symbols': 'ondemand', 08:22:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:45 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:45 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:45 INFO - 'installer_path': 'installer.exe', 08:22:45 INFO - 'log_level': 'info', 08:22:45 INFO - 'log_name': 'talos', 08:22:45 INFO - 'log_to_console': True, 08:22:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:22:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:22:45 INFO - 'opt_config_files': (), 08:22:45 INFO - 'pip_index': False, 08:22:45 INFO - 'sps_profile': False, 08:22:45 INFO - 'sps_profile_interval': 0, 08:22:45 INFO - 'suite': 'dromaeojs-e10s', 08:22:45 INFO - 'system_bits': '32', 08:22:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:45 INFO - 'title': 'talos-linux64-ix-009', 08:22:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:45 INFO - 'use_talos_json': True, 08:22:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:45 INFO - 'work_dir': 'build'} 08:22:45 INFO - ##### 08:22:45 INFO - ##### Running clobber step. 08:22:45 INFO - ##### 08:22:45 INFO - Running pre-action listener: _resource_record_pre_action 08:22:45 INFO - Running main action method: clobber 08:22:45 INFO - rmtree: /builds/slave/test/build 08:22:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:45 INFO - Running post-action listener: _resource_record_post_action 08:22:45 INFO - ##### 08:22:45 INFO - ##### Running read-buildbot-config step. 08:22:45 INFO - ##### 08:22:45 INFO - Running pre-action listener: _resource_record_pre_action 08:22:45 INFO - Running main action method: read_buildbot_config 08:22:45 INFO - Using buildbot properties: 08:22:45 INFO - { 08:22:45 INFO - "project": "", 08:22:45 INFO - "product": "firefox", 08:22:45 INFO - "script_repo_revision": "production", 08:22:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:22:45 INFO - "repository": "", 08:22:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:22:45 INFO - "buildid": "20160428053013", 08:22:45 INFO - "pgo_build": "True", 08:22:45 INFO - "basedir": "/builds/slave/test", 08:22:45 INFO - "buildnumber": 700, 08:22:45 INFO - "slavename": "talos-linux64-ix-009", 08:22:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:22:45 INFO - "platform": "ubuntu64_hw", 08:22:45 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:22:45 INFO - "branch": "fx-team", 08:22:45 INFO - "repo_path": "integration/fx-team", 08:22:45 INFO - "revision": "03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e", 08:22:45 INFO - "stage_platform": "linux64-pgo", 08:22:45 INFO - "builduid": "38359ca627664e50a7a4561cb50a7ad3", 08:22:45 INFO - "slavebuilddir": "test" 08:22:45 INFO - } 08:22:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:22:45 INFO - Running post-action listener: _resource_record_post_action 08:22:45 INFO - ##### 08:22:45 INFO - ##### Running download-and-extract step. 08:22:45 INFO - ##### 08:22:45 INFO - Running pre-action listener: _resource_record_pre_action 08:22:45 INFO - Running main action method: download_and_extract 08:22:45 INFO - mkdir: /builds/slave/test/build/tests 08:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:45 INFO - https://queue.taskcluster.net/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:22:46 INFO - Downloaded 1361 bytes. 08:22:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:46 INFO - Using the following test package requirements: 08:22:46 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:46 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:22:46 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:22:46 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:46 INFO - u'jsshell-linux-x86_64.zip'], 08:22:46 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:22:46 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:46 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:22:46 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:22:46 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:22:46 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:22:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:22: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')]} 08:22:46 INFO - https://queue.taskcluster.net/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:51 INFO - Downloaded 23865705 bytes. 08:22:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:22:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:22:52 INFO - Return code: 0 08:22:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:52 INFO - https://queue.taskcluster.net/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:22:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:23:00 INFO - Downloaded 23865705 bytes. 08:23:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:23:01 INFO - Return code: 0 08:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:01 INFO - https://queue.taskcluster.net/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:23:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:23:02 INFO - Downloaded 10840145 bytes. 08:23:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:23:03 INFO - Return code: 0 08:23:03 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')]} 08:23:03 INFO - https://queue.taskcluster.net/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:23:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:23:04 INFO - Downloaded 58388146 bytes. 08:23:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:04 INFO - mkdir: /builds/slave/test/properties 08:23:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:04 INFO - Contents: 08:23:04 INFO - build_url:https://queue.taskcluster.net/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:05 INFO - Running post-action listener: _resource_record_post_action 08:23:05 INFO - Running post-action listener: set_extra_try_arguments 08:23:05 INFO - ##### 08:23:05 INFO - ##### Running populate-webroot step. 08:23:05 INFO - ##### 08:23:05 INFO - Running pre-action listener: _resource_record_pre_action 08:23:05 INFO - Running main action method: populate_webroot 08:23:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:05 INFO - '--tppagecycles', 08:23:05 INFO - '7'], 08:23:05 INFO - 'tests': ['tsvgm']}}, 08:23:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['damp', 'tps']}, 08:23:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'tests': ['damp', 'tps']}, 08:23:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['dromaeo_dom']}, 08:23:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['tsvgx', 08:23:05 INFO - 'tsvgr_opacity', 08:23:05 INFO - 'tart', 08:23:05 INFO - 'tscrollx', 08:23:05 INFO - 'cart']}, 08:23:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:05 INFO - 'tsvgr_opacity', 08:23:05 INFO - 'tart', 08:23:05 INFO - 'tscrollx', 08:23:05 INFO - 'cart']}, 08:23:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['tp5o']}, 08:23:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'tests': ['tp5o']}, 08:23:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'talos_options': ['--disable-e10s', 08:23:05 INFO - '--xperf_path', 08:23:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:05 INFO - 'tests': ['tp5n']}, 08:23:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'talos_options': ['--xperf_path', 08:23:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:05 INFO - 'tests': ['tp5n']}}, 08:23:05 INFO - 'talos.zip': {'path': '', 08:23:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:05 INFO - Running post-action listener: _resource_record_post_action 08:23:05 INFO - ##### 08:23:05 INFO - ##### Running create-virtualenv step. 08:23:05 INFO - ##### 08:23:05 INFO - Running pre-action listener: _resource_record_pre_action 08:23:05 INFO - Running main action method: create_virtualenv 08:23:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:05 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 08:23:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:05 INFO - Using real prefix '/usr' 08:23:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:07 INFO - Installing pip.................done. 08:23:07 INFO - Return code: 0 08:23:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cbaaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c01410>, '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 0x2c02310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c027a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', '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 08:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:23:07 INFO - Using env: {'DISPLAY': ':0', 08:23:07 INFO - 'HOME': '/home/cltbld', 08:23:07 INFO - 'LANG': 'en_US.UTF-8', 08:23:07 INFO - 'LANGUAGE': 'en_US:en', 08:23:07 INFO - 'LOGNAME': 'cltbld', 08:23:07 INFO - 'MAIL': '/var/mail/cltbld', 08:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:07 INFO - 'MOZ_NO_REMOTE': '1', 08:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:07 INFO - 'NO_EM_RESTART': '1', 08:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:07 INFO - 'PWD': '/builds/slave/test', 08:23:07 INFO - 'SHELL': '/bin/bash', 08:23:07 INFO - 'SHLVL': '1', 08:23:07 INFO - 'TERM': 'linux', 08:23:07 INFO - 'TMOUT': '86400', 08:23:07 INFO - 'USER': 'cltbld', 08:23:07 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', 08:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:07 INFO - '_': '/tools/buildbot/bin/python'} 08:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:08 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 08:23:08 INFO - Cleaning up... 08:23:08 INFO - Return code: 0 08:23:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:08 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 0x7f8cbaaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c01410>, '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 0x2c02310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c027a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', '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 08:23:08 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 08:23:08 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 08:23:08 INFO - Using env: {'DISPLAY': ':0', 08:23:08 INFO - 'HOME': '/home/cltbld', 08:23:08 INFO - 'LANG': 'en_US.UTF-8', 08:23:08 INFO - 'LANGUAGE': 'en_US:en', 08:23:08 INFO - 'LOGNAME': 'cltbld', 08:23:08 INFO - 'MAIL': '/var/mail/cltbld', 08:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:08 INFO - 'MOZ_NO_REMOTE': '1', 08:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:08 INFO - 'NO_EM_RESTART': '1', 08:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:08 INFO - 'PWD': '/builds/slave/test', 08:23:08 INFO - 'SHELL': '/bin/bash', 08:23:08 INFO - 'SHLVL': '1', 08:23:08 INFO - 'TERM': 'linux', 08:23:08 INFO - 'TMOUT': '86400', 08:23:08 INFO - 'USER': 'cltbld', 08:23:08 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', 08:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:08 INFO - '_': '/tools/buildbot/bin/python'} 08:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:08 INFO - Downloading/unpacking psutil>=0.7.1 08:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:10 INFO - Installing collected packages: psutil 08:23:10 INFO - Running setup.py install for psutil 08:23:10 INFO - building 'psutil._psutil_linux' extension 08:23:10 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 08:23:10 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 08:23:10 INFO - building 'psutil._psutil_posix' extension 08:23:10 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 08:23:10 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 08:23:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:10 INFO - Successfully installed psutil 08:23:10 INFO - Cleaning up... 08:23:10 INFO - Return code: 0 08:23:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:23:10 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')]} 08:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:10 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')]} 08:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:10 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 0x7f8cbaaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c01410>, '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 0x2c02310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c027a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', '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 08:23:10 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 08:23:10 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 08:23:10 INFO - Using env: {'DISPLAY': ':0', 08:23:10 INFO - 'HOME': '/home/cltbld', 08:23:10 INFO - 'LANG': 'en_US.UTF-8', 08:23:10 INFO - 'LANGUAGE': 'en_US:en', 08:23:10 INFO - 'LOGNAME': 'cltbld', 08:23:10 INFO - 'MAIL': '/var/mail/cltbld', 08:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:10 INFO - 'MOZ_NO_REMOTE': '1', 08:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:10 INFO - 'NO_EM_RESTART': '1', 08:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:10 INFO - 'PWD': '/builds/slave/test', 08:23:10 INFO - 'SHELL': '/bin/bash', 08:23:10 INFO - 'SHLVL': '1', 08:23:10 INFO - 'TERM': 'linux', 08:23:10 INFO - 'TMOUT': '86400', 08:23:10 INFO - 'USER': 'cltbld', 08:23:10 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', 08:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:10 INFO - '_': '/tools/buildbot/bin/python'} 08:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:23:13 INFO - Installing collected packages: mozsystemmonitor 08:23:13 INFO - Running setup.py install for mozsystemmonitor 08:23:13 INFO - Successfully installed mozsystemmonitor 08:23:13 INFO - Cleaning up... 08:23:13 INFO - Return code: 0 08:23:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23:13 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')]} 08:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:13 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')]} 08:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:13 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 0x7f8cbaaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c01410>, '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 0x2c02310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c027a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', '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 08:23:13 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 08:23:13 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 08:23:13 INFO - Using env: {'DISPLAY': ':0', 08:23:13 INFO - 'HOME': '/home/cltbld', 08:23:13 INFO - 'LANG': 'en_US.UTF-8', 08:23:13 INFO - 'LANGUAGE': 'en_US:en', 08:23:13 INFO - 'LOGNAME': 'cltbld', 08:23:13 INFO - 'MAIL': '/var/mail/cltbld', 08:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:13 INFO - 'MOZ_NO_REMOTE': '1', 08:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:13 INFO - 'NO_EM_RESTART': '1', 08:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:13 INFO - 'PWD': '/builds/slave/test', 08:23:13 INFO - 'SHELL': '/bin/bash', 08:23:13 INFO - 'SHLVL': '1', 08:23:13 INFO - 'TERM': 'linux', 08:23:13 INFO - 'TMOUT': '86400', 08:23:13 INFO - 'USER': 'cltbld', 08:23:13 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', 08:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:13 INFO - '_': '/tools/buildbot/bin/python'} 08:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:13 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 08:23:13 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 08:23:13 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 08:23:13 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 08:23:13 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 08:23:13 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 08:23:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23:15 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 08:23:15 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 08:23:15 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 08:23:15 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 08:23:15 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 08:23:15 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 08:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23:15 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 08:23:15 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 08:23:15 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 08:23:15 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 08:23:15 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 08:23:15 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 08:23:15 INFO - Downloading docopt-0.6.1.tar.gz 08:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:16 INFO - Running setup.py install for blobuploader 08:23:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:16 INFO - Running setup.py install for requests 08:23:16 INFO - Running setup.py install for docopt 08:23:16 INFO - Successfully installed blobuploader requests docopt 08:23:16 INFO - Cleaning up... 08:23:16 INFO - Return code: 0 08:23:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:16 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 0x7f8cbaaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c01410>, '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 0x2c02310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c027a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', '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 08:23:16 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 08:23:16 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 08:23:16 INFO - Using env: {'DISPLAY': ':0', 08:23:16 INFO - 'HOME': '/home/cltbld', 08:23:16 INFO - 'LANG': 'en_US.UTF-8', 08:23:16 INFO - 'LANGUAGE': 'en_US:en', 08:23:16 INFO - 'LOGNAME': 'cltbld', 08:23:16 INFO - 'MAIL': '/var/mail/cltbld', 08:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:16 INFO - 'MOZ_NO_REMOTE': '1', 08:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:16 INFO - 'NO_EM_RESTART': '1', 08:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:16 INFO - 'PWD': '/builds/slave/test', 08:23:16 INFO - 'SHELL': '/bin/bash', 08:23:16 INFO - 'SHLVL': '1', 08:23:16 INFO - 'TERM': 'linux', 08:23:16 INFO - 'TMOUT': '86400', 08:23:16 INFO - 'USER': 'cltbld', 08:23:16 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', 08:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:16 INFO - '_': '/tools/buildbot/bin/python'} 08:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:16 INFO - Running setup.py (path:/tmp/pip-D_Hj0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:16 INFO - Running setup.py (path:/tmp/pip-BCU4ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:16 INFO - Running setup.py (path:/tmp/pip-mQrLuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:17 INFO - Running setup.py (path:/tmp/pip-sDakh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:17 INFO - Running setup.py (path:/tmp/pip-Xly5ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:17 INFO - Running setup.py (path:/tmp/pip-afsQZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:17 INFO - Running setup.py (path:/tmp/pip-mTTQgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:17 INFO - Running setup.py (path:/tmp/pip-z9MTJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:17 INFO - Running setup.py (path:/tmp/pip-a9rFE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:17 INFO - Running setup.py (path:/tmp/pip-5FSPCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:17 INFO - Running setup.py (path:/tmp/pip-Rjou0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:17 INFO - Running setup.py (path:/tmp/pip-Ve2baz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:17 INFO - Running setup.py (path:/tmp/pip-eA5R9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:17 INFO - Running setup.py (path:/tmp/pip-jtsf76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:17 INFO - Running setup.py (path:/tmp/pip-Nlr6uF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:17 INFO - Running setup.py (path:/tmp/pip-3chBtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:17 INFO - Running setup.py (path:/tmp/pip-MvWvZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:18 INFO - Running setup.py install for manifestparser 08:23:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for mozcrash 08:23:18 INFO - Running setup.py install for mozdebug 08:23:18 INFO - Running setup.py install for mozdevice 08:23:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for mozfile 08:23:18 INFO - Running setup.py install for mozhttpd 08:23:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for mozinfo 08:23:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for mozInstall 08:23:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for mozleak 08:23:18 INFO - Running setup.py install for mozlog 08:23:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:19 INFO - Running setup.py install for moznetwork 08:23:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:19 INFO - Running setup.py install for mozprocess 08:23:19 INFO - Running setup.py install for mozprofile 08:23:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:19 INFO - Running setup.py install for mozrunner 08:23:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:19 INFO - Running setup.py install for mozscreenshot 08:23:19 INFO - Running setup.py install for moztest 08:23:19 INFO - Running setup.py install for mozversion 08:23:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:19 INFO - Cleaning up... 08:23:19 INFO - Return code: 0 08:23:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:19 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 0x7f8cbaaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c01410>, '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 0x2c02310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c027a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', '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 08:23:19 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 08:23:19 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 08:23:19 INFO - Using env: {'DISPLAY': ':0', 08:23:19 INFO - 'HOME': '/home/cltbld', 08:23:19 INFO - 'LANG': 'en_US.UTF-8', 08:23:19 INFO - 'LANGUAGE': 'en_US:en', 08:23:19 INFO - 'LOGNAME': 'cltbld', 08:23:19 INFO - 'MAIL': '/var/mail/cltbld', 08:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:19 INFO - 'MOZ_NO_REMOTE': '1', 08:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:19 INFO - 'NO_EM_RESTART': '1', 08:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:19 INFO - 'PWD': '/builds/slave/test', 08:23:19 INFO - 'SHELL': '/bin/bash', 08:23:19 INFO - 'SHLVL': '1', 08:23:19 INFO - 'TERM': 'linux', 08:23:19 INFO - 'TMOUT': '86400', 08:23:19 INFO - 'USER': 'cltbld', 08:23:19 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', 08:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:19 INFO - '_': '/tools/buildbot/bin/python'} 08:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:20 INFO - Running setup.py (path:/tmp/pip-uXmIGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:20 INFO - Running setup.py (path:/tmp/pip-E8CJaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:20 INFO - Running setup.py (path:/tmp/pip-tteYTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:20 INFO - Running setup.py (path:/tmp/pip-gTtbBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:20 INFO - Running setup.py (path:/tmp/pip-yAOO4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:20 INFO - Running setup.py (path:/tmp/pip-DdJIzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:20 INFO - Running setup.py (path:/tmp/pip-ge2CwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:20 INFO - Running setup.py (path:/tmp/pip-vvZvFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:20 INFO - Running setup.py (path:/tmp/pip-37CzGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:20 INFO - Running setup.py (path:/tmp/pip-cJvXcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:20 INFO - Running setup.py (path:/tmp/pip-F_Y3_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:20 INFO - Running setup.py (path:/tmp/pip-tnu0Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:20 INFO - Running setup.py (path:/tmp/pip-WfZmwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:21 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)) 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:21 INFO - Running setup.py (path:/tmp/pip-nLdlZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:21 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)) 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:21 INFO - Running setup.py (path:/tmp/pip-WaDLwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:21 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)) 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:21 INFO - Running setup.py (path:/tmp/pip-IT5nxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:21 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)) 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:21 INFO - Running setup.py (path:/tmp/pip-sTkyIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:21 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)) 08:23:21 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)) 08:23:21 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)) 08:23:21 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)) 08:23:21 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)) 08:23:21 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)) 08:23:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:21 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 08:23:21 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 08:23:21 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 08:23:21 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 08:23:21 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 08:23:21 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 08:23:23 INFO - Downloading blessings-1.6.tar.gz 08:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:23 INFO - Installing collected packages: blessings 08:23:23 INFO - Running setup.py install for blessings 08:23:23 INFO - Successfully installed blessings 08:23:23 INFO - Cleaning up... 08:23:23 INFO - Return code: 0 08:23:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:23 INFO - Reading from file tmpfile_stdout 08:23:23 INFO - Current package versions: 08:23:23 INFO - argparse == 1.2.1 08:23:23 INFO - blessings == 1.6 08:23:23 INFO - blobuploader == 1.2.4 08:23:23 INFO - docopt == 0.6.1 08:23:23 INFO - manifestparser == 1.1 08:23:23 INFO - mozInstall == 1.12 08:23:23 INFO - mozcrash == 0.17 08:23:23 INFO - mozdebug == 0.1 08:23:23 INFO - mozdevice == 0.48 08:23:23 INFO - mozfile == 1.2 08:23:23 INFO - mozhttpd == 0.7 08:23:23 INFO - mozinfo == 0.9 08:23:23 INFO - mozleak == 0.1 08:23:23 INFO - mozlog == 3.1 08:23:23 INFO - moznetwork == 0.27 08:23:23 INFO - mozprocess == 0.22 08:23:23 INFO - mozprofile == 0.28 08:23:23 INFO - mozrunner == 6.11 08:23:23 INFO - mozscreenshot == 0.1 08:23:23 INFO - mozsystemmonitor == 0.0 08:23:23 INFO - moztest == 0.7 08:23:23 INFO - mozversion == 1.4 08:23:23 INFO - psutil == 3.1.1 08:23:23 INFO - requests == 1.2.3 08:23:23 INFO - wsgiref == 0.1.2 08:23:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:23 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 0x7f8cbaaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c01410>, '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 0x2c02310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c027a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', '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 08:23:23 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 08:23:23 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 08:23:23 INFO - Using env: {'DISPLAY': ':0', 08:23:23 INFO - 'HOME': '/home/cltbld', 08:23:23 INFO - 'LANG': 'en_US.UTF-8', 08:23:23 INFO - 'LANGUAGE': 'en_US:en', 08:23:23 INFO - 'LOGNAME': 'cltbld', 08:23:23 INFO - 'MAIL': '/var/mail/cltbld', 08:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:23 INFO - 'MOZ_NO_REMOTE': '1', 08:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:23 INFO - 'NO_EM_RESTART': '1', 08:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:23 INFO - 'PWD': '/builds/slave/test', 08:23:23 INFO - 'SHELL': '/bin/bash', 08:23:23 INFO - 'SHLVL': '1', 08:23:23 INFO - 'TERM': 'linux', 08:23:23 INFO - 'TMOUT': '86400', 08:23:23 INFO - 'USER': 'cltbld', 08:23:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', 08:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:23 INFO - '_': '/tools/buildbot/bin/python'} 08:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:23 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)) 08:23:23 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)) 08:23:23 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)) 08:23:23 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)) 08:23:23 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)) 08:23:23 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)) 08:23:23 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)) 08:23:23 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)) 08:23:23 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)) 08:23:23 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)) 08:23:23 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)) 08:23:23 INFO - Cleaning up... 08:23:23 INFO - Return code: 0 08:23:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:23 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 0x7f8cbaaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c01410>, '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 0x2c02310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c027a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', '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 08:23:23 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 08:23:23 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 08:23:23 INFO - Using env: {'DISPLAY': ':0', 08:23:23 INFO - 'HOME': '/home/cltbld', 08:23:23 INFO - 'LANG': 'en_US.UTF-8', 08:23:23 INFO - 'LANGUAGE': 'en_US:en', 08:23:23 INFO - 'LOGNAME': 'cltbld', 08:23:23 INFO - 'MAIL': '/var/mail/cltbld', 08:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:23 INFO - 'MOZ_NO_REMOTE': '1', 08:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:23 INFO - 'NO_EM_RESTART': '1', 08:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:23 INFO - 'PWD': '/builds/slave/test', 08:23:23 INFO - 'SHELL': '/bin/bash', 08:23:23 INFO - 'SHLVL': '1', 08:23:23 INFO - 'TERM': 'linux', 08:23:23 INFO - 'TMOUT': '86400', 08:23:23 INFO - 'USER': 'cltbld', 08:23:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', 08:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:23 INFO - '_': '/tools/buildbot/bin/python'} 08:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:24 INFO - Downloading/unpacking jsonschema 08:23:24 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 08:23:24 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 08:23:24 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 08:23:24 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 08:23:24 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 08:23:24 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 08:23:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:25 INFO - Downloading/unpacking functools32 (from jsonschema) 08:23:25 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 08:23:25 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 08:23:25 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 08:23:25 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 08:23:25 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 08:23:25 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 08:23:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:26 INFO - warning: no files found matching '*.txt' 08:23:26 INFO - no previously-included directories found matching 'build' 08:23:26 INFO - no previously-included directories found matching 'dist' 08:23:26 INFO - no previously-included directories found matching '.git*' 08:23:26 INFO - Installing collected packages: jsonschema, functools32 08:23:26 INFO - Running setup.py install for functools32 08:23:26 INFO - warning: no files found matching '*.txt' 08:23:26 INFO - no previously-included directories found matching 'build' 08:23:26 INFO - no previously-included directories found matching 'dist' 08:23:26 INFO - no previously-included directories found matching '.git*' 08:23:26 INFO - Successfully installed jsonschema functools32 08:23:26 INFO - Cleaning up... 08:23:26 INFO - Return code: 0 08:23:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:23:26 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')]} 08:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:26 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')]} 08:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:26 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 0x7f8cbaaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b725a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c01410>, '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 0x2c02310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c027a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', '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 08:23:26 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 08:23:26 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 08:23:26 INFO - Using env: {'DISPLAY': ':0', 08:23:26 INFO - 'HOME': '/home/cltbld', 08:23:26 INFO - 'LANG': 'en_US.UTF-8', 08:23:26 INFO - 'LANGUAGE': 'en_US:en', 08:23:26 INFO - 'LOGNAME': 'cltbld', 08:23:26 INFO - 'MAIL': '/var/mail/cltbld', 08:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:26 INFO - 'MOZ_NO_REMOTE': '1', 08:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:26 INFO - 'NO_EM_RESTART': '1', 08:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:26 INFO - 'PWD': '/builds/slave/test', 08:23:26 INFO - 'SHELL': '/bin/bash', 08:23:26 INFO - 'SHLVL': '1', 08:23:26 INFO - 'TERM': 'linux', 08:23:26 INFO - 'TMOUT': '86400', 08:23:26 INFO - 'USER': 'cltbld', 08:23:26 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', 08:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:26 INFO - '_': '/tools/buildbot/bin/python'} 08:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:26 INFO - Downloading/unpacking flake8 08:23:26 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 08:23:26 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 08:23:26 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 08:23:26 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 08:23:26 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 08:23:26 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 08:23:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:23:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:23:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 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 08:23:28 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 08:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:23:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:23:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:23:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:23:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:23:29 INFO - no previously-included directories found matching 'docs/_build' 08:23:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:23:29 INFO - Running setup.py install for pep8 08:23:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:23:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:23:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:23:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:23:29 INFO - no previously-included directories found matching 'docs/_build' 08:23:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:23:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:23:29 INFO - Cleaning up... 08:23:29 INFO - Return code: 0 08:23:29 INFO - Running post-action listener: _resource_record_post_action 08:23:29 INFO - Running post-action listener: _start_resource_monitoring 08:23:29 INFO - Starting resource monitoring. 08:23:29 INFO - ##### 08:23:29 INFO - ##### Running install step. 08:23:29 INFO - ##### 08:23:29 INFO - Running pre-action listener: _resource_record_pre_action 08:23:29 INFO - Running main action method: install 08:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:29 INFO - Reading from file tmpfile_stdout 08:23:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:29 INFO - Reading from file tmpfile_stdout 08:23:29 INFO - Output received: 08:23:29 INFO - Usage: mozinstall [options] installer 08:23:29 INFO - Options: 08:23:29 INFO - -h, --help show this help message and exit 08:23:29 INFO - -d DEST, --destination=DEST 08:23:29 INFO - Directory to install application into. [default: 08:23:29 INFO - "/builds/slave/test"] 08:23:29 INFO - --app=APP Application being installed. [default: firefox] 08:23:29 INFO - mkdir: /builds/slave/test/build/application 08:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:23:46 INFO - Reading from file tmpfile_stdout 08:23:46 INFO - Output received: 08:23:46 INFO - /builds/slave/test/build/application/firefox/firefox 08:23:46 INFO - Running post-action listener: _resource_record_post_action 08:23:46 INFO - ##### 08:23:46 INFO - ##### Running run-tests step. 08:23:46 INFO - ##### 08:23:46 INFO - Running pre-action listener: _resource_record_pre_action 08:23:46 INFO - Running main action method: run_tests 08:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:46 INFO - Python 2.7.3 08:23:46 INFO - Return code: 0 08:23:46 INFO - grabbing minidump binary from tooltool 08:23: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')]} 08:23:46 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 0x2c01410>, '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 0x2c02310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c027a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:46 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 08:23:46 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 08:23:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:46 INFO - Return code: 0 08:23:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:23:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:23:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:23:47 INFO - Return code: 0 08:23:47 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/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 08:23:47 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/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 08:23:47 INFO - Using env: {'DISPLAY': ':0', 08:23:47 INFO - 'HOME': '/home/cltbld', 08:23:47 INFO - 'LANG': 'en_US.UTF-8', 08:23:47 INFO - 'LANGUAGE': 'en_US:en', 08:23:47 INFO - 'LOGNAME': 'cltbld', 08:23:47 INFO - 'MAIL': '/var/mail/cltbld', 08:23:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:47 INFO - 'MOZ_NO_REMOTE': '1', 08:23:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:47 INFO - 'NO_EM_RESTART': '1', 08:23:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:47 INFO - 'PWD': '/builds/slave/test', 08:23:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:47 INFO - 'SHELL': '/bin/bash', 08:23:47 INFO - 'SHLVL': '1', 08:23:47 INFO - 'TERM': 'linux', 08:23:47 INFO - 'TMOUT': '86400', 08:23:47 INFO - 'USER': 'cltbld', 08:23:47 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734', 08:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:47 INFO - '_': '/tools/buildbot/bin/python'} 08:23:47 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/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 08:23:47 INFO - mozversion application_buildid: 20160428053013 08:23:47 INFO - mozversion application_changeset: 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e 08:23:47 INFO - mozversion application_display_name: Nightly 08:23:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:47 INFO - mozversion application_name: Firefox 08:23:47 INFO - mozversion application_remotingname: firefox 08:23:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:23:47 INFO - mozversion application_vendor: Mozilla 08:23:47 INFO - mozversion application_version: 49.0a1 08:23:47 INFO - mozversion platform_buildid: 20160428053013 08:23:47 INFO - mozversion platform_changeset: 03eac758d8d7b0ce6b284bc1cf17512fe7a1ca2e 08:23:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:23:47 INFO - mozversion platform_version: 49.0a1 08:23:47 INFO - using testdate: 1461857027 08:23:47 INFO - actual date: 1461857027 08:23:47 INFO - starting webserver on 'localhost:44062' 08:23:47 INFO - SUITE-START | Running 2 tests 08:23:47 INFO - TEST-START | dromaeo_css 08:23:47 INFO - operating with platform_type : linux_ 08:23:47 INFO - Initialising browser for dromaeo_css test... 08:23:47 INFO - TEST-INFO | started process 29226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbr5hXc/profile http://localhost:44062/getInfo.html) 08:23:51 INFO - PROCESS | 29226 | 08:23:51 INFO - PROCESS | 29226 | (process:29295): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:23:52 INFO - PROCESS | 29226 | __metrics Screen width/height:1600/1200 08:23:52 INFO - PROCESS | 29226 | colorDepth:24 08:23:52 INFO - PROCESS | 29226 | Browser inner width/height: 1024/697 08:23:52 INFO - PROCESS | 29226 | __metrics 08:23:53 ERROR - PROCESS | 29226 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:23:54 INFO - TEST-INFO | 29226: exit 0 08:23:54 INFO - Browser initialized. 08:23:54 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:54 INFO - TEST-INFO | started process 29346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbr5hXc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:56 INFO - PROCESS | 29346 | 08:23:56 INFO - PROCESS | 29346 | (process:29407): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:24:06 INFO - PROCESS | 29346 | RSS: Main: 164573184 08:24:06 INFO - PROCESS | 29346 | 08:24:55 INFO - PROCESS | 29346 | 1461857095694 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] 08:27:03 INFO - PROCESS | 29346 | Cycle 1(1): loaded http://localhost:44062/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44062/tests/dromaeo/cssquery-ext.html) 08:27:04 INFO - PROCESS | 29346 | RSS: Main: 169627648 08:27:04 INFO - PROCESS | 29346 | 08:30:06 INFO - PROCESS | 29346 | Cycle 1(1): loaded http://localhost:44062/tests/dromaeo/cssquery-ext.html (next: http://localhost:44062/tests/dromaeo/cssquery-jquery.html) 08:30:07 INFO - PROCESS | 29346 | RSS: Main: 166989824 08:30:07 INFO - PROCESS | 29346 | 08:33:08 INFO - PROCESS | 29346 | Cycle 1(1): loaded http://localhost:44062/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44062/tests/dromaeo/cssquery-mootools.html) 08:33:09 INFO - PROCESS | 29346 | RSS: Main: 167784448 08:33:09 INFO - PROCESS | 29346 | 08:36:11 INFO - PROCESS | 29346 | Cycle 1(1): loaded http://localhost:44062/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44062/tests/dromaeo/cssquery-prototype.html) 08:36:11 INFO - PROCESS | 29346 | RSS: Main: 165150720 08:36:11 INFO - PROCESS | 29346 | 08:39:14 INFO - PROCESS | 29346 | Cycle 1(1): loaded http://localhost:44062/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44062/tests/dromaeo/cssquery-yui.html) 08:39:14 INFO - PROCESS | 29346 | RSS: Main: 166076416 08:39:14 INFO - PROCESS | 29346 | 08:42:17 INFO - PROCESS | 29346 | Cycle 1(1): loaded http://localhost:44062/tests/dromaeo/cssquery-yui.html (next: http://localhost:44062/tests/dromaeo/cssquery-dojo.html) 08:42:17 INFO - PROCESS | 29346 | RSS: Main: 168689664 08:42:17 INFO - PROCESS | 29346 | 08:42:17 INFO - PROCESS | 29346 | __start_tp_report 08:42:17 INFO - PROCESS | 29346 | _x_x_mozilla_page_load 08:42:17 INFO - PROCESS | 29346 | _x_x_mozilla_page_load_details 08:42:17 INFO - PROCESS | 29346 | |i|pagename|runs| 08:42:17 INFO - PROCESS | 29346 | |0;dojo.html;3154.589903312569;3213.9196520086994;3228.3059142284405;3243.951340729891;3251.934961300774;5400.945990540094;5406.918896216555;5414.296141501609;5419.837404877855;5450.236966824647;5385.919211211835;5412.512873841353;5478;5485.424030476803;5489.862753431166;4932.926006109911;4989.176785830334;5048.596112311006;5081.161608334621;5111.335526381566;4897.779599917994;5088.440271570124;5102.464241254671;5106.08090543702;5114.02833461643;4828.903421931577;4832.492588278215;4870;5009.549140577347;5018.745313671582;4892.198199814618;4920.72935988524;4922.138625740481;4948.8617617948075;4955.4548999610015;4886.853394398138;4905.239687848353;4918.901621967577;4936.7531623419045;4954.851354459372;5240.109181439165;5264.7890985073645;5305.761240744176;5316.20256961455;5361.383440904307;5564.081926482126;5582.665040097607;5595.524380427628;5595.916061259044;5612.522935550483;5630;5661.348944871352;5675.262215911946;5706.857328566777;5733.655980641175;5461.18082287656;5463.644863083927;5487.039768040617;5520.861978450571;5539.695316757577;5906.468417842329;5944.940550594439;5948.345681974979;5949.3753155918;5963.910541341883;5524.281843360337;5671.177679236487;5692.800751973661;5714.857128571819;5716.5998380113;5767.480926716532;5771.653700777967;5772.740226689725;5780.624259423124;5819.825405237765;5605.047141985872;5711.571632127607;5713.800016999468;5740.339860915965;5752.252207213036;5688.800891968761;5742.224799652077;5797.391273916178;5815.82552523425;5834.912476312858;4392.934105988413;4417.359482874966;4420.9115817684105;4425.269830477935;4471.217536931024;3934.626210509997;3936.7637941723588;3940.625640564142;3961.445397644332;3977.8209980550946;5473.452654734574;5491.176323551499;5532.917006244909;5556.555475561945;5565.081761509306;5819.6508209507565;5837.211976383219;5850.180974663551;5861.501772349398;5909.2908850938165;5591.4688104629995;5613.101903695389;5627.8593035174445;5645;5654.604177707603;4878.317035615017;4940.975295123501;4993.425756038102;4999.200127979506;5033.697978121324;6089.725962331706;6129.478994285447;6135.5398345124295;6135.785247516315;6144.4469997699525;5849.941500585025;5883.382244864399;5886.3525012247765;5887.028640274478;5887.322957859729;5749.568782341425;5925.229720136354;5996;6037.63774173551;6062;5645.802396916089;5650.547956163415;5652.293463317085;5663.377028526941;5681.829545113653;5738.8278351649515;5754.798582049776;5766.711664416678;5767.971160144172;5768.94231057684;5406.78372865081;5582.49757521825;5634.915476267941;5650.886982260414;5686.4029276926985;5626.943730562642;5759.107338362561;5764.452377024176;5778.306603207642;5788.044972579477;5627.43725627434;5635.408282130317;5648.85877853057;5659.518940890071;5666.943330566642;5631.1271752878365;5651.6043876928225;5743.224664670383;5766.3368712598585;5789.1605717171615;5641.37944826077;5645.915311270416;5648.830535083954;5659.915101273402;5660.349059858169 08:42:17 INFO - PROCESS | 29346 | |1;ext.html;605.8606520500285;654.8984907339362;656.0520048529874;662.1888186970959;664.5746722097855;32274.67725322746;33781.324373512514;33874.66125338746;33906;33962.32075358494;34650.653493465055;35329;35354.64645353545;35501.2899742005;35518;8243.299319557846;8428.578571071452;8429.831403371929;8431.156884311582;8432.873506897402;8296.419250652456;8674.392792504526;8680.913190868105;8683;8702.564871756418;8655.221030107288;8657.26413254871;8706.303495720358;8722.258608018326;8762.737117886474;8609.56952152393;8690.869636955482;8721.520316382597;8735.25750311218;8758.386912916098;8554.871676924851;8653.480791152488;8668.349873759493;8669.479831210148;8686.609102590335;29905.401891962258;35054.82472587646;35543.82228088843;35683.28633427317;35783.64216357829;3289.7697161198726;3398.64314247003;3585.2470981094;3985.143194213229;4052.0882801369753;25963.350916227057;26104.34739131518;26422.471550569073;26890;27009.189724308304;3948.1116748731592;3949.9012524687114;3953.2093581283857;4032.495938007749;4038.7778672173017;176776;177696;179217;179516;180067.09966450214;31441.528377074363;31616.683833161373;31819.40902954843;31929.52105718416;32548.511772323433;32374;32576.83711581427;32642.51036234411;32813.343733125206;32816.34367312688;14573.344199511048;14678.41286348534;14732;14822.481213157487;14828.110313381232;12203.14577979533;12244.142909996215;12247.632571022883;12261.816072758917;12337.259764414164;7895.368370530344;7962;7990.161033091558;8068.031836179696;8068.798280043045;3166.9524957125664;3194.3930653176285;3217.0670505553126;3233.6766323367474;3241.4003409369343;1061.0185578340004;1067.9626213082504;1075.0969185883896;1077.3912739302425;1180.6694125644833;29553.85223073914;29727.405451891274;29899.701002989692;29971;30086.398272034876;1150.7871043856746;1161.1059484197121;1197.9940100299443;1222.9665932287203;1240.976194639426;15107.622309442351;15583.688326233638;15850.52448426549;16038.919805400898;16322.836771632132;356204;359951;360942;362427;365277;50534.49465505298;52062.21906671403;52095.95808083817;52130;52130.47869521332;1397.406102406473;1399.363289703203;1421.3959067396315;1425.6792221750231;1439.6904665496968;28729.712702872705;28805.7119428803;28887;30102.69897300999;30167.698323016488;44597.77701111474;45175.54824451714;45177.54822451733;45178.77410612926;45210.321845173006;244805;246787;246808;247537;247777;25598.598209930187;25905.222843314732;25966.48067038611;26412.603810943234;26420.339491512867;43067.35398968955;43354.56645433505;43593;43837.34243986406;44568.55431445644;36286.27427451489;36491.817540912125;36671.266574668894;36851.26297473982;37168.628313716516;35599.11002224965;36866.78799272052;37149.6285037157;37201.627983719816;37504.249915002096;31002;35299;35388.82305588455;36051.819740901126;38091.2381752369;30684;30748.692513074584;30960.0711978641;31128.844355778077;31387.686123138476;24776.38059048466;25087.372815679755;25232.098308694734;25760.61359079653;26007.869960650074 08:42:17 INFO - PROCESS | 29346 | |2;jquery.html;400.1177403824567;402.4948689394809;407.41739312782715;408.7077739416317;414.59991108580215;13476;17176.969381837083;17711.29154833805;17855.285788568457;17944.282228710854;17661.82338176618;17819.287228510842;18186.09069546524;18530.44408667742;18752.156152973115;5539.861503462405;5573.08044172712;5658.773649054033;5706.885862282773;5732.5127364174095;5629.071203251458;5658.74535645897;5673;5690.9146362804595;5694.117411801178;5458.4814442627885;5651.434856514336;5669.914951275714;5688.317401911776;5696.746715722535;5592.273004509408;5609.186667933147;5629.60592758507;5638.323401191842;5644.858878528029;4875.609951203895;5055.721935293557;5095.949040509585;5107.846764597068;5109.770060347256;21049.789502104937;21484.355469335944;21494.785052149437;21545.46136346588;21608;2385.284414675608;2514.120057979711;2730.426610411816;2758.213909035935;2803.074985254861;13688.452461901512;14111.576652700436;14288.142711437244;14358.784618230631;14359.353829077716;1964.6168997045581;1980.2673010985884;2009.3971808457404;2018.8788672679539;2075.958480830375;66243.66878165578;66475;67199;67572.662136689;68586.31413685849;9432;9794;9822.950885245527;9922;10115.494225288707;13947.372368243454;14140.222287774272;14305.28473576317;14307.713845723027;14644.707105858037;7679.731209407644;7958.761237162895;7959.8408031839035;8027.839443211103;8074;7610.315071643578;7747.22527747232;7815;7855.371570274365;7900.486468379537;4694.530546945278;4761.880952976134;4762.285657151455;4799.856004319806;4820.493848145894;1790.3017823049022;1824.379710898301;1902.248611798332;1967.5868067705655;1978.2680408248752;445.3253321218357;936.180841763457;1061.3260579531898;1068.6740544134113;1083.4853444613746;10480.47597620116;11054.889451105546;11056.226064175431;11093.667189984313;11142.387168705798;441.0869500134754;443.3416376680627;452.7690877652421;460.9492955774862;468.960138388234;6086.269647642312;6115.113308570232;6131.601445906002;6156.8768624627255;6208.689565521706;453453;454443;524167;529124;534315;75001.62499187469;75932.62033689796;75961.24038759542;76325.23674763182;76602.23397766062;478.7797613098014;481.9950403408862;483.5599604360016;488.46757034832206;488.88511199868003;9893.159081478156;10156.898431015596;10232.386056836614;10352.896471035194;10683.091937185427;34656;34724.3996516113;35135.64864351324;35921.64078359183;36218.55125795044;48743.29398471036;49441.75299992575;49585.75207123941;49775.00449991052;49844.25233621426;7870.606469676608;8071.23323284287;8190.672373105247;8245.587720614065;8269.83460330802;11212.383318917538;12753.48986040548;13075.738485230433;13217.149599055947;13273.867261327263;10727.570897164025;10762.3542587445;10939.45302734876;11216.83174752363;11701.88298117008;11245.93163649452;11377.886221137682;11429.142814289127;11452.770944581229;11461.369624670722;11626.70933226676;11626.88373116258;11804.940975295069;11805.396809620559;11857;8464.57677116154;8514.574271286534;8637.049924508174;8713.215810577078;8986.415882967585;8763.211310982042;11313.830292545454;11516.53933842637;11575.88424115748;11638.904997100602 08:42:17 INFO - PROCESS | 29346 | |3;mootools.html;1526.6259766357243;1535.8233803112641;1671.0892563552864;1767.3637490503409;1786.1069465267367;7764.495307805003;8249.546274954875;8361.83276334473;8631.438956467826;8677.305815534757;8455.873161902577;8463.788405289855;8516.403851730382;8529.488230706147;8547.444416112949;2295.5753185660665;2332.918347857825;2335.5562443135836;2339.543788961153;2345.6129738593113;2304.4238940264936;2309.9076036958586;2337.8714170720605;2346.4720437901506;2349.2952114365708;2242.9102835886547;2255.0190667059883;2257.3792207143;2299.9770002300015;2308.73449553301;2196.967045494319;2200.8679479231296;2201.020545857094;2208.646616541346;2245.2253972379503;2222.5443784024237;2233.7207849018873;2239.496113374494;2241.1707668162885;2242.742084660252;8565.400421970464;8625.482471051757;8646.265067469272;8670.523121228392;8686.044535101133;4952.975235123801;5163.225516172567;5167.586593072545;5195.220716892459;5210.609204309654;3106.534019897011;3238.77328586999;3339.9499007514664;3344.715699165574;3363.2937083212555;1073.3023534702427;1083.5394957143183;1087.3041253597703;1101.735583459964;1140.4810811081022;11745.295282283005;11792.646220613395;11796.174267801258;11844.881551184464;11854.229475084092;4521.367008618796;4644.419447569054;4657.1617108920045;4761.500042495557;4772.045590881838;10024.699259022242;10048.849267260997;10051.24615653829;10085.647002354883;10130.949345253226;5227.424983251839;5287.23335116406;5294.100002999499;5310.654807437581;5315.28243687105;4286.992556749162;4704.670673052922;4857.611391088704;4865.854024379274;4908.092002979461;3907.531096268466;3970.5830887756947;3975.5229372475487;4002.659773919191;4168.937465937953;1171.5899435197782;1195.7548702516137;1196.7127889306503;1203.9097067719956;1267.7084270617624;1010.3937637417491;1017.9236557258236;1019.5768755966191;1031.9174466042848;1040.7918416316768;5886.293644762656;5999.580029397987;6014;6039.909401358983;6235.407636274546;937.8358787212211;954.4702690007113;977.6627063663167;1019.7756493571402;1039.0700323210683;4007.8396864125107;4155.729877557949;4187.748735075906;4226.915461690749;4231.217224813419;9792.265580081523;10225.897741022643;10262.948685256675;10342.689719308433;10458.424786636808;10410.583576657;10493.108085812639;10543.789124217627;10562;10610.787784244272;7756.495827771289;8005.839883202303;8072.3138533224155;8083.514989100673;8108.554029528433;5815.389384114607;5895.233619629421;5904.498117660047;6076.331603523698;6082.847928801815;9297.907970706538;9875.209983201183;9953.800923981624;9957.701268961653;10112.595496180365;9908.504574771088;9997.550110245202;10021.599136034478;10059.849102263619;10232.64185753495;6811.557248778813;7632.38940884739;7658;7697.961510192413;7841.294283514511;8233.135520770233;8320.417570769989;8321.251087402163;8371.33029357662;8389.11914248995;7122.786316410516;7353.926460735324;7405.703771849066;7442.441816863865;7551.433642476946;7503.5497870127965;7639.197884222077;7686.615669216405;7720.112187098555;7738.4969976951315;7044.506884518035;7047.612381319077;7094.219635840157;7110.25342339047;7118.359347658528;4995.075910956485;5120.74396280177;5158.613104017289;5190.740462976761;5276.472352764693;5014.6991180529285;5023.246513023076;5063.974680126723;5070.543651071422;5083.059633967728 08:42:17 INFO - PROCESS | 29346 | |4;prototype.html;322.5001248065499;329.6324598073149;331.1737215646961;335.6408642752256;338.3824520250542;5464.207689884965;5519.558435325164;5579.609427340088;5602.887942241163;5623.465770751783;5438.401775804668;5472.179173124034;5474.616776825624;5488.69812160331;5536.723163841802;4049.5624053460965;4108.815103320343;4247.959249983758;4277.272863613193;4281.507626622947;4268;4274.871753847374;4292.441982542281;4313.180495705821;4313.870583882473;4244.978775106136;4254.97872510637;4255.936160957588;4257.957420425787;4259;4009.919801603981;4210.115875666113;4217.283061879488;4231.830726770925;4275.273203555387;3674.5590529136407;3682.502862113607;3682.963170368316;3690.6678398943955;3718.9628103718887;5289.338832645919;5367.463253674601;5372.55548725329;5379.946200537984;5390.568754499631;4560.88597785058;4787.61699064074;4806.591439727627;4847.345608342864;4873.707577545359;5709;5717.514011309002;5722.198892155102;5722.37053924068;5743.5118014968775;4012.8996775080855;4050.25070361984;4052.716309858311;4053.4527838741687;4062.4921884764403;5972.552058595623;6011.549133814981;6049.576529642883;6053.182820319289;6057.666828324441;4055.2497787909333;4097.323941549671;4098.856540021145;4100.569440208795;4113.25961326964;4142.565030671796;4144.48193975753;4150.190712810973;4159.064210552662;4162.440099338945;4664.39362882823;4757.500462451393;4802.807887684523;4809.495003024632;4812.133815913099;5835.533157347487;5839;5849.619774714715;5866;5878.706064696748;1529.273595042346;1535.5316628428436;1538.7691846223156;1540.31456002078;1546.2268865567216;948.1087777489138;991.4943378876825;1006.1699098243831;1010.3786171504472;1032.442481060219;5968.120042186697;5971.850703732442;5983.850403739854;6006.399360064046;6023.337432882379;6269.310375858652;6300.27546832111;6300.432961033437;6308.495320374359;6309.242890853127;5814.76740930358;5961.791337303173;5985;5987.850303742354;6012.518998480111;3293.176705823544;3357.563516742857;3364.6130694970393;3373.3421982713135;3387.6612338765926;6387.680615969276;6505.674716264168;6548.0384367457955;6585;6619.834504137339;6461.483081353481;6504.577202481823;6522.706478208492;6526.575772574767;6534.281229064799;5962.701864906738;6283.360988384889;6554.115194448784;6572.901406478906;6574.80275591733;5963.582549221513;5989.850253743692;6009.677870868402;6027;6054.606450580698;6009.369016253405;6009.429104235091;6029.78895738647;6029.849253768515;6059.545534084873;5913.733881975408;6237.781677641261;6251.343608920998;6267.2479302484;6288.842778930563;4130.256553820341;4211.6209541140215;4221.451211342506;4222.535521092615;4248.10789734147;5848.736806843787;6026.318288361637;6052.455279024909;6092.786752463642;6101.871153836554;5794.594378393472;5856.824295271149;5857.47282744555;5893.528517718658;5902.173695682522;5818.4763371296785;5836.533077353886;5870;5874.828871501111;5881.73532191061;5664.830055098354;5673.375928647928;5740.971295143498;5772.729999400125;5809;5852.502537284378;5930.34766175729;5958;5960.731767070579;5960.850978725566;5555.972220139035;5778.104393818965;5793.710314484175;5809;5823.505002074871 08:42:17 INFO - PROCESS | 29346 | |5;yui.html;737.9999999999999;852.3053711225352;854.55990165065;859.7635650196195;863.3826813828111;13766;13927.164370137798;13927.930360348184;13947.302634868267;14413.711725765492;13546.39041243144;13576.18542887425;13669.453221871114;13674.384652690627;13743.244121573309;672.4250765595394;791.9722809701661;802.5064585280054;816.2735165702529;817.166490180016;809.348474478045;815.8898548695939;816.2531283875247;816.6937398475571;818.8280461103176;844.8479273730726;853.1425916953453;855.1277696749312;856.0241324889631;858.3390789092396;847.9406441549094;848.6478111583685;849.235687880909;849.5964416901953;853.4964371021065;620.3393386043849;622.9906551401733;623.8565130020121;624.1605041219552;625.2497003595703;14372.06581572205;14440.566782996528;14468.348924298432;14468.638284042878;14469.059511131743;14011.29943502831;14053.64865878351;14068.92965535176;14230.715385692229;14237.644058898506;11690.649280521598;11811.232269902515;11831.585894493652;11883.584074557435;11887.227330223508;3751.0622344413896;3783.3568293389912;3808.9809550952345;3816.732828701992;3824.5410550733814;50566;51322.48677513214;51416.485835141546;53068.73465632686;53610.19584706233;10863.293885897392;10879.673609791718;10903;10911.127109831194;11030.724231894106;19723;19773.307934222234;19785.30751423722;19871;19895.204191832454;7811.218878112257;7916.564588947548;7986.921765561691;8072.192780721881;8566.057733649419;4716.363290955677;4769.308450274691;4823.831165909247;4954.504549545017;5018.723970181675;3208.2781374191086;3271.7709760317025;3277.4264503711756;3288.539604455378;3305.4380755271663;597.8445604142867;626.9592476489014;630.3979699387074;631.1038325577691;635.3900255754435;715.9964200178965;724.9818754531179;725.698834983476;730.1566690472513;748.0611832150616;7862.646180921873;8153.633086511121;8278.213569710988;8378.874316885252;8556.486610803371;587.1515659871445;599.3616798110086;612.3784358875745;650.973961041553;692.6952141057918;4109.547949725527;4171.478565179353;4195.538490766014;4239.703220774578;4246.723962942398;68070.31929680739;68724;70092.2990770096;70491;70765.64617176984;58226.708866455396;58998;60377.39622603718;60515.092273615934;60680.69659651673;51363.743181283855;51539;52154.21768673473;54003.18995215075;54018.729906351;8554.358423118416;8633.223009929137;8752.824943501222;8766.517841518778;8838.734837954871;34751.304973899874;35571.82214088913;35858.8207058963;35975.820120899225;36175.63824361828;45550;49058;49341.2598811011;51335.48664513307;52191.21713174381;10912.926543956622;11137.665870023913;11139;11199.552017919192;11355.03482204022;12899.419526121535;13052.673683157996;13109.73780524365;13222.537211197561;13281.468741250243;11651.242669226473;12040.819387709367;12162.574309899112;12293.877061229274;12366.381680916098;11940;12149.514019439124;12174.39128043612;12477.376131193585;12480.750384992069;11485.045928228532;11572.24780389272;11631.6510504685;11649.650510484698;11880.584179553674;9426.858597121185;9491.335606507479;9609.663661771805;9651.276154288316;10206.336588121749;9123.726288211365;9761.170300524534;9778.217742580435;9787.314887957775;9807.607695692092 08:42:17 INFO - PROCESS | 29346 | __end_tp_report 08:42:17 INFO - PROCESS | 29346 | __start_cc_report 08:42:17 INFO - PROCESS | 29346 | _x_x_mozilla_cycle_collect,327 08:42:17 INFO - PROCESS | 29346 | __end_cc_report 08:42:17 INFO - PROCESS | 29346 | __startTimestamp1461858137293__endTimestamp 08:42:17 INFO - PROCESS | 29346 | 08:42:17 INFO - PROCESS | 29346 | ------- Summary: start ------- 08:42:17 INFO - PROCESS | 29346 | Number of tests: 6 08:42:17 INFO - PROCESS | 29346 | 08:42:17 INFO - PROCESS | 29346 | [#0] dojo.html Cycles:165 Average:5392.57 Median:5627.44 stddev:599.96 (10.7%) stddev-sans-first:575.54 08:42:17 INFO - PROCESS | 29346 | Values: 3154.6 3213.9 3228.3 3244.0 3251.9 5400.9 5406.9 5414.3 5419.8 5450.2 5385.9 5412.5 5478.0 5485.4 5489.9 4932.9 4989.2 5048.6 5081.2 5111.3 4897.8 5088.4 5102.5 5106.1 5114.0 4828.9 4832.5 4870.0 5009.5 5018.7 4892.2 4920.7 4922.1 4948.9 4955.5 4886.9 4905.2 4918.9 4936.8 4954.9 5240.1 5264.8 5305.8 5316.2 5361.4 5564.1 5582.7 5595.5 5595.9 5612.5 5630.0 5661.3 5675.3 5706.9 5733.7 5461.2 5463.6 5487.0 5520.9 5539.7 5906.5 5944.9 5948.3 5949.4 5963.9 5524.3 5671.2 5692.8 5714.9 5716.6 5767.5 5771.7 5772.7 5780.6 5819.8 5605.0 5711.6 5713.8 5740.3 5752.3 5688.8 5742.2 5797.4 5815.8 5834.9 4392.9 4417.4 4420.9 4425.3 4471.2 3934.6 3936.8 3940.6 3961.4 3977.8 5473.5 5491.2 5532.9 5556.6 5565.1 5819.7 5837.2 5850.2 5861.5 5909.3 5591.5 5613.1 5627.9 5645.0 5654.6 4878.3 4941.0 4993.4 4999.2 5033.7 6089.7 6129.5 6135.5 6135.8 6144.4 5849.9 5883.4 5886.4 5887.0 5887.3 5749.6 5925.2 5996.0 6037.6 6062.0 5645.8 5650.5 5652.3 5663.4 5681.8 5738.8 5754.8 5766.7 5768.0 5768.9 5406.8 5582.5 5634.9 5650.9 5686.4 5626.9 5759.1 5764.5 5778.3 5788.0 5627.4 5635.4 5648.9 5659.5 5666.9 5631.1 5651.6 5743.2 5766.3 5789.2 5641.4 5645.9 5648.8 5659.9 5660.3 08:42:17 INFO - PROCESS | 29346 | 08:42:17 INFO - PROCESS | 29346 | [#1] ext.html Cycles:180 Average:41124.14 Median:33890.33 stddev:71742.75 (211.7%) stddev-sans-first:71879.50 08:42:17 INFO - PROCESS | 29346 | Values: 605.9 654.9 656.1 662.2 664.6 32274.7 33781.3 33874.7 33906.0 33962.3 34650.7 35329.0 35354.6 35501.3 35518.0 8243.3 8428.6 8429.8 8431.2 8432.9 8296.4 8674.4 8680.9 8683.0 8702.6 8655.2 8657.3 8706.3 8722.3 8762.7 8609.6 8690.9 8721.5 8735.3 8758.4 8554.9 8653.5 8668.3 8669.5 8686.6 29905.4 35054.8 35543.8 35683.3 35783.6 3289.8 3398.6 3585.2 3985.1 4052.1 25963.4 26104.3 26422.5 26890.0 27009.2 3948.1 3949.9 3953.2 4032.5 4038.8 176776.0 177696.0 179217.0 179516.0 180067.1 31441.5 31616.7 31819.4 31929.5 32548.5 32374.0 32576.8 32642.5 32813.3 32816.3 14573.3 14678.4 14732.0 14822.5 14828.1 12203.1 12244.1 12247.6 12261.8 12337.3 7895.4 7962.0 7990.2 8068.0 8068.8 3167.0 3194.4 3217.1 3233.7 3241.4 1061.0 1068.0 1075.1 1077.4 1180.7 29553.9 29727.4 29899.7 29971.0 30086.4 1150.8 1161.1 1198.0 1223.0 1241.0 15107.6 15583.7 15850.5 16038.9 16322.8 356204.0 359951.0 360942.0 362427.0 365277.0 50534.5 52062.2 52096.0 52130.0 52130.5 1397.4 1399.4 1421.4 1425.7 1439.7 28729.7 28805.7 28887.0 30102.7 30167.7 44597.8 45175.5 45177.5 45178.8 45210.3 244805.0 246787.0 246808.0 247537.0 247777.0 25598.6 25905.2 25966.5 26412.6 26420.3 43067.4 43354.6 43593.0 43837.3 44568.6 36286.3 36491.8 36671.3 36851.3 37168.6 35599.1 36866.8 37149.6 37201.6 37504.2 31002.0 35299.0 35388.8 36051.8 38091.2 30684.0 30748.7 30960.1 31128.8 31387.7 24776.4 25087.4 25232.1 25760.6 26007.9 08:42:17 INFO - PROCESS | 29346 | 08:42:17 INFO - PROCESS | 29346 | [#2] jquery.html Cycles:180 Average:27242.98 Median:226952.88 stddev:81998.45 (36.1%) stddev-sans-first:82203.70 08:42:17 INFO - PROCESS | 29346 | Values: 400.1 402.5 407.4 408.7 414.6 13476.0 17177.0 17711.3 17855.3 17944.3 17661.8 17819.3 18186.1 18530.4 18752.2 5539.9 5573.1 5658.8 5706.9 5732.5 5629.1 5658.7 5673.0 5690.9 5694.1 5458.5 5651.4 5669.9 5688.3 5696.7 5592.3 5609.2 5629.6 5638.3 5644.9 4875.6 5055.7 5095.9 5107.8 5109.8 21049.8 21484.4 21494.8 21545.5 21608.0 2385.3 2514.1 2730.4 2758.2 2803.1 13688.5 14111.6 14288.1 14358.8 14359.4 1964.6 1980.3 2009.4 2018.9 2076.0 66243.7 66475.0 67199.0 67572.7 68586.3 9432.0 9794.0 9823.0 9922.0 10115.5 13947.4 14140.2 14305.3 14307.7 14644.7 7679.7 7958.8 7959.8 8027.8 8074.0 7610.3 7747.2 7815.0 7855.4 7900.5 4694.5 4761.9 4762.3 4799.9 4820.5 1790.3 1824.4 1902.2 1967.6 1978.3 445.3 936.2 1061.3 1068.7 1083.5 10480.5 11054.9 11056.2 11093.7 11142.4 441.1 443.3 452.8 460.9 469.0 6086.3 6115.1 6131.6 6156.9 6208.7 453453.0 454443.0 524167.0 529124.0 534315.0 75001.6 75932.6 75961.2 76325.2 76602.2 478.8 482.0 483.6 488.5 488.9 9893.2 10156.9 10232.4 10352.9 10683.1 34656.0 34724.4 35135.6 35921.6 36218.6 48743.3 49441.8 49585.8 49775.0 49844.3 7870.6 8071.2 8190.7 8245.6 8269.8 11212.4 12753.5 13075.7 13217.1 13273.9 10727.6 10762.4 10939.5 11216.8 11701.9 11245.9 11377.9 11429.1 11452.8 11461.4 11626.7 11626.9 11804.9 11805.4 11857.0 8464.6 8514.6 8637.0 8713.2 8986.4 8763.2 11313.8 11516.5 11575.9 11638.9 08:42:17 INFO - PROCESS | 29346 | 08:42:17 INFO - PROCESS | 29346 | [#3] mootools.html Cycles:180 Average:5687.77 Median:4766.77 stddev:3167.24 (66.4%) stddev-sans-first:3160.69 08:42:17 INFO - PROCESS | 29346 | Values: 1526.6 1535.8 1671.1 1767.4 1786.1 7764.5 8249.5 8361.8 8631.4 8677.3 8455.9 8463.8 8516.4 8529.5 8547.4 2295.6 2332.9 2335.6 2339.5 2345.6 2304.4 2309.9 2337.9 2346.5 2349.3 2242.9 2255.0 2257.4 2300.0 2308.7 2197.0 2200.9 2201.0 2208.6 2245.2 2222.5 2233.7 2239.5 2241.2 2242.7 8565.4 8625.5 8646.3 8670.5 8686.0 4953.0 5163.2 5167.6 5195.2 5210.6 3106.5 3238.8 3339.9 3344.7 3363.3 1073.3 1083.5 1087.3 1101.7 1140.5 11745.3 11792.6 11796.2 11844.9 11854.2 4521.4 4644.4 4657.2 4761.5 4772.0 10024.7 10048.8 10051.2 10085.6 10130.9 5227.4 5287.2 5294.1 5310.7 5315.3 4287.0 4704.7 4857.6 4865.9 4908.1 3907.5 3970.6 3975.5 4002.7 4168.9 1171.6 1195.8 1196.7 1203.9 1267.7 1010.4 1017.9 1019.6 1031.9 1040.8 5886.3 5999.6 6014.0 6039.9 6235.4 937.8 954.5 977.7 1019.8 1039.1 4007.8 4155.7 4187.7 4226.9 4231.2 9792.3 10225.9 10262.9 10342.7 10458.4 10410.6 10493.1 10543.8 10562.0 10610.8 7756.5 8005.8 8072.3 8083.5 8108.6 5815.4 5895.2 5904.5 6076.3 6082.8 9297.9 9875.2 9953.8 9957.7 10112.6 9908.5 9997.6 10021.6 10059.8 10232.6 6811.6 7632.4 7658.0 7698.0 7841.3 8233.1 8320.4 8321.3 8371.3 8389.1 7122.8 7353.9 7405.7 7442.4 7551.4 7503.5 7639.2 7686.6 7720.1 7738.5 7044.5 7047.6 7094.2 7110.3 7118.4 4995.1 5120.7 5158.6 5190.7 5276.5 5014.7 5023.2 5064.0 5070.5 5083.1 08:42:17 INFO - PROCESS | 29346 | 08:42:17 INFO - PROCESS | 29346 | [#4] prototype.html Cycles:180 Average:4942.93 Median:5691.19 stddev:1503.34 (26.4%) stddev-sans-first:1467.01 08:42:17 INFO - PROCESS | 29346 | Values: 322.5 329.6 331.2 335.6 338.4 5464.2 5519.6 5579.6 5602.9 5623.5 5438.4 5472.2 5474.6 5488.7 5536.7 4049.6 4108.8 4248.0 4277.3 4281.5 4268.0 4274.9 4292.4 4313.2 4313.9 4245.0 4255.0 4255.9 4258.0 4259.0 4009.9 4210.1 4217.3 4231.8 4275.3 3674.6 3682.5 3683.0 3690.7 3719.0 5289.3 5367.5 5372.6 5379.9 5390.6 4560.9 4787.6 4806.6 4847.3 4873.7 5709.0 5717.5 5722.2 5722.4 5743.5 4012.9 4050.3 4052.7 4053.5 4062.5 5972.6 6011.5 6049.6 6053.2 6057.7 4055.2 4097.3 4098.9 4100.6 4113.3 4142.6 4144.5 4150.2 4159.1 4162.4 4664.4 4757.5 4802.8 4809.5 4812.1 5835.5 5839.0 5849.6 5866.0 5878.7 1529.3 1535.5 1538.8 1540.3 1546.2 948.1 991.5 1006.2 1010.4 1032.4 5968.1 5971.9 5983.9 6006.4 6023.3 6269.3 6300.3 6300.4 6308.5 6309.2 5814.8 5961.8 5985.0 5987.9 6012.5 3293.2 3357.6 3364.6 3373.3 3387.7 6387.7 6505.7 6548.0 6585.0 6619.8 6461.5 6504.6 6522.7 6526.6 6534.3 5962.7 6283.4 6554.1 6572.9 6574.8 5963.6 5989.9 6009.7 6027.0 6054.6 6009.4 6009.4 6029.8 6029.8 6059.5 5913.7 6237.8 6251.3 6267.2 6288.8 4130.3 4211.6 4221.5 4222.5 4248.1 5848.7 6026.3 6052.5 6092.8 6101.9 5794.6 5856.8 5857.5 5893.5 5902.2 5818.5 5836.5 5870.0 5874.8 5881.7 5664.8 5673.4 5741.0 5772.7 5809.0 5852.5 5930.3 5958.0 5960.7 5960.9 5556.0 5778.1 5793.7 5809.0 5823.5 08:42:17 INFO - PROCESS | 29346 | 08:42:17 INFO - PROCESS | 29346 | [#5] yui.html Cycles:180 Average:15149.30 Median:51328.99 stddev:18307.48 (35.7%) stddev-sans-first:18326.85 08:42:17 INFO - PROCESS | 29346 | Values: 738.0 852.3 854.6 859.8 863.4 13766.0 13927.2 13927.9 13947.3 14413.7 13546.4 13576.2 13669.5 13674.4 13743.2 672.4 792.0 802.5 816.3 817.2 809.3 815.9 816.3 816.7 818.8 844.8 853.1 855.1 856.0 858.3 847.9 848.6 849.2 849.6 853.5 620.3 623.0 623.9 624.2 625.2 14372.1 14440.6 14468.3 14468.6 14469.1 14011.3 14053.6 14068.9 14230.7 14237.6 11690.6 11811.2 11831.6 11883.6 11887.2 3751.1 3783.4 3809.0 3816.7 3824.5 50566.0 51322.5 51416.5 53068.7 53610.2 10863.3 10879.7 10903.0 10911.1 11030.7 19723.0 19773.3 19785.3 19871.0 19895.2 7811.2 7916.6 7986.9 8072.2 8566.1 4716.4 4769.3 4823.8 4954.5 5018.7 3208.3 3271.8 3277.4 3288.5 3305.4 597.8 627.0 630.4 631.1 635.4 716.0 725.0 725.7 730.2 748.1 7862.6 8153.6 8278.2 8378.9 8556.5 587.2 599.4 612.4 651.0 692.7 4109.5 4171.5 4195.5 4239.7 4246.7 68070.3 68724.0 70092.3 70491.0 70765.6 58226.7 58998.0 60377.4 60515.1 60680.7 51363.7 51539.0 52154.2 54003.2 54018.7 8554.4 8633.2 8752.8 8766.5 8838.7 34751.3 35571.8 35858.8 35975.8 36175.6 45550.0 49058.0 49341.3 51335.5 52191.2 10912.9 11137.7 11139.0 11199.6 11355.0 12899.4 13052.7 13109.7 13222.5 13281.5 11651.2 12040.8 12162.6 12293.9 12366.4 11940.0 12149.5 12174.4 12477.4 12480.8 11485.0 11572.2 11631.7 11649.7 11880.6 9426.9 9491.3 9609.7 9651.3 10206.3 9123.7 9761.2 9778.2 9787.3 9807.6 08:42:17 INFO - PROCESS | 29346 | -------- Summary: end -------- 08:42:17 INFO - PROCESS | 29346 | 08:42:17 INFO - TEST-INFO | 29346: exit 0 08:42:18 INFO - TEST-OK | dromaeo_css | took 1110394ms 08:42:18 INFO - TEST-START | kraken 08:42:18 INFO - operating with platform_type : linux_ 08:42:18 INFO - Initialising browser for kraken test... 08:42:18 INFO - TEST-INFO | started process 29580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyA64F0/profile http://localhost:44062/getInfo.html) 08:42:21 INFO - PROCESS | 29580 | 08:42:21 INFO - PROCESS | 29580 | (process:29650): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:42:22 INFO - PROCESS | 29580 | __metrics Screen width/height:1600/1200 08:42:22 INFO - PROCESS | 29580 | colorDepth:24 08:42:22 INFO - PROCESS | 29580 | Browser inner width/height: 1024/697 08:42:22 INFO - PROCESS | 29580 | __metrics 08:42:23 ERROR - PROCESS | 29580 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:42:24 INFO - TEST-INFO | 29580: exit 0 08:42:24 INFO - Browser initialized. 08:42:24 INFO - Running cycle 1/1 for kraken test... 08:42:24 INFO - TEST-INFO | started process 29701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyA64F0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:25 INFO - PROCESS | 29701 | 08:42:25 INFO - PROCESS | 29701 | (process:29760): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:42:35 INFO - PROCESS | 29701 | RSS: Main: 164896768 08:42:35 INFO - PROCESS | 29701 | 08:42:38 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44062/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:39 INFO - PROCESS | 29701 | RSS: Main: 169984000 08:42:39 INFO - PROCESS | 29701 | 08:42:42 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44062/tests/kraken/driver.html?testName=audio-dft) 08:42:42 INFO - PROCESS | 29701 | RSS: Main: 173486080 08:42:42 INFO - PROCESS | 29701 | 08:42:45 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44062/tests/kraken/driver.html?testName=audio-fft) 08:42:46 INFO - PROCESS | 29701 | RSS: Main: 164556800 08:42:46 INFO - PROCESS | 29701 | 08:42:48 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44062/tests/kraken/driver.html?testName=audio-oscillator) 08:42:48 INFO - PROCESS | 29701 | RSS: Main: 164909056 08:42:48 INFO - PROCESS | 29701 | 08:42:51 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44062/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:51 INFO - PROCESS | 29701 | RSS: Main: 165388288 08:42:51 INFO - PROCESS | 29701 | 08:42:54 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44062/tests/kraken/driver.html?testName=imaging-darkroom) 08:42:55 INFO - PROCESS | 29701 | RSS: Main: 165924864 08:42:55 INFO - PROCESS | 29701 | 08:42:58 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44062/tests/kraken/driver.html?testName=imaging-desaturate) 08:42:59 INFO - PROCESS | 29701 | RSS: Main: 168034304 08:42:59 INFO - PROCESS | 29701 | 08:43:02 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44062/tests/kraken/driver.html?testName=json-parse-financial) 08:43:02 INFO - PROCESS | 29701 | RSS: Main: 168161280 08:43:02 INFO - PROCESS | 29701 | 08:43:04 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44062/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:05 INFO - PROCESS | 29701 | RSS: Main: 167804928 08:43:05 INFO - PROCESS | 29701 | 08:43:06 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44062/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:07 INFO - PROCESS | 29701 | RSS: Main: 167911424 08:43:07 INFO - PROCESS | 29701 | 08:43:09 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44062/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:10 INFO - PROCESS | 29701 | RSS: Main: 168337408 08:43:10 INFO - PROCESS | 29701 | 08:43:12 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:13 INFO - PROCESS | 29701 | RSS: Main: 168599552 08:43:13 INFO - PROCESS | 29701 | 08:43:16 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:17 INFO - PROCESS | 29701 | RSS: Main: 168361984 08:43:17 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | Cycle 1(1): loaded http://localhost:44062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44062/tests/kraken/driver.html?testName=ai-astar) 08:43:19 INFO - PROCESS | 29701 | RSS: Main: 169971712 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | __start_tp_report 08:43:19 INFO - PROCESS | 29701 | _x_x_mozilla_page_load 08:43:19 INFO - PROCESS | 29701 | _x_x_mozilla_page_load_details 08:43:19 INFO - PROCESS | 29701 | |i|pagename|runs| 08:43:19 INFO - PROCESS | 29701 | |0;ai-astar;114;107;115;111;112;125;113;112;111;112 08:43:19 INFO - PROCESS | 29701 | |1;audio-beat-detection;158;135;152;185;133;160;156;131;187;126 08:43:19 INFO - PROCESS | 29701 | |2;audio-dft;162;162;162;160;161;168;166;162;165;165 08:43:19 INFO - PROCESS | 29701 | |3;audio-fft;77;76;77;153;76;75;74;74;159;76 08:43:19 INFO - PROCESS | 29701 | |4;audio-oscillator;94;93;160;92;92;93;148;94;93;142 08:43:19 INFO - PROCESS | 29701 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;118;117 08:43:19 INFO - PROCESS | 29701 | |6;imaging-darkroom;146;146;146;146;148;147;146;151;147;146 08:43:19 INFO - PROCESS | 29701 | |7;imaging-desaturate;95;96;96;95;96;95;96;96;95;95 08:43:19 INFO - PROCESS | 29701 | |8;json-parse-financial;61;60;60;63;67;64;62;80;58;60 08:43:19 INFO - PROCESS | 29701 | |9;json-stringify-tinderbox;63;62;61;62;62;62;62;62;61;62 08:43:19 INFO - PROCESS | 29701 | |10;stanford-crypto-aes;79;80;80;78;79;79;80;79;87;80 08:43:19 INFO - PROCESS | 29701 | |11;stanford-crypto-ccm;130;146;129;130;127;136;139;128;199;127 08:43:19 INFO - PROCESS | 29701 | |12;stanford-crypto-pbkdf2;204;199;202;198;200;200;202;214;195;210 08:43:19 INFO - PROCESS | 29701 | |13;stanford-crypto-sha256-iterative;72;73;71;70;73;72;67;70;71;75 08:43:19 INFO - PROCESS | 29701 | __end_tp_report 08:43:19 INFO - PROCESS | 29701 | __start_cc_report 08:43:19 INFO - PROCESS | 29701 | _x_x_mozilla_cycle_collect,831 08:43:19 INFO - PROCESS | 29701 | __end_cc_report 08:43:19 INFO - PROCESS | 29701 | __startTimestamp1461858199396__endTimestamp 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | ------- Summary: start ------- 08:43:19 INFO - PROCESS | 29701 | Number of tests: 14 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#0] ai-astar Cycles:10 Average:113.20 Median:112.50 stddev:4.66 (4.1%) stddev-sans-first:4.94 08:43:19 INFO - PROCESS | 29701 | Values: 114.0 107.0 115.0 111.0 112.0 125.0 113.0 112.0 111.0 112.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:157.00 stddev:21.59 (13.8%) stddev-sans-first:22.80 08:43:19 INFO - PROCESS | 29701 | Values: 158.0 135.0 152.0 185.0 133.0 160.0 156.0 131.0 187.0 126.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:2.54 (1.6%) stddev-sans-first:2.65 08:43:19 INFO - PROCESS | 29701 | Values: 162.0 162.0 162.0 160.0 161.0 168.0 166.0 162.0 165.0 165.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#3] audio-fft Cycles:10 Average:91.70 Median:76.00 stddev:33.93 (44.7%) stddev-sans-first:35.57 08:43:19 INFO - PROCESS | 29701 | Values: 77.0 76.0 77.0 153.0 76.0 75.0 74.0 74.0 159.0 76.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:27.88 (30.0%) stddev-sans-first:28.95 08:43:19 INFO - PROCESS | 29701 | Values: 94.0 93.0 160.0 92.0 92.0 93.0 148.0 94.0 93.0 142.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:43:19 INFO - PROCESS | 29701 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.50 stddev:1.60 (1.1%) stddev-sans-first:1.66 08:43:19 INFO - PROCESS | 29701 | Values: 146.0 146.0 146.0 146.0 148.0 147.0 146.0 151.0 147.0 146.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:43:19 INFO - PROCESS | 29701 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:62.50 stddev:6.33 (10.1%) stddev-sans-first:6.65 08:43:19 INFO - PROCESS | 29701 | Values: 61.0 60.0 60.0 63.0 67.0 64.0 62.0 80.0 58.0 60.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 08:43:19 INFO - PROCESS | 29701 | Values: 63.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:2.51 (3.1%) stddev-sans-first:2.64 08:43:19 INFO - PROCESS | 29701 | Values: 79.0 80.0 80.0 78.0 79.0 79.0 80.0 79.0 87.0 80.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:133.00 stddev:21.93 (16.5%) stddev-sans-first:23.01 08:43:19 INFO - PROCESS | 29701 | Values: 130.0 146.0 129.0 130.0 127.0 136.0 139.0 128.0 199.0 127.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.40 Median:202.00 stddev:5.70 (2.8%) stddev-sans-first:6.02 08:43:19 INFO - PROCESS | 29701 | Values: 204.0 199.0 202.0 198.0 200.0 200.0 202.0 214.0 195.0 210.0 08:43:19 INFO - PROCESS | 29701 | 08:43:19 INFO - PROCESS | 29701 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:72.00 stddev:2.17 (3.0%) stddev-sans-first:2.29 08:43:19 INFO - PROCESS | 29701 | Values: 72.0 73.0 71.0 70.0 73.0 72.0 67.0 70.0 71.0 75.0 08:43:19 INFO - PROCESS | 29701 | -------- Summary: end -------- 08:43:19 INFO - PROCESS | 29701 | 08:43:20 INFO - TEST-INFO | 29701: exit 0 08:43:20 INFO - TEST-OK | kraken | took 62369ms 08:43:20 INFO - SUITE-END | took 1172s 08:43:20 INFO - Completed test suite (00:19:32) 08:43:20 INFO - javascript benchmark 08:43:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.589903312569, 3213.9196520086994, 3228.3059142284405, 3243.951340729891, 3251.934961300774, 5400.945990540094, 5406.918896216555, 5414.296141501609, 5419.837404877855, 5450.236966824647, 5385.919211211835, 5412.512873841353, 5478.0, 5485.424030476803, 5489.862753431166, 4932.926006109911, 4989.176785830334, 5048.596112311006, 5081.161608334621, 5111.335526381566, 4897.779599917994, 5088.440271570124, 5102.464241254671, 5106.08090543702, 5114.02833461643, 4828.903421931577, 4832.492588278215, 4870.0, 5009.549140577347, 5018.745313671582, 4892.198199814618, 4920.72935988524, 4922.138625740481, 4948.8617617948075, 4955.4548999610015, 4886.853394398138, 4905.239687848353, 4918.901621967577, 4936.7531623419045, 4954.851354459372, 5240.109181439165, 5264.7890985073645, 5305.761240744176, 5316.20256961455, 5361.383440904307, 5564.081926482126, 5582.665040097607, 5595.524380427628, 5595.916061259044, 5612.522935550483, 5630.0, 5661.348944871352, 5675.262215911946, 5706.857328566777, 5733.655980641175, 5461.18082287656, 5463.644863083927, 5487.039768040617, 5520.861978450571, 5539.695316757577, 5906.468417842329, 5944.940550594439, 5948.345681974979, 5949.3753155918, 5963.910541341883, 5524.281843360337, 5671.177679236487, 5692.800751973661, 5714.857128571819, 5716.5998380113, 5767.480926716532, 5771.653700777967, 5772.740226689725, 5780.624259423124, 5819.825405237765, 5605.047141985872, 5711.571632127607, 5713.800016999468, 5740.339860915965, 5752.252207213036, 5688.800891968761, 5742.224799652077, 5797.391273916178, 5815.82552523425, 5834.912476312858, 4392.934105988413, 4417.359482874966, 4420.9115817684105, 4425.269830477935, 4471.217536931024, 3934.626210509997, 3936.7637941723588, 3940.625640564142, 3961.445397644332, 3977.8209980550946, 5473.452654734574, 5491.176323551499, 5532.917006244909, 5556.555475561945, 5565.081761509306, 5819.6508209507565, 5837.211976383219, 5850.180974663551, 5861.501772349398, 5909.2908850938165, 5591.4688104629995, 5613.101903695389, 5627.8593035174445, 5645.0, 5654.604177707603, 4878.317035615017, 4940.975295123501, 4993.425756038102, 4999.200127979506, 5033.697978121324, 6089.725962331706, 6129.478994285447, 6135.5398345124295, 6135.785247516315, 6144.4469997699525, 5849.941500585025, 5883.382244864399, 5886.3525012247765, 5887.028640274478, 5887.322957859729, 5749.568782341425, 5925.229720136354, 5996.0, 6037.63774173551, 6062.0, 5645.802396916089, 5650.547956163415, 5652.293463317085, 5663.377028526941, 5681.829545113653, 5738.8278351649515, 5754.798582049776, 5766.711664416678, 5767.971160144172, 5768.94231057684, 5406.78372865081, 5582.49757521825, 5634.915476267941, 5650.886982260414, 5686.4029276926985, 5626.943730562642, 5759.107338362561, 5764.452377024176, 5778.306603207642, 5788.044972579477, 5627.43725627434, 5635.408282130317, 5648.85877853057, 5659.518940890071, 5666.943330566642, 5631.1271752878365, 5651.6043876928225, 5743.224664670383, 5766.3368712598585, 5789.1605717171615, 5641.37944826077, 5645.915311270416, 5648.830535083954, 5659.915101273402, 5660.349059858169], "value": 5353.180925147597, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.8606520500285, 654.8984907339362, 656.0520048529874, 662.1888186970959, 664.5746722097855, 32274.67725322746, 33781.324373512514, 33874.66125338746, 33906.0, 33962.32075358494, 34650.653493465055, 35329.0, 35354.64645353545, 35501.2899742005, 35518.0, 8243.299319557846, 8428.578571071452, 8429.831403371929, 8431.156884311582, 8432.873506897402, 8296.419250652456, 8674.392792504526, 8680.913190868105, 8683.0, 8702.564871756418, 8655.221030107288, 8657.26413254871, 8706.303495720358, 8722.258608018326, 8762.737117886474, 8609.56952152393, 8690.869636955482, 8721.520316382597, 8735.25750311218, 8758.386912916098, 8554.871676924851, 8653.480791152488, 8668.349873759493, 8669.479831210148, 8686.609102590335, 29905.401891962258, 35054.82472587646, 35543.82228088843, 35683.28633427317, 35783.64216357829, 3289.7697161198726, 3398.64314247003, 3585.2470981094, 3985.143194213229, 4052.0882801369753, 25963.350916227057, 26104.34739131518, 26422.471550569073, 26890.0, 27009.189724308304, 3948.1116748731592, 3949.9012524687114, 3953.2093581283857, 4032.495938007749, 4038.7778672173017, 176776.0, 177696.0, 179217.0, 179516.0, 180067.09966450214, 31441.528377074363, 31616.683833161373, 31819.40902954843, 31929.52105718416, 32548.511772323433, 32374.0, 32576.83711581427, 32642.51036234411, 32813.343733125206, 32816.34367312688, 14573.344199511048, 14678.41286348534, 14732.0, 14822.481213157487, 14828.110313381232, 12203.14577979533, 12244.142909996215, 12247.632571022883, 12261.816072758917, 12337.259764414164, 7895.368370530344, 7962.0, 7990.161033091558, 8068.031836179696, 8068.798280043045, 3166.9524957125664, 3194.3930653176285, 3217.0670505553126, 3233.6766323367474, 3241.4003409369343, 1061.0185578340004, 1067.9626213082504, 1075.0969185883896, 1077.3912739302425, 1180.6694125644833, 29553.85223073914, 29727.405451891274, 29899.701002989692, 29971.0, 30086.398272034876, 1150.7871043856746, 1161.1059484197121, 1197.9940100299443, 1222.9665932287203, 1240.976194639426, 15107.622309442351, 15583.688326233638, 15850.52448426549, 16038.919805400898, 16322.836771632132, 356204.0, 359951.0, 360942.0, 362427.0, 365277.0, 50534.49465505298, 52062.21906671403, 52095.95808083817, 52130.0, 52130.47869521332, 1397.406102406473, 1399.363289703203, 1421.3959067396315, 1425.6792221750231, 1439.6904665496968, 28729.712702872705, 28805.7119428803, 28887.0, 30102.69897300999, 30167.698323016488, 44597.77701111474, 45175.54824451714, 45177.54822451733, 45178.77410612926, 45210.321845173006, 244805.0, 246787.0, 246808.0, 247537.0, 247777.0, 25598.598209930187, 25905.222843314732, 25966.48067038611, 26412.603810943234, 26420.339491512867, 43067.35398968955, 43354.56645433505, 43593.0, 43837.34243986406, 44568.55431445644, 36286.27427451489, 36491.817540912125, 36671.266574668894, 36851.26297473982, 37168.628313716516, 35599.11002224965, 36866.78799272052, 37149.6285037157, 37201.627983719816, 37504.249915002096, 31002.0, 35299.0, 35388.82305588455, 36051.819740901126, 38091.2381752369, 30684.0, 30748.692513074584, 30960.0711978641, 31128.844355778077, 31387.686123138476, 24776.38059048466, 25087.372815679755, 25232.098308694734, 25760.61359079653, 26007.869960650074], "value": 16654.46199565985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.1177403824567, 402.4948689394809, 407.41739312782715, 408.7077739416317, 414.59991108580215, 13476.0, 17176.969381837083, 17711.29154833805, 17855.285788568457, 17944.282228710854, 17661.82338176618, 17819.287228510842, 18186.09069546524, 18530.44408667742, 18752.156152973115, 5539.861503462405, 5573.08044172712, 5658.773649054033, 5706.885862282773, 5732.5127364174095, 5629.071203251458, 5658.74535645897, 5673.0, 5690.9146362804595, 5694.117411801178, 5458.4814442627885, 5651.434856514336, 5669.914951275714, 5688.317401911776, 5696.746715722535, 5592.273004509408, 5609.186667933147, 5629.60592758507, 5638.323401191842, 5644.858878528029, 4875.609951203895, 5055.721935293557, 5095.949040509585, 5107.846764597068, 5109.770060347256, 21049.789502104937, 21484.355469335944, 21494.785052149437, 21545.46136346588, 21608.0, 2385.284414675608, 2514.120057979711, 2730.426610411816, 2758.213909035935, 2803.074985254861, 13688.452461901512, 14111.576652700436, 14288.142711437244, 14358.784618230631, 14359.353829077716, 1964.6168997045581, 1980.2673010985884, 2009.3971808457404, 2018.8788672679539, 2075.958480830375, 66243.66878165578, 66475.0, 67199.0, 67572.662136689, 68586.31413685849, 9432.0, 9794.0, 9822.950885245527, 9922.0, 10115.494225288707, 13947.372368243454, 14140.222287774272, 14305.28473576317, 14307.713845723027, 14644.707105858037, 7679.731209407644, 7958.761237162895, 7959.8408031839035, 8027.839443211103, 8074.0, 7610.315071643578, 7747.22527747232, 7815.0, 7855.371570274365, 7900.486468379537, 4694.530546945278, 4761.880952976134, 4762.285657151455, 4799.856004319806, 4820.493848145894, 1790.3017823049022, 1824.379710898301, 1902.248611798332, 1967.5868067705655, 1978.2680408248752, 445.3253321218357, 936.180841763457, 1061.3260579531898, 1068.6740544134113, 1083.4853444613746, 10480.47597620116, 11054.889451105546, 11056.226064175431, 11093.667189984313, 11142.387168705798, 441.0869500134754, 443.3416376680627, 452.7690877652421, 460.9492955774862, 468.960138388234, 6086.269647642312, 6115.113308570232, 6131.601445906002, 6156.8768624627255, 6208.689565521706, 453453.0, 454443.0, 524167.0, 529124.0, 534315.0, 75001.62499187469, 75932.62033689796, 75961.24038759542, 76325.23674763182, 76602.23397766062, 478.7797613098014, 481.9950403408862, 483.5599604360016, 488.46757034832206, 488.88511199868003, 9893.159081478156, 10156.898431015596, 10232.386056836614, 10352.896471035194, 10683.091937185427, 34656.0, 34724.3996516113, 35135.64864351324, 35921.64078359183, 36218.55125795044, 48743.29398471036, 49441.75299992575, 49585.75207123941, 49775.00449991052, 49844.25233621426, 7870.606469676608, 8071.23323284287, 8190.672373105247, 8245.587720614065, 8269.83460330802, 11212.383318917538, 12753.48986040548, 13075.738485230433, 13217.149599055947, 13273.867261327263, 10727.570897164025, 10762.3542587445, 10939.45302734876, 11216.83174752363, 11701.88298117008, 11245.93163649452, 11377.886221137682, 11429.142814289127, 11452.770944581229, 11461.369624670722, 11626.70933226676, 11626.88373116258, 11804.940975295069, 11805.396809620559, 11857.0, 8464.57677116154, 8514.574271286534, 8637.049924508174, 8713.215810577078, 8986.415882967585, 8763.211310982042, 11313.830292545454, 11516.53933842637, 11575.88424115748, 11638.904997100602], "value": 8181.809006816782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.6259766357243, 1535.8233803112641, 1671.0892563552864, 1767.3637490503409, 1786.1069465267367, 7764.495307805003, 8249.546274954875, 8361.83276334473, 8631.438956467826, 8677.305815534757, 8455.873161902577, 8463.788405289855, 8516.403851730382, 8529.488230706147, 8547.444416112949, 2295.5753185660665, 2332.918347857825, 2335.5562443135836, 2339.543788961153, 2345.6129738593113, 2304.4238940264936, 2309.9076036958586, 2337.8714170720605, 2346.4720437901506, 2349.2952114365708, 2242.9102835886547, 2255.0190667059883, 2257.3792207143, 2299.9770002300015, 2308.73449553301, 2196.967045494319, 2200.8679479231296, 2201.020545857094, 2208.646616541346, 2245.2253972379503, 2222.5443784024237, 2233.7207849018873, 2239.496113374494, 2241.1707668162885, 2242.742084660252, 8565.400421970464, 8625.482471051757, 8646.265067469272, 8670.523121228392, 8686.044535101133, 4952.975235123801, 5163.225516172567, 5167.586593072545, 5195.220716892459, 5210.609204309654, 3106.534019897011, 3238.77328586999, 3339.9499007514664, 3344.715699165574, 3363.2937083212555, 1073.3023534702427, 1083.5394957143183, 1087.3041253597703, 1101.735583459964, 1140.4810811081022, 11745.295282283005, 11792.646220613395, 11796.174267801258, 11844.881551184464, 11854.229475084092, 4521.367008618796, 4644.419447569054, 4657.1617108920045, 4761.500042495557, 4772.045590881838, 10024.699259022242, 10048.849267260997, 10051.24615653829, 10085.647002354883, 10130.949345253226, 5227.424983251839, 5287.23335116406, 5294.100002999499, 5310.654807437581, 5315.28243687105, 4286.992556749162, 4704.670673052922, 4857.611391088704, 4865.854024379274, 4908.092002979461, 3907.531096268466, 3970.5830887756947, 3975.5229372475487, 4002.659773919191, 4168.937465937953, 1171.5899435197782, 1195.7548702516137, 1196.7127889306503, 1203.9097067719956, 1267.7084270617624, 1010.3937637417491, 1017.9236557258236, 1019.5768755966191, 1031.9174466042848, 1040.7918416316768, 5886.293644762656, 5999.580029397987, 6014.0, 6039.909401358983, 6235.407636274546, 937.8358787212211, 954.4702690007113, 977.6627063663167, 1019.7756493571402, 1039.0700323210683, 4007.8396864125107, 4155.729877557949, 4187.748735075906, 4226.915461690749, 4231.217224813419, 9792.265580081523, 10225.897741022643, 10262.948685256675, 10342.689719308433, 10458.424786636808, 10410.583576657, 10493.108085812639, 10543.789124217627, 10562.0, 10610.787784244272, 7756.495827771289, 8005.839883202303, 8072.3138533224155, 8083.514989100673, 8108.554029528433, 5815.389384114607, 5895.233619629421, 5904.498117660047, 6076.331603523698, 6082.847928801815, 9297.907970706538, 9875.209983201183, 9953.800923981624, 9957.701268961653, 10112.595496180365, 9908.504574771088, 9997.550110245202, 10021.599136034478, 10059.849102263619, 10232.64185753495, 6811.557248778813, 7632.38940884739, 7658.0, 7697.961510192413, 7841.294283514511, 8233.135520770233, 8320.417570769989, 8321.251087402163, 8371.33029357662, 8389.11914248995, 7122.786316410516, 7353.926460735324, 7405.703771849066, 7442.441816863865, 7551.433642476946, 7503.5497870127965, 7639.197884222077, 7686.615669216405, 7720.112187098555, 7738.4969976951315, 7044.506884518035, 7047.612381319077, 7094.219635840157, 7110.25342339047, 7118.359347658528, 4995.075910956485, 5120.74396280177, 5158.613104017289, 5190.740462976761, 5276.472352764693, 5014.6991180529285, 5023.246513023076, 5063.974680126723, 5070.543651071422, 5083.059633967728], "value": 4585.239128536774, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.5001248065499, 329.6324598073149, 331.1737215646961, 335.6408642752256, 338.3824520250542, 5464.207689884965, 5519.558435325164, 5579.609427340088, 5602.887942241163, 5623.465770751783, 5438.401775804668, 5472.179173124034, 5474.616776825624, 5488.69812160331, 5536.723163841802, 4049.5624053460965, 4108.815103320343, 4247.959249983758, 4277.272863613193, 4281.507626622947, 4268.0, 4274.871753847374, 4292.441982542281, 4313.180495705821, 4313.870583882473, 4244.978775106136, 4254.97872510637, 4255.936160957588, 4257.957420425787, 4259.0, 4009.919801603981, 4210.115875666113, 4217.283061879488, 4231.830726770925, 4275.273203555387, 3674.5590529136407, 3682.502862113607, 3682.963170368316, 3690.6678398943955, 3718.9628103718887, 5289.338832645919, 5367.463253674601, 5372.55548725329, 5379.946200537984, 5390.568754499631, 4560.88597785058, 4787.61699064074, 4806.591439727627, 4847.345608342864, 4873.707577545359, 5709.0, 5717.514011309002, 5722.198892155102, 5722.37053924068, 5743.5118014968775, 4012.8996775080855, 4050.25070361984, 4052.716309858311, 4053.4527838741687, 4062.4921884764403, 5972.552058595623, 6011.549133814981, 6049.576529642883, 6053.182820319289, 6057.666828324441, 4055.2497787909333, 4097.323941549671, 4098.856540021145, 4100.569440208795, 4113.25961326964, 4142.565030671796, 4144.48193975753, 4150.190712810973, 4159.064210552662, 4162.440099338945, 4664.39362882823, 4757.500462451393, 4802.807887684523, 4809.495003024632, 4812.133815913099, 5835.533157347487, 5839.0, 5849.619774714715, 5866.0, 5878.706064696748, 1529.273595042346, 1535.5316628428436, 1538.7691846223156, 1540.31456002078, 1546.2268865567216, 948.1087777489138, 991.4943378876825, 1006.1699098243831, 1010.3786171504472, 1032.442481060219, 5968.120042186697, 5971.850703732442, 5983.850403739854, 6006.399360064046, 6023.337432882379, 6269.310375858652, 6300.27546832111, 6300.432961033437, 6308.495320374359, 6309.242890853127, 5814.76740930358, 5961.791337303173, 5985.0, 5987.850303742354, 6012.518998480111, 3293.176705823544, 3357.563516742857, 3364.6130694970393, 3373.3421982713135, 3387.6612338765926, 6387.680615969276, 6505.674716264168, 6548.0384367457955, 6585.0, 6619.834504137339, 6461.483081353481, 6504.577202481823, 6522.706478208492, 6526.575772574767, 6534.281229064799, 5962.701864906738, 6283.360988384889, 6554.115194448784, 6572.901406478906, 6574.80275591733, 5963.582549221513, 5989.850253743692, 6009.677870868402, 6027.0, 6054.606450580698, 6009.369016253405, 6009.429104235091, 6029.78895738647, 6029.849253768515, 6059.545534084873, 5913.733881975408, 6237.781677641261, 6251.343608920998, 6267.2479302484, 6288.842778930563, 4130.256553820341, 4211.6209541140215, 4221.451211342506, 4222.535521092615, 4248.10789734147, 5848.736806843787, 6026.318288361637, 6052.455279024909, 6092.786752463642, 6101.871153836554, 5794.594378393472, 5856.824295271149, 5857.47282744555, 5893.528517718658, 5902.173695682522, 5818.4763371296785, 5836.533077353886, 5870.0, 5874.828871501111, 5881.73532191061, 5664.830055098354, 5673.375928647928, 5740.971295143498, 5772.729999400125, 5809.0, 5852.502537284378, 5930.34766175729, 5958.0, 5960.731767070579, 5960.850978725566, 5555.972220139035, 5778.104393818965, 5793.710314484175, 5809.0, 5823.505002074871], "value": 4463.014467478747, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.9999999999999, 852.3053711225352, 854.55990165065, 859.7635650196195, 863.3826813828111, 13766.0, 13927.164370137798, 13927.930360348184, 13947.302634868267, 14413.711725765492, 13546.39041243144, 13576.18542887425, 13669.453221871114, 13674.384652690627, 13743.244121573309, 672.4250765595394, 791.9722809701661, 802.5064585280054, 816.2735165702529, 817.166490180016, 809.348474478045, 815.8898548695939, 816.2531283875247, 816.6937398475571, 818.8280461103176, 844.8479273730726, 853.1425916953453, 855.1277696749312, 856.0241324889631, 858.3390789092396, 847.9406441549094, 848.6478111583685, 849.235687880909, 849.5964416901953, 853.4964371021065, 620.3393386043849, 622.9906551401733, 623.8565130020121, 624.1605041219552, 625.2497003595703, 14372.06581572205, 14440.566782996528, 14468.348924298432, 14468.638284042878, 14469.059511131743, 14011.29943502831, 14053.64865878351, 14068.92965535176, 14230.715385692229, 14237.644058898506, 11690.649280521598, 11811.232269902515, 11831.585894493652, 11883.584074557435, 11887.227330223508, 3751.0622344413896, 3783.3568293389912, 3808.9809550952345, 3816.732828701992, 3824.5410550733814, 50566.0, 51322.48677513214, 51416.485835141546, 53068.73465632686, 53610.19584706233, 10863.293885897392, 10879.673609791718, 10903.0, 10911.127109831194, 11030.724231894106, 19723.0, 19773.307934222234, 19785.30751423722, 19871.0, 19895.204191832454, 7811.218878112257, 7916.564588947548, 7986.921765561691, 8072.192780721881, 8566.057733649419, 4716.363290955677, 4769.308450274691, 4823.831165909247, 4954.504549545017, 5018.723970181675, 3208.2781374191086, 3271.7709760317025, 3277.4264503711756, 3288.539604455378, 3305.4380755271663, 597.8445604142867, 626.9592476489014, 630.3979699387074, 631.1038325577691, 635.3900255754435, 715.9964200178965, 724.9818754531179, 725.698834983476, 730.1566690472513, 748.0611832150616, 7862.646180921873, 8153.633086511121, 8278.213569710988, 8378.874316885252, 8556.486610803371, 587.1515659871445, 599.3616798110086, 612.3784358875745, 650.973961041553, 692.6952141057918, 4109.547949725527, 4171.478565179353, 4195.538490766014, 4239.703220774578, 4246.723962942398, 68070.31929680739, 68724.0, 70092.2990770096, 70491.0, 70765.64617176984, 58226.708866455396, 58998.0, 60377.39622603718, 60515.092273615934, 60680.69659651673, 51363.743181283855, 51539.0, 52154.21768673473, 54003.18995215075, 54018.729906351, 8554.358423118416, 8633.223009929137, 8752.824943501222, 8766.517841518778, 8838.734837954871, 34751.304973899874, 35571.82214088913, 35858.8207058963, 35975.820120899225, 36175.63824361828, 45550.0, 49058.0, 49341.2598811011, 51335.48664513307, 52191.21713174381, 10912.926543956622, 11137.665870023913, 11139.0, 11199.552017919192, 11355.03482204022, 12899.419526121535, 13052.673683157996, 13109.73780524365, 13222.537211197561, 13281.468741250243, 11651.242669226473, 12040.819387709367, 12162.574309899112, 12293.877061229274, 12366.381680916098, 11940.0, 12149.514019439124, 12174.39128043612, 12477.376131193585, 12480.750384992069, 11485.045928228532, 11572.24780389272, 11631.6510504685, 11649.650510484698, 11880.584179553674, 9426.858597121185, 9491.335606507479, 9609.663661771805, 9651.276154288316, 10206.336588121749, 9123.726288211365, 9761.170300524534, 9778.217742580435, 9787.314887957775, 9807.607695692092], "value": 6674.7164888582465, "unit": "score"}], "name": "dromaeo_css", "value": 6808.868395119691, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 115.0, 111.0, 112.0, 125.0, 113.0, 112.0, 111.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 135.0, 152.0, 185.0, 133.0, 160.0, 156.0, 131.0, 187.0, 126.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 161.0, 168.0, 166.0, 162.0, 165.0, 165.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 153.0, 76.0, 75.0, 74.0, 74.0, 159.0, 76.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 160.0, 92.0, 92.0, 93.0, 148.0, 94.0, 93.0, 142.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 151.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 63.0, 67.0, 64.0, 62.0, 80.0, 58.0, 60.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 78.0, 79.0, 79.0, 80.0, 79.0, 87.0, 80.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 146.0, 129.0, 130.0, 127.0, 136.0, 139.0, 128.0, 199.0, 127.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 199.0, 202.0, 198.0, 200.0, 200.0, 202.0, 214.0, 195.0, 210.0], "value": 202.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 71.0, 70.0, 73.0, 72.0, 67.0, 70.0, 71.0, 75.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1608.7, "alertThreshold": 2.0}]} 08:43:20 INFO - Return code: 0 08:43:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:43:20 ERROR - # TBPL SUCCESS # 08:43:20 INFO - Running post-action listener: _resource_record_post_action 08:43:20 INFO - Running post-run listener: _resource_record_post_run 08:43:21 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535396352; Read time: 20; Write time: 792544 08:43:21 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244629504; Read time: 0; Write time: 471204 08:43:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290766848; Read time: 20; Write time: 321340 08:43:21 INFO - Running post-run listener: _upload_blobber_files 08:43:21 INFO - Blob upload gear active. 08:43:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:21 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 08:43:21 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'] 08:43:21 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 08:43:22 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:43:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:43:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:23 INFO - (blobuploader) - INFO - Done attempting. 08:43:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:43:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:43:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:23 INFO - (blobuploader) - INFO - Done attempting. 08:43:23 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:23 INFO - Return code: 0 08:43:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed47d6ca46499c3da013b962f9f634191b8c5238aa2c8a2d9699cab04eef9cdb00b928690ac596b453ba2fa7180d056704ec7e29ec611a502cd9f5f2bee8cb01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e55b3ccca2818cd383797ffc0296d07134519dc788d23d63eef70b60d68c50f0f0e40a5368fb901c4ad7fd77f5f6bd043289010bb0cf473322b9d0c220041d0"} 08:43:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:23 INFO - Contents: 08:43:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed47d6ca46499c3da013b962f9f634191b8c5238aa2c8a2d9699cab04eef9cdb00b928690ac596b453ba2fa7180d056704ec7e29ec611a502cd9f5f2bee8cb01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e55b3ccca2818cd383797ffc0296d07134519dc788d23d63eef70b60d68c50f0f0e40a5368fb901c4ad7fd77f5f6bd043289010bb0cf473322b9d0c220041d0"} 08:43:23 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:23 INFO - Copying logs to upload dir... 08:43:23 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.920073 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-28 08:43:23.664768) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 08:43:23.668151) ========= 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=aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734 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/ed47d6ca46499c3da013b962f9f634191b8c5238aa2c8a2d9699cab04eef9cdb00b928690ac596b453ba2fa7180d056704ec7e29ec611a502cd9f5f2bee8cb01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e55b3ccca2818cd383797ffc0296d07134519dc788d23d63eef70b60d68c50f0f0e40a5368fb901c4ad7fd77f5f6bd043289010bb0cf473322b9d0c220041d0"} build_url:https://queue.taskcluster.net/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/CxoanPM2SXui6wqIrzoLUg/artifacts/public/build/firefox-49.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/ed47d6ca46499c3da013b962f9f634191b8c5238aa2c8a2d9699cab04eef9cdb00b928690ac596b453ba2fa7180d056704ec7e29ec611a502cd9f5f2bee8cb01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e55b3ccca2818cd383797ffc0296d07134519dc788d23d63eef70b60d68c50f0f0e40a5368fb901c4ad7fd77f5f6bd043289010bb0cf473322b9d0c220041d0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 08:43:23.692701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:43:23.693042) ========= 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=aa52b8aba932b19cc50b5275000001de-1461848024.756865-1447745734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:43:23.776646) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 08:43:23.776972) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 08:43:23.777275) ========= ========= Total master_lag: 0.16 =========