builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1461866827.04 results: success (0) buildid: 20160428082225 builduid: 9bf6aa59b043478d86198874185c9a49 revision: 070a730a51d3bd2e923f81da9e10633b4d926143 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:07.045259) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:07.045686) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:07.045965) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:07.264294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:07.264609) ========= 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=33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 11:07:07-- 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% 46.0M=0s 2016-04-28 11:07:08 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:07.398197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:07.398522) ========= 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=33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:07.447141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 11:07:07.447456) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 070a730a51d3bd2e923f81da9e10633b4d926143 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 070a730a51d3bd2e923f81da9e10633b4d926143 --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=33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 11:07:08,171 truncating revision to first 12 chars 2016-04-28 11:07:08,171 Setting DEBUG logging. 2016-04-28 11:07:08,171 attempt 1/10 2016-04-28 11:07:08,171 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/070a730a51d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 11:07:09,323 unpacking tar archive at: mozilla-aurora-070a730a51d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.446536 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 11:07:08.907163) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:08.907513) ========= script_repo_revision: 070a730a51d3bd2e923f81da9e10633b4d926143 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:08.907963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:08.908239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 11:07:08.917559) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-28 11:07:08.917854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:07:09 INFO - MultiFileLogger online at 20160428 11:07:09 in /builds/slave/test 11:07:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:07:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:07:09 INFO - {'append_to_log': False, 11:07:09 INFO - 'base_work_dir': '/builds/slave/test', 11:07:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:07:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:07:09 INFO - 'branch': 'Mozilla-Aurora', 11:07:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:07:09 INFO - 'config_files': ('talos/linux_config.py',), 11:07:09 INFO - 'default_actions': ('clobber', 11:07:09 INFO - 'read-buildbot-config', 11:07:09 INFO - 'download-and-extract', 11:07:09 INFO - 'populate-webroot', 11:07:09 INFO - 'create-virtualenv', 11:07:09 INFO - 'install', 11:07:09 INFO - 'run-tests'), 11:07:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:07:09 INFO - 'download_minidump_stackwalk': True, 11:07:09 INFO - 'download_symbols': 'ondemand', 11:07:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:07:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:07:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:07:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:07:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:07:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:07:09 INFO - 'installer_path': 'installer.exe', 11:07:09 INFO - 'log_level': 'info', 11:07:09 INFO - 'log_name': 'talos', 11:07:09 INFO - 'log_to_console': True, 11:07:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:07:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:07:09 INFO - 'opt_config_files': (), 11:07:09 INFO - 'pip_index': False, 11:07:09 INFO - 'sps_profile': False, 11:07:09 INFO - 'sps_profile_interval': 0, 11:07:09 INFO - 'suite': 'dromaeojs-e10s', 11:07:09 INFO - 'system_bits': '32', 11:07:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:07:09 INFO - 'title': 'talos-linux64-ix-063', 11:07:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:07:09 INFO - 'use_talos_json': True, 11:07:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:07:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:07:09 INFO - 'work_dir': 'build'} 11:07:09 INFO - ##### 11:07:09 INFO - ##### Running clobber step. 11:07:09 INFO - ##### 11:07:09 INFO - Running pre-action listener: _resource_record_pre_action 11:07:09 INFO - Running main action method: clobber 11:07:09 INFO - rmtree: /builds/slave/test/build 11:07:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:07:10 INFO - Running post-action listener: _resource_record_post_action 11:07:10 INFO - ##### 11:07:10 INFO - ##### Running read-buildbot-config step. 11:07:10 INFO - ##### 11:07:10 INFO - Running pre-action listener: _resource_record_pre_action 11:07:10 INFO - Running main action method: read_buildbot_config 11:07:10 INFO - Using buildbot properties: 11:07:10 INFO - { 11:07:10 INFO - "project": "", 11:07:10 INFO - "product": "firefox", 11:07:10 INFO - "script_repo_revision": "production", 11:07:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:07:10 INFO - "repository": "", 11:07:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:07:10 INFO - "buildid": "20160428082225", 11:07:10 INFO - "stage_platform": "linux64-pgo", 11:07:10 INFO - "basedir": "/builds/slave/test", 11:07:10 INFO - "nightly_build": "True", 11:07:10 INFO - "buildnumber": 242, 11:07:10 INFO - "slavename": "talos-linux64-ix-063", 11:07:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:07:10 INFO - "platform": "ubuntu64_hw", 11:07:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:07:10 INFO - "branch": "mozilla-aurora", 11:07:10 INFO - "repo_path": "releases/mozilla-aurora", 11:07:10 INFO - "revision": "070a730a51d3bd2e923f81da9e10633b4d926143", 11:07:10 INFO - "pgo_build": "True", 11:07:10 INFO - "builduid": "9bf6aa59b043478d86198874185c9a49", 11:07:10 INFO - "slavebuilddir": "test" 11:07:10 INFO - } 11:07:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 11:07:10 INFO - Running post-action listener: _resource_record_post_action 11:07:10 INFO - ##### 11:07:10 INFO - ##### Running download-and-extract step. 11:07:10 INFO - ##### 11:07:10 INFO - Running pre-action listener: _resource_record_pre_action 11:07:10 INFO - Running main action method: download_and_extract 11:07:10 INFO - mkdir: /builds/slave/test/build/tests 11:07: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')]} 11:07:10 INFO - https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:07:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:07:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:07:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:07:10 INFO - Downloaded 1361 bytes. 11:07:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:07:10 INFO - Using the following test package requirements: 11:07:10 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 11:07:10 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:07:10 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:07:10 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:10 INFO - u'jsshell-linux-x86_64.zip'], 11:07:10 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:07:10 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 11:07:10 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:07:10 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:07:10 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:07:10 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:07:10 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:07: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')]} 11:07:10 INFO - https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:12 INFO - Downloaded 23821688 bytes. 11:07:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:07:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:07:13 INFO - Return code: 0 11:07:13 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:07: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')]} 11:07:13 INFO - https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:15 INFO - Downloaded 23821688 bytes. 11:07:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:07:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:07:16 INFO - Return code: 0 11:07: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')]} 11:07:16 INFO - https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:07:17 INFO - Downloaded 10840145 bytes. 11:07:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:07:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:07:17 INFO - Return code: 0 11:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:17 INFO - https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:07:19 INFO - Downloaded 62660962 bytes. 11:07:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:07:19 INFO - mkdir: /builds/slave/test/properties 11:07:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:07:19 INFO - Writing to file /builds/slave/test/properties/build_url 11:07:19 INFO - Contents: 11:07:19 INFO - build_url:https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:07:20 INFO - Running post-action listener: _resource_record_post_action 11:07:20 INFO - Running post-action listener: set_extra_try_arguments 11:07:20 INFO - ##### 11:07:20 INFO - ##### Running populate-webroot step. 11:07:20 INFO - ##### 11:07:20 INFO - Running pre-action listener: _resource_record_pre_action 11:07:20 INFO - Running main action method: populate_webroot 11:07:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:20 INFO - '--tppagecycles', 11:07:20 INFO - '7'], 11:07:20 INFO - 'tests': ['tsvgm']}}, 11:07:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:07:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:07:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:07:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:07:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:07:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:20 INFO - 'talos_options': ['--disable-e10s'], 11:07:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:20 INFO - 'talos_options': ['--disable-e10s'], 11:07:20 INFO - 'tests': ['damp', 'tps']}, 11:07:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:20 INFO - 'tests': ['damp', 'tps']}, 11:07:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:07:20 INFO - 'tests': ['dromaeo_dom']}, 11:07:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:07:20 INFO - 'tests': ['a11yr', 11:07:20 INFO - 'ts_paint', 11:07:20 INFO - 'tpaint', 11:07:20 INFO - 'sessionrestore', 11:07:20 INFO - 'sessionrestore_no_auto_restore', 11:07:20 INFO - 'tabpaint']}, 11:07:20 INFO - 'other-e10s': {'tests': ['a11yr', 11:07:20 INFO - 'ts_paint', 11:07:20 INFO - 'tpaint', 11:07:20 INFO - 'sessionrestore', 11:07:20 INFO - 'sessionrestore_no_auto_restore', 11:07:20 INFO - 'tabpaint']}, 11:07:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:07:20 INFO - 'ts_paint', 11:07:20 INFO - 'tpaint', 11:07:20 INFO - 'sessionrestore', 11:07:20 INFO - 'sessionrestore_no_auto_restore', 11:07:20 INFO - 'tabpaint']}, 11:07:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:07:20 INFO - 'ts_paint', 11:07:20 INFO - 'tpaint', 11:07:20 INFO - 'sessionrestore', 11:07:20 INFO - 'sessionrestore_no_auto_restore', 11:07:20 INFO - 'tabpaint']}, 11:07:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:07:20 INFO - 'tests': ['a11yr', 11:07:20 INFO - 'ts_paint', 11:07:20 INFO - 'tpaint', 11:07:20 INFO - 'sessionrestore', 11:07:20 INFO - 'sessionrestore_no_auto_restore', 11:07:20 INFO - 'tabpaint']}, 11:07:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:07:20 INFO - 'tests': ['a11yr', 11:07:20 INFO - 'ts_paint', 11:07:20 INFO - 'tpaint', 11:07:20 INFO - 'sessionrestore', 11:07:20 INFO - 'sessionrestore_no_auto_restore', 11:07:20 INFO - 'tabpaint']}, 11:07:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:07:20 INFO - 'tests': ['tsvgx', 11:07:20 INFO - 'tsvgr_opacity', 11:07:20 INFO - 'tart', 11:07:20 INFO - 'tscrollx', 11:07:20 INFO - 'cart']}, 11:07:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:07:20 INFO - 'tsvgr_opacity', 11:07:20 INFO - 'tart', 11:07:20 INFO - 'tscrollx', 11:07:20 INFO - 'cart']}, 11:07:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:20 INFO - 'talos_options': ['--disable-e10s'], 11:07:20 INFO - 'tests': ['tp5o']}, 11:07:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:20 INFO - 'tests': ['tp5o']}, 11:07:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:20 INFO - 'talos_options': ['--disable-e10s', 11:07:20 INFO - '--xperf_path', 11:07:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:20 INFO - 'tests': ['tp5n']}, 11:07:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:20 INFO - 'talos_options': ['--xperf_path', 11:07:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:20 INFO - 'tests': ['tp5n']}}, 11:07:20 INFO - 'talos.zip': {'path': '', 11:07:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:20 INFO - Running post-action listener: _resource_record_post_action 11:07:20 INFO - ##### 11:07:20 INFO - ##### Running create-virtualenv step. 11:07:20 INFO - ##### 11:07:20 INFO - Running pre-action listener: _resource_record_pre_action 11:07:20 INFO - Running main action method: create_virtualenv 11:07:20 INFO - Creating virtualenv /builds/slave/test/build/venv 11:07:20 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 11:07:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:07:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:20 INFO - Using real prefix '/usr' 11:07:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:07:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:22 INFO - Installing pip.................done. 11:07:22 INFO - Return code: 0 11:07:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:22 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 0x7f8b5486ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983410>, '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 0x1984310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19847a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', '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 11:07:22 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 11:07:22 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 11:07:23 INFO - Using env: {'DISPLAY': ':0', 11:07:23 INFO - 'HOME': '/home/cltbld', 11:07:23 INFO - 'LANG': 'en_US.UTF-8', 11:07:23 INFO - 'LANGUAGE': 'en_US:en', 11:07:23 INFO - 'LOGNAME': 'cltbld', 11:07:23 INFO - 'MAIL': '/var/mail/cltbld', 11:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:23 INFO - 'MOZ_NO_REMOTE': '1', 11:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:23 INFO - 'NO_EM_RESTART': '1', 11:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:23 INFO - 'PWD': '/builds/slave/test', 11:07:23 INFO - 'SHELL': '/bin/bash', 11:07:23 INFO - 'SHLVL': '1', 11:07:23 INFO - 'TERM': 'linux', 11:07:23 INFO - 'TMOUT': '86400', 11:07:23 INFO - 'USER': 'cltbld', 11:07:23 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', 11:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:23 INFO - '_': '/tools/buildbot/bin/python'} 11:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:23 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 11:07:23 INFO - Cleaning up... 11:07:23 INFO - Return code: 0 11:07:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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', '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 0x7f8b5486ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983410>, '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 0x1984310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19847a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', '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 11:07: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', 'psutil>=0.7.1'] in /builds/slave/test/build 11:07: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 psutil>=0.7.1 11:07:23 INFO - Using env: {'DISPLAY': ':0', 11:07:23 INFO - 'HOME': '/home/cltbld', 11:07:23 INFO - 'LANG': 'en_US.UTF-8', 11:07:23 INFO - 'LANGUAGE': 'en_US:en', 11:07:23 INFO - 'LOGNAME': 'cltbld', 11:07:23 INFO - 'MAIL': '/var/mail/cltbld', 11:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:23 INFO - 'MOZ_NO_REMOTE': '1', 11:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:23 INFO - 'NO_EM_RESTART': '1', 11:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:23 INFO - 'PWD': '/builds/slave/test', 11:07:23 INFO - 'SHELL': '/bin/bash', 11:07:23 INFO - 'SHLVL': '1', 11:07:23 INFO - 'TERM': 'linux', 11:07:23 INFO - 'TMOUT': '86400', 11:07:23 INFO - 'USER': 'cltbld', 11:07:23 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', 11:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:23 INFO - '_': '/tools/buildbot/bin/python'} 11:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:23 INFO - Downloading/unpacking psutil>=0.7.1 11:07:23 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 11:07:23 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 11:07:23 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 11:07:23 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 11:07:23 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 11:07:23 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 11:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:25 INFO - Installing collected packages: psutil 11:07:25 INFO - Running setup.py install for psutil 11:07:25 INFO - building 'psutil._psutil_linux' extension 11:07:25 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 11:07:25 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 11:07:25 INFO - building 'psutil._psutil_posix' extension 11:07:25 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 11:07:25 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 11:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:25 INFO - Successfully installed psutil 11:07:25 INFO - Cleaning up... 11:07:25 INFO - Return code: 0 11:07:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:25 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 0x7f8b5486ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983410>, '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 0x1984310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19847a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', '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 11:07:25 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 11:07:25 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 11:07:25 INFO - Using env: {'DISPLAY': ':0', 11:07:25 INFO - 'HOME': '/home/cltbld', 11:07:25 INFO - 'LANG': 'en_US.UTF-8', 11:07:25 INFO - 'LANGUAGE': 'en_US:en', 11:07:25 INFO - 'LOGNAME': 'cltbld', 11:07:25 INFO - 'MAIL': '/var/mail/cltbld', 11:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:25 INFO - 'MOZ_NO_REMOTE': '1', 11:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:25 INFO - 'NO_EM_RESTART': '1', 11:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:25 INFO - 'PWD': '/builds/slave/test', 11:07:25 INFO - 'SHELL': '/bin/bash', 11:07:25 INFO - 'SHLVL': '1', 11:07:25 INFO - 'TERM': 'linux', 11:07:25 INFO - 'TMOUT': '86400', 11:07:25 INFO - 'USER': 'cltbld', 11:07:25 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', 11:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:25 INFO - '_': '/tools/buildbot/bin/python'} 11:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:07:28 INFO - Installing collected packages: mozsystemmonitor 11:07:28 INFO - Running setup.py install for mozsystemmonitor 11:07:28 INFO - Successfully installed mozsystemmonitor 11:07:28 INFO - Cleaning up... 11:07:28 INFO - Return code: 0 11:07:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:07:28 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')]} 11:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:28 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')]} 11:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:28 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 0x7f8b5486ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983410>, '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 0x1984310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19847a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', '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 11:07:28 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 11:07:28 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 11:07:28 INFO - Using env: {'DISPLAY': ':0', 11:07:28 INFO - 'HOME': '/home/cltbld', 11:07:28 INFO - 'LANG': 'en_US.UTF-8', 11:07:28 INFO - 'LANGUAGE': 'en_US:en', 11:07:28 INFO - 'LOGNAME': 'cltbld', 11:07:28 INFO - 'MAIL': '/var/mail/cltbld', 11:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:28 INFO - 'MOZ_NO_REMOTE': '1', 11:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:28 INFO - 'NO_EM_RESTART': '1', 11:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:28 INFO - 'PWD': '/builds/slave/test', 11:07:28 INFO - 'SHELL': '/bin/bash', 11:07:28 INFO - 'SHLVL': '1', 11:07:28 INFO - 'TERM': 'linux', 11:07:28 INFO - 'TMOUT': '86400', 11:07:28 INFO - 'USER': 'cltbld', 11:07:28 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', 11:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:28 INFO - '_': '/tools/buildbot/bin/python'} 11:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:28 INFO - Downloading/unpacking blobuploader==1.2.4 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:30 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:07:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:30 INFO - Downloading docopt-0.6.1.tar.gz 11:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:31 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:31 INFO - Running setup.py install for blobuploader 11:07:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:07:31 INFO - Running setup.py install for requests 11:07:31 INFO - Running setup.py install for docopt 11:07:31 INFO - Successfully installed blobuploader requests docopt 11:07:31 INFO - Cleaning up... 11:07:31 INFO - Return code: 0 11:07:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:31 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 0x7f8b5486ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983410>, '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 0x1984310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19847a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', '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 11:07:31 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 11:07:31 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 11:07:31 INFO - Using env: {'DISPLAY': ':0', 11:07:31 INFO - 'HOME': '/home/cltbld', 11:07:31 INFO - 'LANG': 'en_US.UTF-8', 11:07:31 INFO - 'LANGUAGE': 'en_US:en', 11:07:31 INFO - 'LOGNAME': 'cltbld', 11:07:31 INFO - 'MAIL': '/var/mail/cltbld', 11:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:31 INFO - 'MOZ_NO_REMOTE': '1', 11:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:31 INFO - 'NO_EM_RESTART': '1', 11:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:31 INFO - 'PWD': '/builds/slave/test', 11:07:31 INFO - 'SHELL': '/bin/bash', 11:07:31 INFO - 'SHLVL': '1', 11:07:31 INFO - 'TERM': 'linux', 11:07:31 INFO - 'TMOUT': '86400', 11:07:31 INFO - 'USER': 'cltbld', 11:07:31 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', 11:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:31 INFO - '_': '/tools/buildbot/bin/python'} 11:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:31 INFO - Running setup.py (path:/tmp/pip-11JvlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:31 INFO - Running setup.py (path:/tmp/pip-LpJciL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:32 INFO - Running setup.py (path:/tmp/pip-xu2QFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:32 INFO - Running setup.py (path:/tmp/pip-WJh_eE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:32 INFO - Running setup.py (path:/tmp/pip-a5lkGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:32 INFO - Running setup.py (path:/tmp/pip-D70rWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:32 INFO - Running setup.py (path:/tmp/pip-SWTjXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:32 INFO - Running setup.py (path:/tmp/pip-mNw0Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:32 INFO - Running setup.py (path:/tmp/pip-iMFfBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:32 INFO - Running setup.py (path:/tmp/pip-So4Mn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:32 INFO - Running setup.py (path:/tmp/pip-QiM8UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:32 INFO - Running setup.py (path:/tmp/pip-jB4vfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:32 INFO - Running setup.py (path:/tmp/pip-CAw7jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:32 INFO - Running setup.py (path:/tmp/pip-FcjUd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:32 INFO - Running setup.py (path:/tmp/pip-EO3Chb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:32 INFO - Running setup.py (path:/tmp/pip-aZMBPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:33 INFO - Running setup.py (path:/tmp/pip-dGTU0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:33 INFO - Running setup.py install for manifestparser 11:07:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Running setup.py install for mozcrash 11:07:33 INFO - Running setup.py install for mozdebug 11:07:33 INFO - Running setup.py install for mozdevice 11:07:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Running setup.py install for mozfile 11:07:33 INFO - Running setup.py install for mozhttpd 11:07:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Running setup.py install for mozinfo 11:07:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Running setup.py install for mozInstall 11:07:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Running setup.py install for mozleak 11:07:33 INFO - Running setup.py install for mozlog 11:07:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Running setup.py install for moznetwork 11:07:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Running setup.py install for mozprocess 11:07:34 INFO - Running setup.py install for mozprofile 11:07:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Running setup.py install for mozrunner 11:07:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Running setup.py install for mozscreenshot 11:07:34 INFO - Running setup.py install for moztest 11:07:34 INFO - Running setup.py install for mozversion 11:07:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:34 INFO - Cleaning up... 11:07:34 INFO - Return code: 0 11:07:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:34 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 0x7f8b5486ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983410>, '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 0x1984310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19847a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', '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 11:07:34 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 11:07:34 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 11:07:34 INFO - Using env: {'DISPLAY': ':0', 11:07:34 INFO - 'HOME': '/home/cltbld', 11:07:34 INFO - 'LANG': 'en_US.UTF-8', 11:07:34 INFO - 'LANGUAGE': 'en_US:en', 11:07:34 INFO - 'LOGNAME': 'cltbld', 11:07:34 INFO - 'MAIL': '/var/mail/cltbld', 11:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:34 INFO - 'MOZ_NO_REMOTE': '1', 11:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:34 INFO - 'NO_EM_RESTART': '1', 11:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:34 INFO - 'PWD': '/builds/slave/test', 11:07:34 INFO - 'SHELL': '/bin/bash', 11:07:34 INFO - 'SHLVL': '1', 11:07:34 INFO - 'TERM': 'linux', 11:07:34 INFO - 'TMOUT': '86400', 11:07:34 INFO - 'USER': 'cltbld', 11:07:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', 11:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:34 INFO - '_': '/tools/buildbot/bin/python'} 11:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:35 INFO - Running setup.py (path:/tmp/pip-4ooQI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:35 INFO - Running setup.py (path:/tmp/pip-MquK1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:35 INFO - Running setup.py (path:/tmp/pip-tgoUHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:35 INFO - Running setup.py (path:/tmp/pip-4febZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:35 INFO - Running setup.py (path:/tmp/pip-be2Fwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:35 INFO - Running setup.py (path:/tmp/pip-fJMQzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:35 INFO - Running setup.py (path:/tmp/pip-pKPFFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:35 INFO - Running setup.py (path:/tmp/pip-79uF27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:35 INFO - Running setup.py (path:/tmp/pip-6hzgsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:35 INFO - Running setup.py (path:/tmp/pip-7aZtPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:35 INFO - Running setup.py (path:/tmp/pip-ZSqIZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:35 INFO - Running setup.py (path:/tmp/pip-0TLDa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:35 INFO - Running setup.py (path:/tmp/pip-22CkXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:36 INFO - Running setup.py (path:/tmp/pip-pUaFRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:36 INFO - Running setup.py (path:/tmp/pip-05pUhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:36 INFO - Running setup.py (path:/tmp/pip-w0YVie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:36 INFO - Running setup.py (path:/tmp/pip-2V2Ddd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:36 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)) 11:07:36 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)) 11:07:36 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)) 11:07:36 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)) 11:07:36 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)) 11:07:36 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)) 11:07:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:38 INFO - Downloading blessings-1.6.tar.gz 11:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:38 INFO - Installing collected packages: blessings 11:07:38 INFO - Running setup.py install for blessings 11:07:38 INFO - Successfully installed blessings 11:07:38 INFO - Cleaning up... 11:07:38 INFO - Return code: 0 11:07:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:38 INFO - Reading from file tmpfile_stdout 11:07:38 INFO - Current package versions: 11:07:38 INFO - argparse == 1.2.1 11:07:38 INFO - blessings == 1.6 11:07:38 INFO - blobuploader == 1.2.4 11:07:38 INFO - docopt == 0.6.1 11:07:38 INFO - manifestparser == 1.1 11:07:38 INFO - mozInstall == 1.12 11:07:38 INFO - mozcrash == 0.17 11:07:38 INFO - mozdebug == 0.1 11:07:38 INFO - mozdevice == 0.48 11:07:38 INFO - mozfile == 1.2 11:07:38 INFO - mozhttpd == 0.7 11:07:38 INFO - mozinfo == 0.9 11:07:38 INFO - mozleak == 0.1 11:07:38 INFO - mozlog == 3.1 11:07:38 INFO - moznetwork == 0.27 11:07:38 INFO - mozprocess == 0.22 11:07:38 INFO - mozprofile == 0.28 11:07:38 INFO - mozrunner == 6.11 11:07:38 INFO - mozscreenshot == 0.1 11:07:38 INFO - mozsystemmonitor == 0.0 11:07:38 INFO - moztest == 0.7 11:07:38 INFO - mozversion == 1.4 11:07:38 INFO - psutil == 3.1.1 11:07:38 INFO - requests == 1.2.3 11:07:38 INFO - wsgiref == 0.1.2 11:07:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:38 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 0x7f8b5486ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983410>, '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 0x1984310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19847a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', '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 11:07:38 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 11:07:38 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 11:07:38 INFO - Using env: {'DISPLAY': ':0', 11:07:38 INFO - 'HOME': '/home/cltbld', 11:07:38 INFO - 'LANG': 'en_US.UTF-8', 11:07:38 INFO - 'LANGUAGE': 'en_US:en', 11:07:38 INFO - 'LOGNAME': 'cltbld', 11:07:38 INFO - 'MAIL': '/var/mail/cltbld', 11:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:38 INFO - 'MOZ_NO_REMOTE': '1', 11:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:38 INFO - 'NO_EM_RESTART': '1', 11:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:38 INFO - 'PWD': '/builds/slave/test', 11:07:38 INFO - 'SHELL': '/bin/bash', 11:07:38 INFO - 'SHLVL': '1', 11:07:38 INFO - 'TERM': 'linux', 11:07:38 INFO - 'TMOUT': '86400', 11:07:38 INFO - 'USER': 'cltbld', 11:07:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', 11:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:38 INFO - '_': '/tools/buildbot/bin/python'} 11:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:38 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)) 11:07:38 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)) 11:07:38 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)) 11:07:38 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)) 11:07:38 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)) 11:07:38 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)) 11:07:38 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)) 11:07:38 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)) 11:07:38 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)) 11:07:38 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)) 11:07:38 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)) 11:07:38 INFO - Cleaning up... 11:07:38 INFO - Return code: 0 11:07:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5486ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983410>, '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 0x1984310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19847a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', '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 11:07:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:07:38 INFO - Using env: {'DISPLAY': ':0', 11:07:38 INFO - 'HOME': '/home/cltbld', 11:07:38 INFO - 'LANG': 'en_US.UTF-8', 11:07:38 INFO - 'LANGUAGE': 'en_US:en', 11:07:38 INFO - 'LOGNAME': 'cltbld', 11:07:38 INFO - 'MAIL': '/var/mail/cltbld', 11:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:38 INFO - 'MOZ_NO_REMOTE': '1', 11:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:38 INFO - 'NO_EM_RESTART': '1', 11:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:38 INFO - 'PWD': '/builds/slave/test', 11:07:38 INFO - 'SHELL': '/bin/bash', 11:07:38 INFO - 'SHLVL': '1', 11:07:38 INFO - 'TERM': 'linux', 11:07:38 INFO - 'TMOUT': '86400', 11:07:38 INFO - 'USER': 'cltbld', 11:07:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', 11:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:38 INFO - '_': '/tools/buildbot/bin/python'} 11:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:39 INFO - Downloading/unpacking jsonschema 11:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:40 INFO - Downloading/unpacking functools32 (from jsonschema) 11:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:41 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:41 INFO - warning: no files found matching '*.txt' 11:07:41 INFO - no previously-included directories found matching 'build' 11:07:41 INFO - no previously-included directories found matching 'dist' 11:07:41 INFO - no previously-included directories found matching '.git*' 11:07:41 INFO - Installing collected packages: jsonschema, functools32 11:07:41 INFO - Running setup.py install for functools32 11:07:41 INFO - warning: no files found matching '*.txt' 11:07:41 INFO - no previously-included directories found matching 'build' 11:07:41 INFO - no previously-included directories found matching 'dist' 11:07:41 INFO - no previously-included directories found matching '.git*' 11:07:41 INFO - Successfully installed jsonschema functools32 11:07:41 INFO - Cleaning up... 11:07:41 INFO - Return code: 0 11:07:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:41 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 0x7f8b5486ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983410>, '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 0x1984310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19847a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', '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 11:07:41 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 11:07:41 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 11:07:41 INFO - Using env: {'DISPLAY': ':0', 11:07:41 INFO - 'HOME': '/home/cltbld', 11:07:41 INFO - 'LANG': 'en_US.UTF-8', 11:07:41 INFO - 'LANGUAGE': 'en_US:en', 11:07:41 INFO - 'LOGNAME': 'cltbld', 11:07:41 INFO - 'MAIL': '/var/mail/cltbld', 11:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:41 INFO - 'MOZ_NO_REMOTE': '1', 11:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:41 INFO - 'NO_EM_RESTART': '1', 11:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:41 INFO - 'PWD': '/builds/slave/test', 11:07:41 INFO - 'SHELL': '/bin/bash', 11:07:41 INFO - 'SHLVL': '1', 11:07:41 INFO - 'TERM': 'linux', 11:07:41 INFO - 'TMOUT': '86400', 11:07:41 INFO - 'USER': 'cltbld', 11:07:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', 11:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:41 INFO - '_': '/tools/buildbot/bin/python'} 11:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:41 INFO - Downloading/unpacking flake8 11:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:07:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:07:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:07:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:44 INFO - no previously-included directories found matching 'docs/_build' 11:07:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:07:44 INFO - Running setup.py install for pep8 11:07:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:44 INFO - no previously-included directories found matching 'docs/_build' 11:07:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:07:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:07:44 INFO - Cleaning up... 11:07:44 INFO - Return code: 0 11:07:44 INFO - Running post-action listener: _resource_record_post_action 11:07:44 INFO - Running post-action listener: _start_resource_monitoring 11:07:44 INFO - Starting resource monitoring. 11:07:44 INFO - ##### 11:07:44 INFO - ##### Running install step. 11:07:44 INFO - ##### 11:07:44 INFO - Running pre-action listener: _resource_record_pre_action 11:07:44 INFO - Running main action method: install 11:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:44 INFO - Reading from file tmpfile_stdout 11:07:44 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:44 INFO - Reading from file tmpfile_stdout 11:07:44 INFO - Output received: 11:07:44 INFO - Usage: mozinstall [options] installer 11:07:44 INFO - Options: 11:07:44 INFO - -h, --help show this help message and exit 11:07:44 INFO - -d DEST, --destination=DEST 11:07:44 INFO - Directory to install application into. [default: 11:07:44 INFO - "/builds/slave/test"] 11:07:44 INFO - --app=APP Application being installed. [default: firefox] 11:07:44 INFO - mkdir: /builds/slave/test/build/application 11:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:08:00 INFO - Reading from file tmpfile_stdout 11:08:00 INFO - Output received: 11:08:00 INFO - /builds/slave/test/build/application/firefox/firefox 11:08:00 INFO - Running post-action listener: _resource_record_post_action 11:08:00 INFO - ##### 11:08:00 INFO - ##### Running run-tests step. 11:08:00 INFO - ##### 11:08:00 INFO - Running pre-action listener: _resource_record_pre_action 11:08:00 INFO - Running main action method: run_tests 11:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:08:00 INFO - Python 2.7.3 11:08:00 INFO - Return code: 0 11:08:00 INFO - grabbing minidump binary from tooltool 11:08:00 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')]} 11:08:00 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 0x1983410>, '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 0x1984310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19847a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:08:00 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 11:08:00 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 11:08:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:08:00 INFO - Return code: 0 11:08:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:08:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:08:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:08:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:08:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:08:01 INFO - Return code: 0 11:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 11:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 11:08:01 INFO - Using env: {'DISPLAY': ':0', 11:08:01 INFO - 'HOME': '/home/cltbld', 11:08:01 INFO - 'LANG': 'en_US.UTF-8', 11:08:01 INFO - 'LANGUAGE': 'en_US:en', 11:08:01 INFO - 'LOGNAME': 'cltbld', 11:08:01 INFO - 'MAIL': '/var/mail/cltbld', 11:08:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:08:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:01 INFO - 'MOZ_NO_REMOTE': '1', 11:08:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:01 INFO - 'NO_EM_RESTART': '1', 11:08:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:01 INFO - 'PWD': '/builds/slave/test', 11:08:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:08:01 INFO - 'SHELL': '/bin/bash', 11:08:01 INFO - 'SHLVL': '1', 11:08:01 INFO - 'TERM': 'linux', 11:08:01 INFO - 'TMOUT': '86400', 11:08:01 INFO - 'USER': 'cltbld', 11:08:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080', 11:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:01 INFO - '_': '/tools/buildbot/bin/python'} 11:08:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 11:08:01 INFO - mozversion application_buildid: 20160428082225 11:08:01 INFO - mozversion application_changeset: 070a730a51d3bd2e923f81da9e10633b4d926143 11:08:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:08:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:08:01 INFO - mozversion application_name: Firefox 11:08:01 INFO - mozversion application_remotingname: firefox-dev 11:08:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:08:01 INFO - mozversion application_vendor: Mozilla 11:08:01 INFO - mozversion application_version: 48.0a2 11:08:01 INFO - mozversion platform_buildid: 20160428082225 11:08:01 INFO - mozversion platform_changeset: 070a730a51d3bd2e923f81da9e10633b4d926143 11:08:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:08:01 INFO - mozversion platform_version: 48.0a2 11:08:01 INFO - using testdate: 1461866881 11:08:01 INFO - actual date: 1461866881 11:08:01 INFO - starting webserver on 'localhost:44791' 11:08:01 INFO - SUITE-START | Running 2 tests 11:08:01 INFO - TEST-START | dromaeo_css 11:08:01 INFO - operating with platform_type : linux_ 11:08:01 INFO - Initialising browser for dromaeo_css test... 11:08:01 INFO - TEST-INFO | started process 11246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpybQryO/profile http://localhost:44791/getInfo.html) 11:08:05 INFO - PROCESS | 11246 | 11:08:05 INFO - PROCESS | 11246 | (process:11324): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:08:06 INFO - PROCESS | 11246 | __metrics Screen width/height:1600/1200 11:08:06 INFO - PROCESS | 11246 | colorDepth:24 11:08:06 INFO - PROCESS | 11246 | Browser inner width/height: 1024/697 11:08:06 INFO - PROCESS | 11246 | __metrics 11:08:07 ERROR - PROCESS | 11246 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:08:08 INFO - TEST-INFO | 11246: exit 0 11:08:08 INFO - Browser initialized. 11:08:08 INFO - Running cycle 1/1 for dromaeo_css test... 11:08:08 INFO - TEST-INFO | started process 11375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpybQryO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:09 INFO - PROCESS | 11375 | 11:08:09 INFO - PROCESS | 11375 | (process:11444): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:08:19 INFO - PROCESS | 11375 | RSS: Main: 152711168 11:08:19 INFO - PROCESS | 11375 | 11:09:09 INFO - PROCESS | 11375 | 1461866949541 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] 11:11:17 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:44791/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44791/tests/dromaeo/cssquery-ext.html) 11:11:18 INFO - PROCESS | 11375 | RSS: Main: 155828224 11:11:18 INFO - PROCESS | 11375 | 11:14:20 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:44791/tests/dromaeo/cssquery-ext.html (next: http://localhost:44791/tests/dromaeo/cssquery-jquery.html) 11:14:20 INFO - PROCESS | 11375 | RSS: Main: 154546176 11:14:20 INFO - PROCESS | 11375 | 11:17:22 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:44791/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44791/tests/dromaeo/cssquery-mootools.html) 11:17:23 INFO - PROCESS | 11375 | RSS: Main: 153976832 11:17:23 INFO - PROCESS | 11375 | 11:20:24 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:44791/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44791/tests/dromaeo/cssquery-prototype.html) 11:20:25 INFO - PROCESS | 11375 | RSS: Main: 153440256 11:20:25 INFO - PROCESS | 11375 | 11:23:27 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:44791/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44791/tests/dromaeo/cssquery-yui.html) 11:23:28 INFO - PROCESS | 11375 | RSS: Main: 154849280 11:23:28 INFO - PROCESS | 11375 | 11:26:30 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:44791/tests/dromaeo/cssquery-yui.html (next: http://localhost:44791/tests/dromaeo/cssquery-dojo.html) 11:26:31 INFO - PROCESS | 11375 | RSS: Main: 156037120 11:26:31 INFO - PROCESS | 11375 | 11:26:31 INFO - PROCESS | 11375 | __start_tp_report 11:26:31 INFO - PROCESS | 11375 | _x_x_mozilla_page_load 11:26:31 INFO - PROCESS | 11375 | _x_x_mozilla_page_load_details 11:26:31 INFO - PROCESS | 11375 | |i|pagename|runs| 11:26:31 INFO - PROCESS | 11375 | |0;dojo.html;3375.6793104655058;3432.7425443091765;3448.8792892248775;3459.048761590564;3490.8778192763257;5690.51630611398;5706.714664266791;5724.542036637069;5743.023685973384;5757.539396848252;5717.685527295997;5730.197772311869;5733.885322293551;5752.539796816255;5760.45275698809;5198.2982297389935;5200.0379929712935;5232.973835130838;5264.157734762439;5267.157254839227;5105.157648987931;5208.348956380452;5212.947870521303;5342.492463215988;5346.03771321162;5178.456262092483;5238.580913526908;5246.7638956247065;5290.2064690296575;5336.226247194155;5252.5010124038345;5259.658122222062;5261.342332208474;5271.65734227274;5290.39160496544;5028.874278143039;5100.846974590768;5168.940367224747;5232.032074066272;5250.291210686547;5477.370102438191;5516.834494965157;5537.169424586304;5601.579881508862;5625.971870140664;6109.4501494865235;6120.846978825521;6146.262448506208;6151.323354431009;6158.9692051539905;6011.639301641915;6126.540509461764;6184.505239580868;6200.0699895016105;6222.253329600477;5709.0580054290995;5765.250517432707;5771.595988280822;5772.451617096369;5773.480386765169;6270.2789179244055;6295.992641177481;6298.622082675054;6298.937010629927;6300.684965751694;6020.518358531307;6022.036474164112;6041.486473649701;6098.786542470993;6137.048757442603;6064.332923378425;6107.6640784757265;6128.8774224516155;6131.325554189036;6145.907811382833;6053.243344581927;6060.33336333003;6067.696615169224;6075.362086980892;6087.147799308101;5960.8807823844145;5994.67029313392;6042.425969532887;6064.02975523914;6066.545009124245;4565.223911934979;4591.724496530219;4603.240465323252;4603.401557797465;4608;4051.108756073659;4131.5248746393945;4137.40007698888;4143.958560414418;4155.314373128461;5800.767969281266;5891.351951285355;5958.374370691102;5990;6028.608140470856;6119;6193.225846769154;6201.410865967726;6204.317525072239;6217.347178546278;5782.190493330937;5947.732352044169;5966.880662386728;5980.850478738066;5999.820005399845;5255.159174532057;5286.259923610698;5306.575473962151;5316.601254905898;5327.893442131136;6367.108604795332;6400.551961362753;6407;6414.967925160345;6418.74325027003;6020.277566692025;6163.19878415803;6194.256689197326;6198.907016394667;6199.225096862982;6336.809895703136;6361.268454127649;6399.584027038228;6412;6412.807615771534;5997.610155339889;6057.878842423215;6063.363346848518;6067.211262535842;6076;5968.522518198447;6090.451859332681;6103;6129.08063790435;6139.737467782747;5919.112133180058;5956.523478121653;5971.910421343597;5974.9103763444455;5986;5959.463648271676;5986.2217911671205;5989.940100598938;5995.400459953969;6003.309619393651;5719.256496655408;5870.148828419769;5870.383609721089;5985.042393217064;5985.0723137911955;6022.728977196124;6045.365236650088;6056.9697151513965;6079.756809727562;6103.23709536308;5915.585908986502;5933.199018132497;5962.314333851663;5964.045752679551;5969.492593129633 11:26:31 INFO - PROCESS | 11375 | |1;ext.html;675.1931441926897;676.9356911093445;685.064886430023;698.1970733656298;750.714728403207;32210.194745131354;39109.60890391095;39587.40618890719;39779;39924.40113398294;43078.13843723124;43261.56738432615;43834.56165438345;44047.77976110123;44127.558724412746;8839.204471597572;9040.909590904073;9045.412048216846;9061.773455663595;9063.95468022659;8811.515366654832;8967.910320896774;8970.775730606721;8978.057303983085;8980;9157.95421022894;9195.08049195082;9208.585613647401;9216.723498295029;9245.537723113852;9076.63693452261;9120.908790912072;9121.407108537924;9174.128457796565;9192.494412807293;9087.681931132378;9175.220106290973;9190.908090919072;9207.861882071775;9222.21611163052;41075.76772696794;41287.58712412897;41404.1719165615;41442.37836432456;41460;3945.822437990297;4072.8981775455554;4133.1940271647045;4167.74993500391;4393.890152746175;33197.6680233197;33745;34048.659513405044;34049.65950340514;34708;4694.131585656631;4726.905461890743;4749.168895443284;4759.643026773006;4790.952090479085;343919;345984;347741;348534;348877;65526.67236663881;66197.33802662008;66470.33529664642;66647;66939;68168;69241.65379173071;69372;69623;69849.3015069853;19077.713834292495;19302.517437063903;19404.8059519403;19413.223471061283;19440.70838937417;14288.57134285973;14310.928445357707;14344.354504047344;14384.35270412834;14394.42422303117;21268.361949141243;21412.25057122993;21462.678059829115;21662.45843853916;21750.782492175193;7800.9219907801335;7978.401619878532;8046.678132874737;8085.43401961857;8191.8771218430575;1130.621241883978;1149.0922171484601;1213.6541085790684;1222.9877701222874;1298.6493646715523;34536.30927381438;34721.98757763975;34814.303713926085;34968.82515587406;35243;1196.7905616517075;1252.680566455548;1274.3691872523161;1307.2417997561581;1384.4323827230787;17933.67106911684;18122.25226167181;18157.648810862418;18164.00587806021;18225.63548729018;308209;323992;333775;334445;592281;64817.351826482074;65215;65461;66035;66054.33945660578;1510.3430007946579;1512.901661392006;1519.6428839222554;1523.3678023620073;1639.6802623488543;29984.400311994075;30372.544411834282;30437.239069023453;30559.54160687547;31175;57081;57727;57756;57799.4220057794;57832;462894;463662;464123;465169;467799;31599.36801263916;31709.524357135124;31901.521477177397;32569.348613027134;32595.34809303848;52909.47090529045;53820.46179538311;54481.18278225909;54481.72759136179;54705;43557.564424355354;44239.11521769611;44981.775091124335;45042.3243651352;45572;35979.82010089933;36277.27445451129;36361.818190908874;36443.817780910926;36483.27033459263;41761;42479;42796.78601607097;43228.351574727036;46127.308090379345;33394.83302583471;34942.47586286157;35061.649383505835;35117.29765404626;35816;27278.727212728412;29857.25356866096;30017;30212.24469388283;30374.60013752276 11:26:31 INFO - PROCESS | 11375 | |2;jquery.html;420.47440699126093;429.67774169372973;430.1955343507641;430.9095090031094;439.6768375244197;18631.72052419213;18847.528811779695;19376.51558711033;19414.70877936832;19574.41276761696;18629.068546572653;18820.62358752824;19488.41534753956;20048.799512004876;20198.697019544717;5593.188987596796;5858.853528661775;5863.824085277449;5881.588288819784;5893.8821223575505;4078.714489985702;5770.2210201622875;5788.334341550733;6029.336772954972;6369.968150159243;6271.372862713738;6309.400606942333;6313.49492040638;6333.936660633381;6380.872382552347;6039.1545183674325;6235.220597425322;6319.494440444753;6322.36776322364;6337.556371054028;5457.181422786574;5600.635958662674;5605.7197140143235;5630.859228519279;5636.549076073945;23568.410789730395;23800.523989520112;24151.758482415302;24259.514809703705;24261.272161834997;2530.4686015936677;2541.2376287113975;2598.493293807708;2629.605559166121;2657.3489495073636;14598.781018284733;15160.393584256726;15319.157446340447;15493;15503.302351394213;2132.7867213278705;2139.70044193813;2287.5196208796174;2290.9656355154684;2367.4554852383876;83637;85983.57008214982;86621;86705;88519.55740221322;10797.892021079846;11196.38419886914;11515.366654833897;11591.594294199662;11606.361650109326;16076.919615401848;16105.516834494983;16300.184990750415;16326.591835203977;16413.753793693104;8340.124286949904;8591.226789588967;8599.871001934976;8663.696770612998;8700.564971751388;8486.448380855225;8597.613107410056;8601.61292741828;8603.053664096944;8641.135886411308;4459.175052615276;4509.684322097487;4559.612432943237;4561.680682352204;4592.816287348469;1804.7022241330296;1846.5291350705752;3396.6433524480067;3430.850665027194;3588.6949609282983;1006.6979906028163;1094.5512339940585;1115.9888401116048;1122.6070875193616;1126.3298337489182;17862.642747144986;18587.81412185861;19134.61730765377;19280.32518861833;19916.60166796656;1077.2782235901964;1145.6448500964727;1146.2606618730872;1184.934828584419;1189.5717541684987;10898.72753181161;10960.342379457257;11095;11096;11115.055220306203;563646;568056;573496;576136;586698;95849;96027;96794.5160274194;97349;98164.50917745508;1121.0807138146804;1132.4847194526471;1141.686036340013;1157.9536818527165;1161.7908776420325;17060.74408883843;17308.740368894225;17435.215415306087;17583.736243956606;17812.376566820098;40333.19333613253;40940.79529602333;43787.60057921717;43953.56046439495;47799.761001196166;52514.474855250955;56724;57465;58704.70647646734;60155.39844601498;12949.223046617233;13358;13603.183808971493;13632.65918352049;13800.102993305403;14581.489647862274;14601.634959126106;14640.341184646504;14772.778408324099;14918;12677.112602117762;12817.102802803714;12887.548935787578;12910.741785164057;13054.869451305365;12475.688107797378;12705.555305564261;12805.615831525069;12937.482500699867;13188.604341869759;13192.67018324511;13214.669633259246;13245.536406225736;13311.66720831987;13363.064585478924;13255.138416002928;13404.597862064154;13522.526711565048;13544.525941591997;13545.932270338586;12811.487540498276;12902.483900644245;12903.483860645469;12906.483740650268;13018.544350947672 11:26:31 INFO - PROCESS | 11375 | |3;mootools.html;1602.7355486344754;1635.02715884049;1858.5725283184868;1909.5417099896029;1948.4057362504439;8021.799455013627;8264.504129752218;8543.871841922368;8857.778555536115;8887.422317549363;7814.179511151333;8441.366897482698;8593.441426307301;8618.91381086189;8832.072632373589;2454.950900981984;2467.814913881457;2469.715982661999;2478.3432390416556;2490.414752533153;2406.1939250351065;2440.9023639054417;2455.668484754562;2467.370820440785;2470.9258722238274;2444.7433019532873;2446.71862735785;2463.531928933497;2465.0632759551345;2467.370820440785;2372.5966585680476;2383.332666853275;2394.245812569035;2413.963790543143;2443.3769388805918;2399.0523743121544;2436.427439551704;2438.7074850329354;2447.7919376852988;2452.0559584560074;8788.252998495136;8819.735407937773;8838.160374764388;8862.556872156367;8894.911050889474;5547.833564993057;5751.827445176651;5758.683272420015;5760.423957604248;5760.942390576082;3614.012293238708;3617.6563226493704;3640.1263696712863;3650.762700424464;3681.0613293610227;1220.6094049904034;1265.2155663488604;2258.2096266306826;2307.7922986931258;2387.0809738250723;11643.06855451562;11661.067114630809;11718.589849355232;11723.179377443497;11724.062075034062;4649.116667833101;4747.264174053027;4812.927806082912;4829.323894654751;4873.074115917964;9347.766305842273;9399.295052871063;9400.059994000545;9410.200132988635;9424.717258482257;5493.2034854946605;5524.8342549722765;5548.029094908456;5559.19391688211;5595.272614560163;4537.568930951555;5003.299538064601;5089.236614507779;5106.234064890222;5175.611829112831;4010.5187377514885;4015.4980627421573;4074.490688663917;4087.9795601021806;4100.138970816102;1187.4953144913377;1200.591798788416;1202;1213.4660749270292;1217.829503869459;1074.8548945892205;1087.7389426537575;1094.5293523784849;1095.7917995580815;1119.86561612607;6230.813075607739;6329.335419780857;6335.936640633627;6344.809655710336;6614.603123812587;448.9326601009809;464.03017693021746;1105.7733164701217;1170.8126699728002;1176.8705442401329;4323.589259020388;4439.511653718153;4492.842750503717;4506.301523263899;4514.45826500822;10445.425501597334;10805.297655652357;10821.513031913582;10872.565097396173;10895.782084358269;10673.73315667099;10687.14502839771;10729;10738.302010369458;10740.516676749565;8030.759077227693;8314.667413303521;8378.455400398954;8466.872996905051;8477.448965817202;6275.34108918557;6446.258680251831;6499.703925598229;6538.1827271591055;6767.966160169168;10234.846477302697;10367.740806479596;10485.737856553647;10567.841482377617;10636.41499717523;10570.048695617432;10592;10758.946205268923;10858.077063449695;10944.233903626988;7431.331180193809;7822.608869556613;8054.758357249292;8054.8791768122355;8287.12985136576;8624.439411438236;8650.56747162652;8698.95612526501;8740.125987401208;8767.123287671182;7587.810304742426;7925.960370198112;7935.84128317442;7997.560134192675;8057.43597948138;7756.185600512091;7966.123726389977;8005.919940800517;8134.349252059939;8240.670373185005;7520.699172033057;7566.810829729301;7601.049868766404;7603.0876294844975;7731.7680469586;5677.261955945701;5694.829155125353;5719.5710321726865;5790.334111577223;5849.210356601974;5321.04221240165;5366.6243362964215;5562.499375056264;5681.034224181982;5810.622309549865 11:26:31 INFO - PROCESS | 11375 | |4;prototype.html;339.1182924396568;348.11925827656023;364.99087522811925;370.2557858704004;371.23896013173004;5504.944950550494;5624;5629.380768115509;5770.971145144274;5775.653460792355;5619.634723742954;5660.830175094743;5684.54523638109;5711.742971566279;5747.683877386752;4478.596926276635;4480.596746292833;4485.215087359716;4503.513840432649;4508.752018638974;4211.347241177622;4429.623482004034;4468.620167285784;4471.731696098228;4503.752293623849;4371.546478282154;4376.277914144178;4412.97793511032;4422.668299877506;4439.378487011821;4371.693981421302;4371.934420983688;4418.447694038246;4442.311441726538;4447.510773814878;3827.1771569112775;3880.59253778352;3890.5525864525657;3923.5684074751753;3928.8035598220263;5484.669015668325;5513.283273174502;5515.779368825282;5525.751341189656;5526.696031718254;5041.823536176216;5057.418396884369;5061.848144555633;5068.4424713281505;5072.797088116471;5790.913136302959;5935.406459354073;5962.224910761616;6006.96996515019;6007.909881351783;4296.57034296571;4297.570242975708;4323;4329.354845158819;4330.7401555906745;6203.534734894856;6219.813405597839;6240.968795156041;6270.905936410957;6294.464970477515;4262.42457268271;4392;4397.780110994438;4399.406080179199;4415.205263052617;4416.3596278539435;4456.442944631921;4456.710313829591;4457.375967364572;4485.798139083749;5049.914268432231;5060.746962651852;5072.644914855999;5086.618503612244;5091.414487334004;5798.304203495608;5848.795292164754;5907.675077870758;5996.16053752475;6001.2498437695285;1620.3194658243567;1629.2831154292073;1633.0609899307944;1635.934562617482;1644.4573290814003;1066.2376400873259;1081.081081081075;1081.8918108189118;1096.2162054131334;1108.8523378303416;6297.842553936097;6307.5269354798575;6313.526485513605;6319.178506794087;6323.399277068671;6621.271660117383;6623.2383275923885;6646.933530664632;6666.133402657623;6701.1623547056615;5614.157876318585;5919.112133180058;5923.4076592340425;5936.7031648417405;5937.821865344046;3528.7000604948867;3544.946825797615;3560.1099725068734;3563.768355056965;3588.677019068244;6198.2871969723155;6425.518086143465;6482.666240153541;6494.318096599884;6902.137232845895;6290.968545157245;6305.96847015762;6383.382813046628;6417.486601071903;6436.517261205428;6307.211598550181;6443.806685799434;6465.709043092978;6507.349265073455;6550.246721626979;6202.4417802398;6213.844653883508;6274.152989346379;6275.403836635513;6276.717547710273;5897.233359663216;6119.877602448015;6121.877562448815;6122.755089796537;6132.938670613236;6411.8717625646295;6441.645709486023;6445.677716114269;6494.155759751202;6527.836804079936;4440.2007638625355;4467.419235499365;4477.104579084131;4479.865604031885;4501.279795232747;6006.8498287541415;6264.310925798068;6278.623282603058;6316.242050953915;6318.210223722035;6132.78535251264;6135.110408990582;6154.815355539341;6160.168377269011;6180.907286390618;5945.256842894638;6041.18444010053;6113.449789518964;6126.448619624255;6127.437503436595;5929.377415371324;5936.198613187337;5970.97014514942;5971.343152253162;6038.373307611203;6062.939370606414;6104.359042300494;6119;6145.84635384119;6172;5628.971855140698;5829.242198514166;5903.2325797646035;5958.404159584007;5965.194698715792 11:26:31 INFO - PROCESS | 11375 | |5;yui.html;872.8254349130174;892.6161750447309;913.4838816068925;946.3233787841694;963.3574755042645;15016.699666006672;15017.924910375446;15107.093574385544;15140.394384224617;15182.240887955586;14477.85522144781;14499.347529361177;14593.635159121;14621.78067328991;14714.264286785645;911.2163539356148;932.0772435289083;936.3445588088365;949.5726922884695;954.0507195340612;928.8420968435348;928.8746019287411;933.8879334479838;935.5228833295034;948.3551185194066;984.1241295247236;986.4919566423298;987.146118607403;989.8366769483063;1003.8895721470633;974.025974025974;981.9116279534876;982.0130768577606;984.4339504784741;1002.2082554781714;731.1956847467796;733.1275781819618;733.9192688804227;734.6547122852251;735.0444422251105;15413.3834646614;15486.922565387214;15495.922520387327;15613.609659758484;15616.687666246611;14540.127592344494;14623.122612643276;14656.120632761962;14678.853211467962;14691.926540367229;12008.939955300168;12017.63947081589;12088.274703517729;12091.57679481214;12237.388130593436;4053.7567745935044;4098.959010409888;4110.609492098246;4120.587941205886;4170.332746760504;56790.148147777814;57773;58920.41079589235;59166.70416647889;59873.70063149656;11432.199746017699;11561.248518846249;11653.6503904883;11688.766224675459;11706.70733231659;20283.797162028484;20322.288719894732;20329.288474903307;20332.593348132956;20334.593308133753;8558.186972237627;8609.225169734755;8634.963804343519;8810.074942130985;8914.55427228636;5027.095122877844;5098.2352647103235;5113.411957624847;5146.948530514722;5325.893482130413;3586.264815712773;3641.599424063351;3648.7628304160676;3652.6164752701116;3654.1778099927838;658.3317932298721;681.6285124607101;684.9178098628197;690.2510775808304;703.0298188499837;748.9775306740806;786.6931896560346;802.6869520886859;811.8619834628128;816.1756625807858;10343.534540945675;10504.632337868137;10538.947305263424;10589.629362972259;10869.40218287986;721.019413597507;776.2625505769541;779.8401327727802;784.8312612788278;824.8927639406838;4785.3300537924715;4821.4696383397795;4858.951410485921;4916.803327866917;4942.085714142895;63467.6826615864;63650.36349636444;64034;68091;68507.65746171237;57603.423965760645;57790.711046445336;59346;60128.39871601316;61937.690311548155;55392.446075538726;56076.15885761717;56146;56458.717706411204;56953.430465695645;10072.798544029225;10112.64605738825;10206.795864082529;10252.743681408025;10686.25196236256;33909.321813564085;35449.645503544634;36550.8172459136;36570.26859462849;36657;44199.77900110479;47943;48108;48339;48942.51057489379;13369.131006484547;13451.730965380442;13607.591772246848;13631.591052268448;13863.584092477242;14720.558383248519;14742.778858317348;14924.104553726811;15234.619134521725;15372.84627153714;13967.580972570839;14053;14081.718365632425;14141.292935353396;14302.499412520929;13060.542880999119;13138.211707297593;13778.724425511233;14381.921355898141;14419.351129199422;13529.391177397238;13547.458101676217;13863;13912.165270083828;14177;11641.941790290994;11824.52701891949;11845.76308473843;11882.168248222888;11964.581239656918;12038.638840834788;12103.818442723543;12166.75666486683;12174.939125304316;12311.322877241479 11:26:31 INFO - PROCESS | 11375 | __end_tp_report 11:26:31 INFO - PROCESS | 11375 | __start_cc_report 11:26:31 INFO - PROCESS | 11375 | _x_x_mozilla_cycle_collect,341 11:26:31 INFO - PROCESS | 11375 | __end_cc_report 11:26:31 INFO - PROCESS | 11375 | __startTimestamp1461867991002__endTimestamp 11:26:31 INFO - PROCESS | 11375 | 11:26:31 INFO - PROCESS | 11375 | ------- Summary: start ------- 11:26:31 INFO - PROCESS | 11375 | Number of tests: 6 11:26:31 INFO - PROCESS | 11375 | 11:26:31 INFO - PROCESS | 11375 | [#0] dojo.html Cycles:165 Average:5703.74 Median:5968.52 stddev:644.74 (10.8%) stddev-sans-first:620.31 11:26:31 INFO - PROCESS | 11375 | Values: 3375.7 3432.7 3448.9 3459.0 3490.9 5690.5 5706.7 5724.5 5743.0 5757.5 5717.7 5730.2 5733.9 5752.5 5760.5 5198.3 5200.0 5233.0 5264.2 5267.2 5105.2 5208.3 5212.9 5342.5 5346.0 5178.5 5238.6 5246.8 5290.2 5336.2 5252.5 5259.7 5261.3 5271.7 5290.4 5028.9 5100.8 5168.9 5232.0 5250.3 5477.4 5516.8 5537.2 5601.6 5626.0 6109.5 6120.8 6146.3 6151.3 6159.0 6011.6 6126.5 6184.5 6200.1 6222.3 5709.1 5765.3 5771.6 5772.5 5773.5 6270.3 6296.0 6298.6 6298.9 6300.7 6020.5 6022.0 6041.5 6098.8 6137.0 6064.3 6107.7 6128.9 6131.3 6145.9 6053.2 6060.3 6067.7 6075.4 6087.1 5960.9 5994.7 6042.4 6064.0 6066.5 4565.2 4591.7 4603.2 4603.4 4608.0 4051.1 4131.5 4137.4 4144.0 4155.3 5800.8 5891.4 5958.4 5990.0 6028.6 6119.0 6193.2 6201.4 6204.3 6217.3 5782.2 5947.7 5966.9 5980.9 5999.8 5255.2 5286.3 5306.6 5316.6 5327.9 6367.1 6400.6 6407.0 6415.0 6418.7 6020.3 6163.2 6194.3 6198.9 6199.2 6336.8 6361.3 6399.6 6412.0 6412.8 5997.6 6057.9 6063.4 6067.2 6076.0 5968.5 6090.5 6103.0 6129.1 6139.7 5919.1 5956.5 5971.9 5974.9 5986.0 5959.5 5986.2 5989.9 5995.4 6003.3 5719.3 5870.1 5870.4 5985.0 5985.1 6022.7 6045.4 6057.0 6079.8 6103.2 5915.6 5933.2 5962.3 5964.0 5969.5 11:26:31 INFO - PROCESS | 11375 | 11:26:31 INFO - PROCESS | 11375 | [#1] ext.html Cycles:180 Average:57964.55 Median:41451.19 stddev:106828.88 (257.7%) stddev-sans-first:107041.96 11:26:31 INFO - PROCESS | 11375 | Values: 675.2 676.9 685.1 698.2 750.7 32210.2 39109.6 39587.4 39779.0 39924.4 43078.1 43261.6 43834.6 44047.8 44127.6 8839.2 9040.9 9045.4 9061.8 9064.0 8811.5 8967.9 8970.8 8978.1 8980.0 9158.0 9195.1 9208.6 9216.7 9245.5 9076.6 9120.9 9121.4 9174.1 9192.5 9087.7 9175.2 9190.9 9207.9 9222.2 41075.8 41287.6 41404.2 41442.4 41460.0 3945.8 4072.9 4133.2 4167.7 4393.9 33197.7 33745.0 34048.7 34049.7 34708.0 4694.1 4726.9 4749.2 4759.6 4791.0 343919.0 345984.0 347741.0 348534.0 348877.0 65526.7 66197.3 66470.3 66647.0 66939.0 68168.0 69241.7 69372.0 69623.0 69849.3 19077.7 19302.5 19404.8 19413.2 19440.7 14288.6 14310.9 14344.4 14384.4 14394.4 21268.4 21412.3 21462.7 21662.5 21750.8 7800.9 7978.4 8046.7 8085.4 8191.9 1130.6 1149.1 1213.7 1223.0 1298.6 34536.3 34722.0 34814.3 34968.8 35243.0 1196.8 1252.7 1274.4 1307.2 1384.4 17933.7 18122.3 18157.6 18164.0 18225.6 308209.0 323992.0 333775.0 334445.0 592281.0 64817.4 65215.0 65461.0 66035.0 66054.3 1510.3 1512.9 1519.6 1523.4 1639.7 29984.4 30372.5 30437.2 30559.5 31175.0 57081.0 57727.0 57756.0 57799.4 57832.0 462894.0 463662.0 464123.0 465169.0 467799.0 31599.4 31709.5 31901.5 32569.3 32595.3 52909.5 53820.5 54481.2 54481.7 54705.0 43557.6 44239.1 44981.8 45042.3 45572.0 35979.8 36277.3 36361.8 36443.8 36483.3 41761.0 42479.0 42796.8 43228.4 46127.3 33394.8 34942.5 35061.6 35117.3 35816.0 27278.7 29857.3 30017.0 30212.2 30374.6 11:26:31 INFO - PROCESS | 11375 | 11:26:31 INFO - PROCESS | 11375 | [#2] jquery.html Cycles:180 Average:32397.20 Median:20123.75 stddev:94194.06 (468.1%) stddev-sans-first:94427.69 11:26:31 INFO - PROCESS | 11375 | Values: 420.5 429.7 430.2 430.9 439.7 18631.7 18847.5 19376.5 19414.7 19574.4 18629.1 18820.6 19488.4 20048.8 20198.7 5593.2 5858.9 5863.8 5881.6 5893.9 4078.7 5770.2 5788.3 6029.3 6370.0 6271.4 6309.4 6313.5 6333.9 6380.9 6039.2 6235.2 6319.5 6322.4 6337.6 5457.2 5600.6 5605.7 5630.9 5636.5 23568.4 23800.5 24151.8 24259.5 24261.3 2530.5 2541.2 2598.5 2629.6 2657.3 14598.8 15160.4 15319.2 15493.0 15503.3 2132.8 2139.7 2287.5 2291.0 2367.5 83637.0 85983.6 86621.0 86705.0 88519.6 10797.9 11196.4 11515.4 11591.6 11606.4 16076.9 16105.5 16300.2 16326.6 16413.8 8340.1 8591.2 8599.9 8663.7 8700.6 8486.4 8597.6 8601.6 8603.1 8641.1 4459.2 4509.7 4559.6 4561.7 4592.8 1804.7 1846.5 3396.6 3430.9 3588.7 1006.7 1094.6 1116.0 1122.6 1126.3 17862.6 18587.8 19134.6 19280.3 19916.6 1077.3 1145.6 1146.3 1184.9 1189.6 10898.7 10960.3 11095.0 11096.0 11115.1 563646.0 568056.0 573496.0 576136.0 586698.0 95849.0 96027.0 96794.5 97349.0 98164.5 1121.1 1132.5 1141.7 1158.0 1161.8 17060.7 17308.7 17435.2 17583.7 17812.4 40333.2 40940.8 43787.6 43953.6 47799.8 52514.5 56724.0 57465.0 58704.7 60155.4 12949.2 13358.0 13603.2 13632.7 13800.1 14581.5 14601.6 14640.3 14772.8 14918.0 12677.1 12817.1 12887.5 12910.7 13054.9 12475.7 12705.6 12805.6 12937.5 13188.6 13192.7 13214.7 13245.5 13311.7 13363.1 13255.1 13404.6 13522.5 13544.5 13545.9 12811.5 12902.5 12903.5 12906.5 13018.5 11:26:31 INFO - PROCESS | 11375 | 11:26:31 INFO - PROCESS | 11375 | [#3] mootools.html Cycles:180 Average:5958.12 Median:2556.57 stddev:3196.90 (125.0%) stddev-sans-first:3189.11 11:26:31 INFO - PROCESS | 11375 | Values: 1602.7 1635.0 1858.6 1909.5 1948.4 8021.8 8264.5 8543.9 8857.8 8887.4 7814.2 8441.4 8593.4 8618.9 8832.1 2455.0 2467.8 2469.7 2478.3 2490.4 2406.2 2440.9 2455.7 2467.4 2470.9 2444.7 2446.7 2463.5 2465.1 2467.4 2372.6 2383.3 2394.2 2414.0 2443.4 2399.1 2436.4 2438.7 2447.8 2452.1 8788.3 8819.7 8838.2 8862.6 8894.9 5547.8 5751.8 5758.7 5760.4 5760.9 3614.0 3617.7 3640.1 3650.8 3681.1 1220.6 1265.2 2258.2 2307.8 2387.1 11643.1 11661.1 11718.6 11723.2 11724.1 4649.1 4747.3 4812.9 4829.3 4873.1 9347.8 9399.3 9400.1 9410.2 9424.7 5493.2 5524.8 5548.0 5559.2 5595.3 4537.6 5003.3 5089.2 5106.2 5175.6 4010.5 4015.5 4074.5 4088.0 4100.1 1187.5 1200.6 1202.0 1213.5 1217.8 1074.9 1087.7 1094.5 1095.8 1119.9 6230.8 6329.3 6335.9 6344.8 6614.6 448.9 464.0 1105.8 1170.8 1176.9 4323.6 4439.5 4492.8 4506.3 4514.5 10445.4 10805.3 10821.5 10872.6 10895.8 10673.7 10687.1 10729.0 10738.3 10740.5 8030.8 8314.7 8378.5 8466.9 8477.4 6275.3 6446.3 6499.7 6538.2 6768.0 10234.8 10367.7 10485.7 10567.8 10636.4 10570.0 10592.0 10758.9 10858.1 10944.2 7431.3 7822.6 8054.8 8054.9 8287.1 8624.4 8650.6 8699.0 8740.1 8767.1 7587.8 7926.0 7935.8 7997.6 8057.4 7756.2 7966.1 8005.9 8134.3 8240.7 7520.7 7566.8 7601.0 7603.1 7731.8 5677.3 5694.8 5719.6 5790.3 5849.2 5321.0 5366.6 5562.5 5681.0 5810.6 11:26:31 INFO - PROCESS | 11375 | 11:26:31 INFO - PROCESS | 11375 | [#4] prototype.html Cycles:180 Average:5119.61 Median:5773.31 stddev:1509.62 (26.1%) stddev-sans-first:1470.59 11:26:31 INFO - PROCESS | 11375 | Values: 339.1 348.1 365.0 370.3 371.2 5504.9 5624.0 5629.4 5771.0 5775.7 5619.6 5660.8 5684.5 5711.7 5747.7 4478.6 4480.6 4485.2 4503.5 4508.8 4211.3 4429.6 4468.6 4471.7 4503.8 4371.5 4376.3 4413.0 4422.7 4439.4 4371.7 4371.9 4418.4 4442.3 4447.5 3827.2 3880.6 3890.6 3923.6 3928.8 5484.7 5513.3 5515.8 5525.8 5526.7 5041.8 5057.4 5061.8 5068.4 5072.8 5790.9 5935.4 5962.2 6007.0 6007.9 4296.6 4297.6 4323.0 4329.4 4330.7 6203.5 6219.8 6241.0 6270.9 6294.5 4262.4 4392.0 4397.8 4399.4 4415.2 4416.4 4456.4 4456.7 4457.4 4485.8 5049.9 5060.7 5072.6 5086.6 5091.4 5798.3 5848.8 5907.7 5996.2 6001.2 1620.3 1629.3 1633.1 1635.9 1644.5 1066.2 1081.1 1081.9 1096.2 1108.9 6297.8 6307.5 6313.5 6319.2 6323.4 6621.3 6623.2 6646.9 6666.1 6701.2 5614.2 5919.1 5923.4 5936.7 5937.8 3528.7 3544.9 3560.1 3563.8 3588.7 6198.3 6425.5 6482.7 6494.3 6902.1 6291.0 6306.0 6383.4 6417.5 6436.5 6307.2 6443.8 6465.7 6507.3 6550.2 6202.4 6213.8 6274.2 6275.4 6276.7 5897.2 6119.9 6121.9 6122.8 6132.9 6411.9 6441.6 6445.7 6494.2 6527.8 4440.2 4467.4 4477.1 4479.9 4501.3 6006.8 6264.3 6278.6 6316.2 6318.2 6132.8 6135.1 6154.8 6160.2 6180.9 5945.3 6041.2 6113.4 6126.4 6127.4 5929.4 5936.2 5971.0 5971.3 6038.4 6062.9 6104.4 6119.0 6145.8 6172.0 5629.0 5829.2 5903.2 5958.4 5965.2 11:26:31 INFO - PROCESS | 11375 | 11:26:31 INFO - PROCESS | 11375 | [#5] yui.html Cycles:180 Average:16002.90 Median:36613.63 stddev:18295.36 (50.0%) stddev-sans-first:18311.41 11:26:31 INFO - PROCESS | 11375 | Values: 872.8 892.6 913.5 946.3 963.4 15016.7 15017.9 15107.1 15140.4 15182.2 14477.9 14499.3 14593.6 14621.8 14714.3 911.2 932.1 936.3 949.6 954.1 928.8 928.9 933.9 935.5 948.4 984.1 986.5 987.1 989.8 1003.9 974.0 981.9 982.0 984.4 1002.2 731.2 733.1 733.9 734.7 735.0 15413.4 15486.9 15495.9 15613.6 15616.7 14540.1 14623.1 14656.1 14678.9 14691.9 12008.9 12017.6 12088.3 12091.6 12237.4 4053.8 4099.0 4110.6 4120.6 4170.3 56790.1 57773.0 58920.4 59166.7 59873.7 11432.2 11561.2 11653.7 11688.8 11706.7 20283.8 20322.3 20329.3 20332.6 20334.6 8558.2 8609.2 8635.0 8810.1 8914.6 5027.1 5098.2 5113.4 5146.9 5325.9 3586.3 3641.6 3648.8 3652.6 3654.2 658.3 681.6 684.9 690.3 703.0 749.0 786.7 802.7 811.9 816.2 10343.5 10504.6 10538.9 10589.6 10869.4 721.0 776.3 779.8 784.8 824.9 4785.3 4821.5 4859.0 4916.8 4942.1 63467.7 63650.4 64034.0 68091.0 68507.7 57603.4 57790.7 59346.0 60128.4 61937.7 55392.4 56076.2 56146.0 56458.7 56953.4 10072.8 10112.6 10206.8 10252.7 10686.3 33909.3 35449.6 36550.8 36570.3 36657.0 44199.8 47943.0 48108.0 48339.0 48942.5 13369.1 13451.7 13607.6 13631.6 13863.6 14720.6 14742.8 14924.1 15234.6 15372.8 13967.6 14053.0 14081.7 14141.3 14302.5 13060.5 13138.2 13778.7 14381.9 14419.4 13529.4 13547.5 13863.0 13912.2 14177.0 11641.9 11824.5 11845.8 11882.2 11964.6 12038.6 12103.8 12166.8 12174.9 12311.3 11:26:31 INFO - PROCESS | 11375 | -------- Summary: end -------- 11:26:31 INFO - PROCESS | 11375 | 11:26:31 INFO - TEST-INFO | 11375: exit 0 11:26:31 INFO - TEST-OK | dromaeo_css | took 1110117ms 11:26:31 INFO - TEST-START | kraken 11:26:31 INFO - operating with platform_type : linux_ 11:26:31 INFO - Initialising browser for kraken test... 11:26:31 INFO - TEST-INFO | started process 11612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XGMVW/profile http://localhost:44791/getInfo.html) 11:26:35 INFO - PROCESS | 11612 | 11:26:35 INFO - PROCESS | 11612 | (process:11691): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:26:36 INFO - PROCESS | 11612 | __metrics Screen width/height:1600/1200 11:26:36 INFO - PROCESS | 11612 | colorDepth:24 11:26:36 INFO - PROCESS | 11612 | Browser inner width/height: 1024/697 11:26:36 INFO - PROCESS | 11612 | __metrics 11:26:37 ERROR - PROCESS | 11612 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:26:38 INFO - TEST-INFO | 11612: exit 0 11:26:38 INFO - Browser initialized. 11:26:38 INFO - Running cycle 1/1 for kraken test... 11:26:38 INFO - TEST-INFO | started process 11743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XGMVW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:40 INFO - PROCESS | 11743 | 11:26:40 INFO - PROCESS | 11743 | (process:11811): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:26:50 INFO - PROCESS | 11743 | RSS: Main: 152346624 11:26:50 INFO - PROCESS | 11743 | 11:26:52 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44791/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:53 INFO - PROCESS | 11743 | RSS: Main: 156938240 11:26:53 INFO - PROCESS | 11743 | 11:26:56 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44791/tests/kraken/driver.html?testName=audio-dft) 11:26:56 INFO - PROCESS | 11743 | RSS: Main: 157085696 11:26:56 INFO - PROCESS | 11743 | 11:26:59 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44791/tests/kraken/driver.html?testName=audio-fft) 11:27:00 INFO - PROCESS | 11743 | RSS: Main: 157753344 11:27:00 INFO - PROCESS | 11743 | 11:27:02 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44791/tests/kraken/driver.html?testName=audio-oscillator) 11:27:02 INFO - PROCESS | 11743 | RSS: Main: 157949952 11:27:02 INFO - PROCESS | 11743 | 11:27:05 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44791/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:05 INFO - PROCESS | 11743 | RSS: Main: 157700096 11:27:05 INFO - PROCESS | 11743 | 11:27:08 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44791/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:09 INFO - PROCESS | 11743 | RSS: Main: 157769728 11:27:09 INFO - PROCESS | 11743 | 11:27:12 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44791/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:13 INFO - PROCESS | 11743 | RSS: Main: 157822976 11:27:13 INFO - PROCESS | 11743 | 11:27:16 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44791/tests/kraken/driver.html?testName=json-parse-financial) 11:27:16 INFO - PROCESS | 11743 | RSS: Main: 157847552 11:27:16 INFO - PROCESS | 11743 | 11:27:18 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44791/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:19 INFO - PROCESS | 11743 | RSS: Main: 157904896 11:27:19 INFO - PROCESS | 11743 | 11:27:20 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44791/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:21 INFO - PROCESS | 11743 | RSS: Main: 158015488 11:27:21 INFO - PROCESS | 11743 | 11:27:23 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44791/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:24 INFO - PROCESS | 11743 | RSS: Main: 158052352 11:27:24 INFO - PROCESS | 11743 | 11:27:26 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:27 INFO - PROCESS | 11743 | RSS: Main: 158912512 11:27:27 INFO - PROCESS | 11743 | 11:27:29 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:30 INFO - PROCESS | 11743 | RSS: Main: 159010816 11:27:30 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | Cycle 1(1): loaded http://localhost:44791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44791/tests/kraken/driver.html?testName=ai-astar) 11:27:32 INFO - PROCESS | 11743 | RSS: Main: 160100352 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | __start_tp_report 11:27:32 INFO - PROCESS | 11743 | _x_x_mozilla_page_load 11:27:32 INFO - PROCESS | 11743 | _x_x_mozilla_page_load_details 11:27:32 INFO - PROCESS | 11743 | |i|pagename|runs| 11:27:32 INFO - PROCESS | 11743 | |0;ai-astar;111;105;110;111;111;123;111;112;110;111 11:27:32 INFO - PROCESS | 11743 | |1;audio-beat-detection;169;127;152;181;134;154;153;130;196;127 11:27:32 INFO - PROCESS | 11743 | |2;audio-dft;163;161;164;163;162;163;160;162;164;162 11:27:32 INFO - PROCESS | 11743 | |3;audio-fft;75;80;77;171;76;74;77;78;174;77 11:27:32 INFO - PROCESS | 11743 | |4;audio-oscillator;92;93;146;92;94;93;143;93;94;147 11:27:32 INFO - PROCESS | 11743 | |5;imaging-gaussian-blur;117;117;117;118;117;119;117;117;117;117 11:27:32 INFO - PROCESS | 11743 | |6;imaging-darkroom;145;147;145;146;147;146;147;147;147;146 11:27:32 INFO - PROCESS | 11743 | |7;imaging-desaturate;96;95;96;95;95;96;95;95;95;95 11:27:32 INFO - PROCESS | 11743 | |8;json-parse-financial;56;57;59;56;57;57;60;78;58;57 11:27:32 INFO - PROCESS | 11743 | |9;json-stringify-tinderbox;57;57;56;57;57;57;57;57;57;57 11:27:32 INFO - PROCESS | 11743 | |10;stanford-crypto-aes;73;73;73;74;75;76;75;81;76;73 11:27:32 INFO - PROCESS | 11743 | |11;stanford-crypto-ccm;126;126;125;125;117;129;121;126;162;124 11:27:32 INFO - PROCESS | 11743 | |12;stanford-crypto-pbkdf2;159;164;163;158;164;170;157;159;157;154 11:27:32 INFO - PROCESS | 11743 | |13;stanford-crypto-sha256-iterative;69;68;69;67;67;68;66;70;66;65 11:27:32 INFO - PROCESS | 11743 | __end_tp_report 11:27:32 INFO - PROCESS | 11743 | __start_cc_report 11:27:32 INFO - PROCESS | 11743 | _x_x_mozilla_cycle_collect,859 11:27:32 INFO - PROCESS | 11743 | __end_cc_report 11:27:32 INFO - PROCESS | 11743 | __startTimestamp1461868052509__endTimestamp 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | ------- Summary: start ------- 11:27:32 INFO - PROCESS | 11743 | Number of tests: 14 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:4.48 (4.0%) stddev-sans-first:4.75 11:27:32 INFO - PROCESS | 11743 | Values: 111.0 105.0 110.0 111.0 111.0 123.0 111.0 112.0 110.0 111.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:153.50 stddev:23.87 (15.6%) stddev-sans-first:24.54 11:27:32 INFO - PROCESS | 11743 | Values: 169.0 127.0 152.0 181.0 134.0 154.0 153.0 130.0 196.0 127.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 11:27:32 INFO - PROCESS | 11743 | Values: 163.0 161.0 164.0 163.0 162.0 163.0 160.0 162.0 164.0 162.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#3] audio-fft Cycles:10 Average:95.90 Median:77.00 stddev:40.41 (52.5%) stddev-sans-first:42.15 11:27:32 INFO - PROCESS | 11743 | Values: 75.0 80.0 77.0 171.0 76.0 74.0 77.0 78.0 174.0 77.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:25.31 (27.2%) stddev-sans-first:26.11 11:27:32 INFO - PROCESS | 11743 | Values: 92.0 93.0 146.0 92.0 94.0 93.0 143.0 93.0 94.0 147.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 11:27:32 INFO - PROCESS | 11743 | Values: 117.0 117.0 117.0 118.0 117.0 119.0 117.0 117.0 117.0 117.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 11:27:32 INFO - PROCESS | 11743 | Values: 145.0 147.0 145.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:27:32 INFO - PROCESS | 11743 | Values: 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:57.50 stddev:6.62 (11.5%) stddev-sans-first:6.90 11:27:32 INFO - PROCESS | 11743 | Values: 56.0 57.0 59.0 56.0 57.0 57.0 60.0 78.0 58.0 57.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 11:27:32 INFO - PROCESS | 11743 | Values: 57.0 57.0 56.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:2.47 (3.3%) stddev-sans-first:2.52 11:27:32 INFO - PROCESS | 11743 | Values: 73.0 73.0 73.0 74.0 75.0 76.0 75.0 81.0 76.0 73.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:126.00 stddev:12.35 (9.8%) stddev-sans-first:13.08 11:27:32 INFO - PROCESS | 11743 | Values: 126.0 126.0 125.0 125.0 117.0 129.0 121.0 126.0 162.0 124.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.00 stddev:4.70 (2.9%) stddev-sans-first:4.95 11:27:32 INFO - PROCESS | 11743 | Values: 159.0 164.0 163.0 158.0 164.0 170.0 157.0 159.0 157.0 154.0 11:27:32 INFO - PROCESS | 11743 | 11:27:32 INFO - PROCESS | 11743 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.58 (2.3%) stddev-sans-first:1.58 11:27:32 INFO - PROCESS | 11743 | Values: 69.0 68.0 69.0 67.0 67.0 68.0 66.0 70.0 66.0 65.0 11:27:32 INFO - PROCESS | 11743 | -------- Summary: end -------- 11:27:32 INFO - PROCESS | 11743 | 11:27:33 INFO - TEST-INFO | 11743: exit 0 11:27:33 INFO - TEST-OK | kraken | took 61764ms 11:27:33 INFO - SUITE-END | took 1171s 11:27:33 INFO - Completed test suite (00:19:32) 11:27:33 INFO - javascript benchmark 11:27:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.6793104655058, 3432.7425443091765, 3448.8792892248775, 3459.048761590564, 3490.8778192763257, 5690.51630611398, 5706.714664266791, 5724.542036637069, 5743.023685973384, 5757.539396848252, 5717.685527295997, 5730.197772311869, 5733.885322293551, 5752.539796816255, 5760.45275698809, 5198.2982297389935, 5200.0379929712935, 5232.973835130838, 5264.157734762439, 5267.157254839227, 5105.157648987931, 5208.348956380452, 5212.947870521303, 5342.492463215988, 5346.03771321162, 5178.456262092483, 5238.580913526908, 5246.7638956247065, 5290.2064690296575, 5336.226247194155, 5252.5010124038345, 5259.658122222062, 5261.342332208474, 5271.65734227274, 5290.39160496544, 5028.874278143039, 5100.846974590768, 5168.940367224747, 5232.032074066272, 5250.291210686547, 5477.370102438191, 5516.834494965157, 5537.169424586304, 5601.579881508862, 5625.971870140664, 6109.4501494865235, 6120.846978825521, 6146.262448506208, 6151.323354431009, 6158.9692051539905, 6011.639301641915, 6126.540509461764, 6184.505239580868, 6200.0699895016105, 6222.253329600477, 5709.0580054290995, 5765.250517432707, 5771.595988280822, 5772.451617096369, 5773.480386765169, 6270.2789179244055, 6295.992641177481, 6298.622082675054, 6298.937010629927, 6300.684965751694, 6020.518358531307, 6022.036474164112, 6041.486473649701, 6098.786542470993, 6137.048757442603, 6064.332923378425, 6107.6640784757265, 6128.8774224516155, 6131.325554189036, 6145.907811382833, 6053.243344581927, 6060.33336333003, 6067.696615169224, 6075.362086980892, 6087.147799308101, 5960.8807823844145, 5994.67029313392, 6042.425969532887, 6064.02975523914, 6066.545009124245, 4565.223911934979, 4591.724496530219, 4603.240465323252, 4603.401557797465, 4608.0, 4051.108756073659, 4131.5248746393945, 4137.40007698888, 4143.958560414418, 4155.314373128461, 5800.767969281266, 5891.351951285355, 5958.374370691102, 5990.0, 6028.608140470856, 6119.0, 6193.225846769154, 6201.410865967726, 6204.317525072239, 6217.347178546278, 5782.190493330937, 5947.732352044169, 5966.880662386728, 5980.850478738066, 5999.820005399845, 5255.159174532057, 5286.259923610698, 5306.575473962151, 5316.601254905898, 5327.893442131136, 6367.108604795332, 6400.551961362753, 6407.0, 6414.967925160345, 6418.74325027003, 6020.277566692025, 6163.19878415803, 6194.256689197326, 6198.907016394667, 6199.225096862982, 6336.809895703136, 6361.268454127649, 6399.584027038228, 6412.0, 6412.807615771534, 5997.610155339889, 6057.878842423215, 6063.363346848518, 6067.211262535842, 6076.0, 5968.522518198447, 6090.451859332681, 6103.0, 6129.08063790435, 6139.737467782747, 5919.112133180058, 5956.523478121653, 5971.910421343597, 5974.9103763444455, 5986.0, 5959.463648271676, 5986.2217911671205, 5989.940100598938, 5995.400459953969, 6003.309619393651, 5719.256496655408, 5870.148828419769, 5870.383609721089, 5985.042393217064, 5985.0723137911955, 6022.728977196124, 6045.365236650088, 6056.9697151513965, 6079.756809727562, 6103.23709536308, 5915.585908986502, 5933.199018132497, 5962.314333851663, 5964.045752679551, 5969.492593129633], "value": 5660.941274204506, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.1931441926897, 676.9356911093445, 685.064886430023, 698.1970733656298, 750.714728403207, 32210.194745131354, 39109.60890391095, 39587.40618890719, 39779.0, 39924.40113398294, 43078.13843723124, 43261.56738432615, 43834.56165438345, 44047.77976110123, 44127.558724412746, 8839.204471597572, 9040.909590904073, 9045.412048216846, 9061.773455663595, 9063.95468022659, 8811.515366654832, 8967.910320896774, 8970.775730606721, 8978.057303983085, 8980.0, 9157.95421022894, 9195.08049195082, 9208.585613647401, 9216.723498295029, 9245.537723113852, 9076.63693452261, 9120.908790912072, 9121.407108537924, 9174.128457796565, 9192.494412807293, 9087.681931132378, 9175.220106290973, 9190.908090919072, 9207.861882071775, 9222.21611163052, 41075.76772696794, 41287.58712412897, 41404.1719165615, 41442.37836432456, 41460.0, 3945.822437990297, 4072.8981775455554, 4133.1940271647045, 4167.74993500391, 4393.890152746175, 33197.6680233197, 33745.0, 34048.659513405044, 34049.65950340514, 34708.0, 4694.131585656631, 4726.905461890743, 4749.168895443284, 4759.643026773006, 4790.952090479085, 343919.0, 345984.0, 347741.0, 348534.0, 348877.0, 65526.67236663881, 66197.33802662008, 66470.33529664642, 66647.0, 66939.0, 68168.0, 69241.65379173071, 69372.0, 69623.0, 69849.3015069853, 19077.713834292495, 19302.517437063903, 19404.8059519403, 19413.223471061283, 19440.70838937417, 14288.57134285973, 14310.928445357707, 14344.354504047344, 14384.35270412834, 14394.42422303117, 21268.361949141243, 21412.25057122993, 21462.678059829115, 21662.45843853916, 21750.782492175193, 7800.9219907801335, 7978.401619878532, 8046.678132874737, 8085.43401961857, 8191.8771218430575, 1130.621241883978, 1149.0922171484601, 1213.6541085790684, 1222.9877701222874, 1298.6493646715523, 34536.30927381438, 34721.98757763975, 34814.303713926085, 34968.82515587406, 35243.0, 1196.7905616517075, 1252.680566455548, 1274.3691872523161, 1307.2417997561581, 1384.4323827230787, 17933.67106911684, 18122.25226167181, 18157.648810862418, 18164.00587806021, 18225.63548729018, 308209.0, 323992.0, 333775.0, 334445.0, 592281.0, 64817.351826482074, 65215.0, 65461.0, 66035.0, 66054.33945660578, 1510.3430007946579, 1512.901661392006, 1519.6428839222554, 1523.3678023620073, 1639.6802623488543, 29984.400311994075, 30372.544411834282, 30437.239069023453, 30559.54160687547, 31175.0, 57081.0, 57727.0, 57756.0, 57799.4220057794, 57832.0, 462894.0, 463662.0, 464123.0, 465169.0, 467799.0, 31599.36801263916, 31709.524357135124, 31901.521477177397, 32569.348613027134, 32595.34809303848, 52909.47090529045, 53820.46179538311, 54481.18278225909, 54481.72759136179, 54705.0, 43557.564424355354, 44239.11521769611, 44981.775091124335, 45042.3243651352, 45572.0, 35979.82010089933, 36277.27445451129, 36361.818190908874, 36443.817780910926, 36483.27033459263, 41761.0, 42479.0, 42796.78601607097, 43228.351574727036, 46127.308090379345, 33394.83302583471, 34942.47586286157, 35061.649383505835, 35117.29765404626, 35816.0, 27278.727212728412, 29857.25356866096, 30017.0, 30212.24469388283, 30374.60013752276], "value": 21223.137473042745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.47440699126093, 429.67774169372973, 430.1955343507641, 430.9095090031094, 439.6768375244197, 18631.72052419213, 18847.528811779695, 19376.51558711033, 19414.70877936832, 19574.41276761696, 18629.068546572653, 18820.62358752824, 19488.41534753956, 20048.799512004876, 20198.697019544717, 5593.188987596796, 5858.853528661775, 5863.824085277449, 5881.588288819784, 5893.8821223575505, 4078.714489985702, 5770.2210201622875, 5788.334341550733, 6029.336772954972, 6369.968150159243, 6271.372862713738, 6309.400606942333, 6313.49492040638, 6333.936660633381, 6380.872382552347, 6039.1545183674325, 6235.220597425322, 6319.494440444753, 6322.36776322364, 6337.556371054028, 5457.181422786574, 5600.635958662674, 5605.7197140143235, 5630.859228519279, 5636.549076073945, 23568.410789730395, 23800.523989520112, 24151.758482415302, 24259.514809703705, 24261.272161834997, 2530.4686015936677, 2541.2376287113975, 2598.493293807708, 2629.605559166121, 2657.3489495073636, 14598.781018284733, 15160.393584256726, 15319.157446340447, 15493.0, 15503.302351394213, 2132.7867213278705, 2139.70044193813, 2287.5196208796174, 2290.9656355154684, 2367.4554852383876, 83637.0, 85983.57008214982, 86621.0, 86705.0, 88519.55740221322, 10797.892021079846, 11196.38419886914, 11515.366654833897, 11591.594294199662, 11606.361650109326, 16076.919615401848, 16105.516834494983, 16300.184990750415, 16326.591835203977, 16413.753793693104, 8340.124286949904, 8591.226789588967, 8599.871001934976, 8663.696770612998, 8700.564971751388, 8486.448380855225, 8597.613107410056, 8601.61292741828, 8603.053664096944, 8641.135886411308, 4459.175052615276, 4509.684322097487, 4559.612432943237, 4561.680682352204, 4592.816287348469, 1804.7022241330296, 1846.5291350705752, 3396.6433524480067, 3430.850665027194, 3588.6949609282983, 1006.6979906028163, 1094.5512339940585, 1115.9888401116048, 1122.6070875193616, 1126.3298337489182, 17862.642747144986, 18587.81412185861, 19134.61730765377, 19280.32518861833, 19916.60166796656, 1077.2782235901964, 1145.6448500964727, 1146.2606618730872, 1184.934828584419, 1189.5717541684987, 10898.72753181161, 10960.342379457257, 11095.0, 11096.0, 11115.055220306203, 563646.0, 568056.0, 573496.0, 576136.0, 586698.0, 95849.0, 96027.0, 96794.5160274194, 97349.0, 98164.50917745508, 1121.0807138146804, 1132.4847194526471, 1141.686036340013, 1157.9536818527165, 1161.7908776420325, 17060.74408883843, 17308.740368894225, 17435.215415306087, 17583.736243956606, 17812.376566820098, 40333.19333613253, 40940.79529602333, 43787.60057921717, 43953.56046439495, 47799.761001196166, 52514.474855250955, 56724.0, 57465.0, 58704.70647646734, 60155.39844601498, 12949.223046617233, 13358.0, 13603.183808971493, 13632.65918352049, 13800.102993305403, 14581.489647862274, 14601.634959126106, 14640.341184646504, 14772.778408324099, 14918.0, 12677.112602117762, 12817.102802803714, 12887.548935787578, 12910.741785164057, 13054.869451305365, 12475.688107797378, 12705.555305564261, 12805.615831525069, 12937.482500699867, 13188.604341869759, 13192.67018324511, 13214.669633259246, 13245.536406225736, 13311.66720831987, 13363.064585478924, 13255.138416002928, 13404.597862064154, 13522.526711565048, 13544.525941591997, 13545.932270338586, 12811.487540498276, 12902.483900644245, 12903.483860645469, 12906.483740650268, 13018.544350947672], "value": 10194.028185076651, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1602.7355486344754, 1635.02715884049, 1858.5725283184868, 1909.5417099896029, 1948.4057362504439, 8021.799455013627, 8264.504129752218, 8543.871841922368, 8857.778555536115, 8887.422317549363, 7814.179511151333, 8441.366897482698, 8593.441426307301, 8618.91381086189, 8832.072632373589, 2454.950900981984, 2467.814913881457, 2469.715982661999, 2478.3432390416556, 2490.414752533153, 2406.1939250351065, 2440.9023639054417, 2455.668484754562, 2467.370820440785, 2470.9258722238274, 2444.7433019532873, 2446.71862735785, 2463.531928933497, 2465.0632759551345, 2467.370820440785, 2372.5966585680476, 2383.332666853275, 2394.245812569035, 2413.963790543143, 2443.3769388805918, 2399.0523743121544, 2436.427439551704, 2438.7074850329354, 2447.7919376852988, 2452.0559584560074, 8788.252998495136, 8819.735407937773, 8838.160374764388, 8862.556872156367, 8894.911050889474, 5547.833564993057, 5751.827445176651, 5758.683272420015, 5760.423957604248, 5760.942390576082, 3614.012293238708, 3617.6563226493704, 3640.1263696712863, 3650.762700424464, 3681.0613293610227, 1220.6094049904034, 1265.2155663488604, 2258.2096266306826, 2307.7922986931258, 2387.0809738250723, 11643.06855451562, 11661.067114630809, 11718.589849355232, 11723.179377443497, 11724.062075034062, 4649.116667833101, 4747.264174053027, 4812.927806082912, 4829.323894654751, 4873.074115917964, 9347.766305842273, 9399.295052871063, 9400.059994000545, 9410.200132988635, 9424.717258482257, 5493.2034854946605, 5524.8342549722765, 5548.029094908456, 5559.19391688211, 5595.272614560163, 4537.568930951555, 5003.299538064601, 5089.236614507779, 5106.234064890222, 5175.611829112831, 4010.5187377514885, 4015.4980627421573, 4074.490688663917, 4087.9795601021806, 4100.138970816102, 1187.4953144913377, 1200.591798788416, 1202.0, 1213.4660749270292, 1217.829503869459, 1074.8548945892205, 1087.7389426537575, 1094.5293523784849, 1095.7917995580815, 1119.86561612607, 6230.813075607739, 6329.335419780857, 6335.936640633627, 6344.809655710336, 6614.603123812587, 448.9326601009809, 464.03017693021746, 1105.7733164701217, 1170.8126699728002, 1176.8705442401329, 4323.589259020388, 4439.511653718153, 4492.842750503717, 4506.301523263899, 4514.45826500822, 10445.425501597334, 10805.297655652357, 10821.513031913582, 10872.565097396173, 10895.782084358269, 10673.73315667099, 10687.14502839771, 10729.0, 10738.302010369458, 10740.516676749565, 8030.759077227693, 8314.667413303521, 8378.455400398954, 8466.872996905051, 8477.448965817202, 6275.34108918557, 6446.258680251831, 6499.703925598229, 6538.1827271591055, 6767.966160169168, 10234.846477302697, 10367.740806479596, 10485.737856553647, 10567.841482377617, 10636.41499717523, 10570.048695617432, 10592.0, 10758.946205268923, 10858.077063449695, 10944.233903626988, 7431.331180193809, 7822.608869556613, 8054.758357249292, 8054.8791768122355, 8287.12985136576, 8624.439411438236, 8650.56747162652, 8698.95612526501, 8740.125987401208, 8767.123287671182, 7587.810304742426, 7925.960370198112, 7935.84128317442, 7997.560134192675, 8057.43597948138, 7756.185600512091, 7966.123726389977, 8005.919940800517, 8134.349252059939, 8240.670373185005, 7520.699172033057, 7566.810829729301, 7601.049868766404, 7603.0876294844975, 7731.7680469586, 5677.261955945701, 5694.829155125353, 5719.5710321726865, 5790.334111577223, 5849.210356601974, 5321.04221240165, 5366.6243362964215, 5562.499375056264, 5681.034224181982, 5810.622309549865], "value": 4869.085024105424, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.1182924396568, 348.11925827656023, 364.99087522811925, 370.2557858704004, 371.23896013173004, 5504.944950550494, 5624.0, 5629.380768115509, 5770.971145144274, 5775.653460792355, 5619.634723742954, 5660.830175094743, 5684.54523638109, 5711.742971566279, 5747.683877386752, 4478.596926276635, 4480.596746292833, 4485.215087359716, 4503.513840432649, 4508.752018638974, 4211.347241177622, 4429.623482004034, 4468.620167285784, 4471.731696098228, 4503.752293623849, 4371.546478282154, 4376.277914144178, 4412.97793511032, 4422.668299877506, 4439.378487011821, 4371.693981421302, 4371.934420983688, 4418.447694038246, 4442.311441726538, 4447.510773814878, 3827.1771569112775, 3880.59253778352, 3890.5525864525657, 3923.5684074751753, 3928.8035598220263, 5484.669015668325, 5513.283273174502, 5515.779368825282, 5525.751341189656, 5526.696031718254, 5041.823536176216, 5057.418396884369, 5061.848144555633, 5068.4424713281505, 5072.797088116471, 5790.913136302959, 5935.406459354073, 5962.224910761616, 6006.96996515019, 6007.909881351783, 4296.57034296571, 4297.570242975708, 4323.0, 4329.354845158819, 4330.7401555906745, 6203.534734894856, 6219.813405597839, 6240.968795156041, 6270.905936410957, 6294.464970477515, 4262.42457268271, 4392.0, 4397.780110994438, 4399.406080179199, 4415.205263052617, 4416.3596278539435, 4456.442944631921, 4456.710313829591, 4457.375967364572, 4485.798139083749, 5049.914268432231, 5060.746962651852, 5072.644914855999, 5086.618503612244, 5091.414487334004, 5798.304203495608, 5848.795292164754, 5907.675077870758, 5996.16053752475, 6001.2498437695285, 1620.3194658243567, 1629.2831154292073, 1633.0609899307944, 1635.934562617482, 1644.4573290814003, 1066.2376400873259, 1081.081081081075, 1081.8918108189118, 1096.2162054131334, 1108.8523378303416, 6297.842553936097, 6307.5269354798575, 6313.526485513605, 6319.178506794087, 6323.399277068671, 6621.271660117383, 6623.2383275923885, 6646.933530664632, 6666.133402657623, 6701.1623547056615, 5614.157876318585, 5919.112133180058, 5923.4076592340425, 5936.7031648417405, 5937.821865344046, 3528.7000604948867, 3544.946825797615, 3560.1099725068734, 3563.768355056965, 3588.677019068244, 6198.2871969723155, 6425.518086143465, 6482.666240153541, 6494.318096599884, 6902.137232845895, 6290.968545157245, 6305.96847015762, 6383.382813046628, 6417.486601071903, 6436.517261205428, 6307.211598550181, 6443.806685799434, 6465.709043092978, 6507.349265073455, 6550.246721626979, 6202.4417802398, 6213.844653883508, 6274.152989346379, 6275.403836635513, 6276.717547710273, 5897.233359663216, 6119.877602448015, 6121.877562448815, 6122.755089796537, 6132.938670613236, 6411.8717625646295, 6441.645709486023, 6445.677716114269, 6494.155759751202, 6527.836804079936, 4440.2007638625355, 4467.419235499365, 4477.104579084131, 4479.865604031885, 4501.279795232747, 6006.8498287541415, 6264.310925798068, 6278.623282603058, 6316.242050953915, 6318.210223722035, 6132.78535251264, 6135.110408990582, 6154.815355539341, 6160.168377269011, 6180.907286390618, 5945.256842894638, 6041.18444010053, 6113.449789518964, 6126.448619624255, 6127.437503436595, 5929.377415371324, 5936.198613187337, 5970.97014514942, 5971.343152253162, 6038.373307611203, 6062.939370606414, 6104.359042300494, 6119.0, 6145.84635384119, 6172.0, 5628.971855140698, 5829.242198514166, 5903.2325797646035, 5958.404159584007, 5965.194698715792], "value": 4645.3842934777695, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.8254349130174, 892.6161750447309, 913.4838816068925, 946.3233787841694, 963.3574755042645, 15016.699666006672, 15017.924910375446, 15107.093574385544, 15140.394384224617, 15182.240887955586, 14477.85522144781, 14499.347529361177, 14593.635159121, 14621.78067328991, 14714.264286785645, 911.2163539356148, 932.0772435289083, 936.3445588088365, 949.5726922884695, 954.0507195340612, 928.8420968435348, 928.8746019287411, 933.8879334479838, 935.5228833295034, 948.3551185194066, 984.1241295247236, 986.4919566423298, 987.146118607403, 989.8366769483063, 1003.8895721470633, 974.025974025974, 981.9116279534876, 982.0130768577606, 984.4339504784741, 1002.2082554781714, 731.1956847467796, 733.1275781819618, 733.9192688804227, 734.6547122852251, 735.0444422251105, 15413.3834646614, 15486.922565387214, 15495.922520387327, 15613.609659758484, 15616.687666246611, 14540.127592344494, 14623.122612643276, 14656.120632761962, 14678.853211467962, 14691.926540367229, 12008.939955300168, 12017.63947081589, 12088.274703517729, 12091.57679481214, 12237.388130593436, 4053.7567745935044, 4098.959010409888, 4110.609492098246, 4120.587941205886, 4170.332746760504, 56790.148147777814, 57773.0, 58920.41079589235, 59166.70416647889, 59873.70063149656, 11432.199746017699, 11561.248518846249, 11653.6503904883, 11688.766224675459, 11706.70733231659, 20283.797162028484, 20322.288719894732, 20329.288474903307, 20332.593348132956, 20334.593308133753, 8558.186972237627, 8609.225169734755, 8634.963804343519, 8810.074942130985, 8914.55427228636, 5027.095122877844, 5098.2352647103235, 5113.411957624847, 5146.948530514722, 5325.893482130413, 3586.264815712773, 3641.599424063351, 3648.7628304160676, 3652.6164752701116, 3654.1778099927838, 658.3317932298721, 681.6285124607101, 684.9178098628197, 690.2510775808304, 703.0298188499837, 748.9775306740806, 786.6931896560346, 802.6869520886859, 811.8619834628128, 816.1756625807858, 10343.534540945675, 10504.632337868137, 10538.947305263424, 10589.629362972259, 10869.40218287986, 721.019413597507, 776.2625505769541, 779.8401327727802, 784.8312612788278, 824.8927639406838, 4785.3300537924715, 4821.4696383397795, 4858.951410485921, 4916.803327866917, 4942.085714142895, 63467.6826615864, 63650.36349636444, 64034.0, 68091.0, 68507.65746171237, 57603.423965760645, 57790.711046445336, 59346.0, 60128.39871601316, 61937.690311548155, 55392.446075538726, 56076.15885761717, 56146.0, 56458.717706411204, 56953.430465695645, 10072.798544029225, 10112.64605738825, 10206.795864082529, 10252.743681408025, 10686.25196236256, 33909.321813564085, 35449.645503544634, 36550.8172459136, 36570.26859462849, 36657.0, 44199.77900110479, 47943.0, 48108.0, 48339.0, 48942.51057489379, 13369.131006484547, 13451.730965380442, 13607.591772246848, 13631.591052268448, 13863.584092477242, 14720.558383248519, 14742.778858317348, 14924.104553726811, 15234.619134521725, 15372.84627153714, 13967.580972570839, 14053.0, 14081.718365632425, 14141.292935353396, 14302.499412520929, 13060.542880999119, 13138.211707297593, 13778.724425511233, 14381.921355898141, 14419.351129199422, 13529.391177397238, 13547.458101676217, 13863.0, 13912.165270083828, 14177.0, 11641.941790290994, 11824.52701891949, 11845.76308473843, 11882.168248222888, 11964.581239656918, 12038.638840834788, 12103.818442723543, 12166.75666486683, 12174.939125304316, 12311.322877241479], "value": 7414.806272553713, "unit": "score"}], "name": "dromaeo_css", "value": 7681.436534889663, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 111.0, 111.0, 123.0, 111.0, 112.0, 110.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 127.0, 152.0, 181.0, 134.0, 154.0, 153.0, 130.0, 196.0, 127.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 163.0, 162.0, 163.0, 160.0, 162.0, 164.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 77.0, 171.0, 76.0, 74.0, 77.0, 78.0, 174.0, 77.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 146.0, 92.0, 94.0, 93.0, 143.0, 93.0, 94.0, 147.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 59.0, 56.0, 57.0, 57.0, 60.0, 78.0, 58.0, 57.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 74.0, 75.0, 76.0, 75.0, 81.0, 76.0, 73.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 125.0, 125.0, 117.0, 129.0, 121.0, 126.0, 162.0, 124.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 164.0, 163.0, 158.0, 164.0, 170.0, 157.0, 159.0, 157.0, 154.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 67.0, 67.0, 68.0, 66.0, 70.0, 66.0, 65.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1537.1000000000001, "alertThreshold": 2.0}]} 11:27:33 INFO - Return code: 0 11:27:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:27:33 ERROR - # TBPL SUCCESS # 11:27:33 INFO - Running post-action listener: _resource_record_post_action 11:27:33 INFO - Running post-run listener: _resource_record_post_run 11:27:34 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 495521792; Read time: 16; Write time: 958332 11:27:34 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 248713216; Read time: 0; Write time: 624984 11:27:34 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 246808576; Read time: 16; Write time: 333348 11:27:34 INFO - Running post-run listener: _upload_blobber_files 11:27:34 INFO - Blob upload gear active. 11:27:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:34 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 11:27:34 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:27:34 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:27:35 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:27:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:36 INFO - (blobuploader) - INFO - Done attempting. 11:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:27:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:37 INFO - (blobuploader) - INFO - Done attempting. 11:27:37 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:37 INFO - Return code: 0 11:27:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad3c555193bc400b13d8f88c203a7fc07dcc2e851500bab043ee2e55664aed73ec1425d2f05b8d732881eb1b084f83ef0cf016620ba24681c7f9438cd85e47d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38fdc67597a678da8836ccf8b2c8eae94aefc10109d4267da3874c6164d245b25b1ab82ecd37b0b382f44876cdf73f0f8c94c3125371d4afd60f9b69f604563c"} 11:27:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:37 INFO - Contents: 11:27:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad3c555193bc400b13d8f88c203a7fc07dcc2e851500bab043ee2e55664aed73ec1425d2f05b8d732881eb1b084f83ef0cf016620ba24681c7f9438cd85e47d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38fdc67597a678da8836ccf8b2c8eae94aefc10109d4267da3874c6164d245b25b1ab82ecd37b0b382f44876cdf73f0f8c94c3125371d4afd60f9b69f604563c"} 11:27:37 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:37 INFO - Copying logs to upload dir... 11:27:37 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.499553 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-28 11:27:36.421210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 11:27:36.424987) ========= 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=33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080 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/Mozilla-Aurora/sha512/ad3c555193bc400b13d8f88c203a7fc07dcc2e851500bab043ee2e55664aed73ec1425d2f05b8d732881eb1b084f83ef0cf016620ba24681c7f9438cd85e47d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38fdc67597a678da8836ccf8b2c8eae94aefc10109d4267da3874c6164d245b25b1ab82ecd37b0b382f44876cdf73f0f8c94c3125371d4afd60f9b69f604563c"} build_url:https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad3c555193bc400b13d8f88c203a7fc07dcc2e851500bab043ee2e55664aed73ec1425d2f05b8d732881eb1b084f83ef0cf016620ba24681c7f9438cd85e47d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38fdc67597a678da8836ccf8b2c8eae94aefc10109d4267da3874c6164d245b25b1ab82ecd37b0b382f44876cdf73f0f8c94c3125371d4afd60f9b69f604563c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 11:27:36.449443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:27:36.449771) ========= 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=33d5923976266a1c518c4bf7000001ab-1461865474.967097-1416245080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:27:36.533286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 11:27:36.533580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 11:27:36.533855) ========= ========= Total master_lag: 0.15 =========