builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1464725946.74 results: success (0) buildid: 20160531103942 builduid: e71bbbe81f194a8996e2dd81575c8890 revision: 9eebb2835273857468a80e0e89013673352a37e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:06.736589) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:06.737008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:06.737286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:06.752953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:06.753250) ========= 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=232498196343f89f466a4a9a000001c8-1464725689.321902-180437406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 13:19: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-05-31 13:19:07 (37.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:06.879744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:06.880057) ========= 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=232498196343f89f466a4a9a000001c8-1464725689.321902-180437406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020433 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:06.929295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:06.929661) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9eebb2835273857468a80e0e89013673352a37e7 --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 9eebb2835273857468a80e0e89013673352a37e7 --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=232498196343f89f466a4a9a000001c8-1464725689.321902-180437406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 13:19:07,439 truncating revision to first 12 chars 2016-05-31 13:19:07,439 Setting DEBUG logging. 2016-05-31 13:19:07,439 attempt 1/10 2016-05-31 13:19:07,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9eebb2835273?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 13:19:08,007 unpacking tar archive at: mozilla-aurora-9eebb2835273/testing/mozharness/ program finished with exit code 0 elapsedTime=0.915347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:07.858243) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:07.858557) ========= script_repo_revision: 9eebb2835273857468a80e0e89013673352a37e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:07.859070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:07.859344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 13:19:07.870347) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-31 13:19:07.870656) ========= /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=232498196343f89f466a4a9a000001c8-1464725689.321902-180437406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:19:08 INFO - MultiFileLogger online at 20160531 13:19:08 in /builds/slave/test 13:19:08 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 13:19:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:19:08 INFO - {'append_to_log': False, 13:19:08 INFO - 'base_work_dir': '/builds/slave/test', 13:19:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:19:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:19:08 INFO - 'branch': 'Mozilla-Aurora', 13:19:08 INFO - 'buildbot_json_path': 'buildprops.json', 13:19:08 INFO - 'config_files': ('talos/linux_config.py',), 13:19:08 INFO - 'default_actions': ('clobber', 13:19:08 INFO - 'read-buildbot-config', 13:19:08 INFO - 'download-and-extract', 13:19:08 INFO - 'populate-webroot', 13:19:08 INFO - 'create-virtualenv', 13:19:08 INFO - 'install', 13:19:08 INFO - 'run-tests'), 13:19:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:19:08 INFO - 'download_minidump_stackwalk': True, 13:19:08 INFO - 'download_symbols': 'ondemand', 13:19:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:19:08 INFO - 'tooltool.py': '/tools/tooltool.py', 13:19:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:19:08 INFO - '/tools/misc-python/virtualenv.py')}, 13:19:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:19:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:19:08 INFO - 'installer_path': 'installer.exe', 13:19:08 INFO - 'log_level': 'info', 13:19:08 INFO - 'log_name': 'talos', 13:19:08 INFO - 'log_to_console': True, 13:19:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:19:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:19:08 INFO - 'opt_config_files': (), 13:19:08 INFO - 'pip_index': False, 13:19:08 INFO - 'sps_profile': False, 13:19:08 INFO - 'sps_profile_interval': 0, 13:19:08 INFO - 'suite': 'dromaeojs-e10s', 13:19:08 INFO - 'system_bits': '32', 13:19:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:19:08 INFO - 'title': 'talos-linux64-ix-025', 13:19:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:19:08 INFO - 'use_talos_json': True, 13:19:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:19:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:19:08 INFO - 'work_dir': 'build'} 13:19:08 INFO - ##### 13:19:08 INFO - ##### Running clobber step. 13:19:08 INFO - ##### 13:19:08 INFO - Running pre-action listener: _resource_record_pre_action 13:19:08 INFO - Running main action method: clobber 13:19:08 INFO - rmtree: /builds/slave/test/build 13:19:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:19:09 INFO - Running post-action listener: _resource_record_post_action 13:19:09 INFO - ##### 13:19:09 INFO - ##### Running read-buildbot-config step. 13:19:09 INFO - ##### 13:19:09 INFO - Running pre-action listener: _resource_record_pre_action 13:19:09 INFO - Running main action method: read_buildbot_config 13:19:09 INFO - Using buildbot properties: 13:19:09 INFO - { 13:19:09 INFO - "project": "", 13:19:09 INFO - "product": "firefox", 13:19:09 INFO - "script_repo_revision": "production", 13:19:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:19:09 INFO - "repository": "", 13:19:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:19:09 INFO - "buildid": "20160531103942", 13:19:09 INFO - "pgo_build": "True", 13:19:09 INFO - "basedir": "/builds/slave/test", 13:19:09 INFO - "buildnumber": 319, 13:19:09 INFO - "slavename": "talos-linux64-ix-025", 13:19:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:19:09 INFO - "platform": "ubuntu64_hw", 13:19:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:19:09 INFO - "branch": "mozilla-aurora", 13:19:09 INFO - "repo_path": "releases/mozilla-aurora", 13:19:09 INFO - "revision": "9eebb2835273857468a80e0e89013673352a37e7", 13:19:09 INFO - "stage_platform": "linux64-pgo", 13:19:09 INFO - "builduid": "e71bbbe81f194a8996e2dd81575c8890", 13:19:09 INFO - "slavebuilddir": "test" 13:19:09 INFO - } 13:19:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 13:19:09 INFO - Running post-action listener: _resource_record_post_action 13:19:09 INFO - ##### 13:19:09 INFO - ##### Running download-and-extract step. 13:19:09 INFO - ##### 13:19:09 INFO - Running pre-action listener: _resource_record_pre_action 13:19:09 INFO - Running main action method: download_and_extract 13:19:09 INFO - mkdir: /builds/slave/test/build/tests 13:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:09 INFO - https://queue.taskcluster.net/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:19:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:19:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:19:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/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 13:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/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 13:19:10 INFO - Downloaded 1361 bytes. 13:19:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:19:10 INFO - Using the following test package requirements: 13:19:10 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:19:10 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:19:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:19:10 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:19:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:19:10 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:19:10 INFO - u'jsshell-linux-x86_64.zip'], 13:19:10 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:19:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:19:10 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:19:10 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:19:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:19:10 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:19:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:19:10 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:19:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:19:10 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:19:10 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:19:10 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:19: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')]} 13:19:10 INFO - https://queue.taskcluster.net/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:19:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:19:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:19:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/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 13:19:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/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 13:19:12 INFO - Downloaded 24174366 bytes. 13:19: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'] 13:19: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 13:19:13 INFO - Return code: 0 13:19: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 13:19: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')]} 13:19:13 INFO - https://queue.taskcluster.net/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:19:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:19:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:19:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/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 13:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/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 13:19:15 INFO - Downloaded 24174366 bytes. 13:19: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'] 13:19: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 13:19:16 INFO - Return code: 0 13:19: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')]} 13:19:16 INFO - https://queue.taskcluster.net/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:19:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:19:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:19:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/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 13:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/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 13:19:18 INFO - Downloaded 10840145 bytes. 13:19:18 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'] 13:19:18 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 13:19:18 INFO - Return code: 0 13:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:18 INFO - https://queue.taskcluster.net/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:19:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:19:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:19:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/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 13:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrDKI9HfQGuUJos8wYJlCw/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 13:19:21 INFO - Downloaded 62805729 bytes. 13:19:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:19:21 INFO - mkdir: /builds/slave/test/properties 13:19:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:19:21 INFO - Writing to file /builds/slave/test/properties/build_url 13:19:21 INFO - Contents: 13:19:21 INFO - build_url:https://queue.taskcluster.net/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:19:22 INFO - Running post-action listener: _resource_record_post_action 13:19:22 INFO - Running post-action listener: set_extra_try_arguments 13:19:22 INFO - ##### 13:19:22 INFO - ##### Running populate-webroot step. 13:19:22 INFO - ##### 13:19:22 INFO - Running pre-action listener: _resource_record_pre_action 13:19:22 INFO - Running main action method: populate_webroot 13:19:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:19:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:19:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:19:22 INFO - '--tppagecycles', 13:19:22 INFO - '7'], 13:19:22 INFO - 'tests': ['tsvgm']}}, 13:19:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:19:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:19:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:19:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:19:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:19:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:19:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:22 INFO - 'talos_options': ['--disable-e10s'], 13:19:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:22 INFO - 'talos_options': ['--disable-e10s'], 13:19:22 INFO - 'tests': ['damp', 'tps']}, 13:19:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:22 INFO - 'tests': ['damp', 'tps']}, 13:19:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:19:22 INFO - 'tests': ['dromaeo_dom']}, 13:19:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:19:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:19:22 INFO - 'tests': ['a11yr', 13:19:22 INFO - 'ts_paint', 13:19:22 INFO - 'tpaint', 13:19:22 INFO - 'sessionrestore', 13:19:22 INFO - 'sessionrestore_no_auto_restore', 13:19:22 INFO - 'tabpaint']}, 13:19:22 INFO - 'other-e10s': {'tests': ['a11yr', 13:19:22 INFO - 'ts_paint', 13:19:22 INFO - 'tpaint', 13:19:22 INFO - 'sessionrestore', 13:19:22 INFO - 'sessionrestore_no_auto_restore', 13:19:22 INFO - 'tabpaint']}, 13:19:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:19:22 INFO - 'ts_paint', 13:19:22 INFO - 'tpaint', 13:19:22 INFO - 'sessionrestore', 13:19:22 INFO - 'sessionrestore_no_auto_restore', 13:19:22 INFO - 'tabpaint']}, 13:19:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:19:22 INFO - 'ts_paint', 13:19:22 INFO - 'tpaint', 13:19:22 INFO - 'sessionrestore', 13:19:22 INFO - 'sessionrestore_no_auto_restore', 13:19:22 INFO - 'tabpaint']}, 13:19:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:19:22 INFO - 'tests': ['a11yr', 13:19:22 INFO - 'ts_paint', 13:19:22 INFO - 'tpaint', 13:19:22 INFO - 'sessionrestore', 13:19:22 INFO - 'sessionrestore_no_auto_restore', 13:19:22 INFO - 'tabpaint']}, 13:19:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:19:22 INFO - 'tests': ['a11yr', 13:19:22 INFO - 'ts_paint', 13:19:22 INFO - 'tpaint', 13:19:22 INFO - 'sessionrestore', 13:19:22 INFO - 'sessionrestore_no_auto_restore', 13:19:22 INFO - 'tabpaint']}, 13:19:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:19:22 INFO - 'tests': ['tsvgx', 13:19:22 INFO - 'tsvgr_opacity', 13:19:22 INFO - 'tart', 13:19:22 INFO - 'tscrollx', 13:19:22 INFO - 'cart']}, 13:19:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:19:22 INFO - 'tsvgr_opacity', 13:19:22 INFO - 'tart', 13:19:22 INFO - 'tscrollx', 13:19:22 INFO - 'cart']}, 13:19:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:22 INFO - 'talos_options': ['--disable-e10s'], 13:19:22 INFO - 'tests': ['tp5o']}, 13:19:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:22 INFO - 'tests': ['tp5o']}, 13:19:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:22 INFO - 'talos_options': ['--disable-e10s', 13:19:22 INFO - '--xperf_path', 13:19:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:22 INFO - 'tests': ['tp5n']}, 13:19:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:22 INFO - 'talos_options': ['--xperf_path', 13:19:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:22 INFO - 'tests': ['tp5n']}}, 13:19:22 INFO - 'talos.zip': {'path': '', 13:19:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:19:22 INFO - Running post-action listener: _resource_record_post_action 13:19:22 INFO - ##### 13:19:22 INFO - ##### Running create-virtualenv step. 13:19:22 INFO - ##### 13:19:22 INFO - Running pre-action listener: _resource_record_pre_action 13:19:22 INFO - Running main action method: create_virtualenv 13:19:22 INFO - Creating virtualenv /builds/slave/test/build/venv 13:19:22 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 13:19:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:19:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:19:22 INFO - Using real prefix '/usr' 13:19:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:19:23 INFO - Installing distribute.............................................................................................................................................................................................done. 13:19:25 INFO - Installing pip.................done. 13:19:25 INFO - Return code: 0 13:19:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adbc0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e1410>, '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 0x13e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e27a0>, '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': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', '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 13:19: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', 'pip>=1.5'] in /builds/slave/test/build 13:19: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 pip>=1.5 13:19:25 INFO - Using env: {'DISPLAY': ':0', 13:19:25 INFO - 'HOME': '/home/cltbld', 13:19:25 INFO - 'LANG': 'en_US.UTF-8', 13:19:25 INFO - 'LANGUAGE': 'en_US:en', 13:19:25 INFO - 'LOGNAME': 'cltbld', 13:19:25 INFO - 'MAIL': '/var/mail/cltbld', 13:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:25 INFO - 'MOZ_NO_REMOTE': '1', 13:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:25 INFO - 'NO_EM_RESTART': '1', 13:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:25 INFO - 'PWD': '/builds/slave/test', 13:19:25 INFO - 'SHELL': '/bin/bash', 13:19:25 INFO - 'SHLVL': '1', 13:19:25 INFO - 'TERM': 'linux', 13:19:25 INFO - 'TMOUT': '86400', 13:19:25 INFO - 'USER': 'cltbld', 13:19:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', 13:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:25 INFO - '_': '/tools/buildbot/bin/python'} 13:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:25 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 13:19:25 INFO - Cleaning up... 13:19:25 INFO - Return code: 0 13:19:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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', '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 0x7f9adbc0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e1410>, '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 0x13e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e27a0>, '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': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', '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 13:19: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', 'psutil>=0.7.1'] in /builds/slave/test/build 13:19: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 psutil>=0.7.1 13:19:25 INFO - Using env: {'DISPLAY': ':0', 13:19:25 INFO - 'HOME': '/home/cltbld', 13:19:25 INFO - 'LANG': 'en_US.UTF-8', 13:19:25 INFO - 'LANGUAGE': 'en_US:en', 13:19:25 INFO - 'LOGNAME': 'cltbld', 13:19:25 INFO - 'MAIL': '/var/mail/cltbld', 13:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:25 INFO - 'MOZ_NO_REMOTE': '1', 13:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:25 INFO - 'NO_EM_RESTART': '1', 13:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:25 INFO - 'PWD': '/builds/slave/test', 13:19:25 INFO - 'SHELL': '/bin/bash', 13:19:25 INFO - 'SHLVL': '1', 13:19:25 INFO - 'TERM': 'linux', 13:19:25 INFO - 'TMOUT': '86400', 13:19:25 INFO - 'USER': 'cltbld', 13:19:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', 13:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:25 INFO - '_': '/tools/buildbot/bin/python'} 13:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:25 INFO - Downloading/unpacking psutil>=0.7.1 13:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:27 INFO - Installing collected packages: psutil 13:19:27 INFO - Running setup.py install for psutil 13:19:27 INFO - building 'psutil._psutil_linux' extension 13:19:27 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 13:19:27 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 13:19:27 INFO - building 'psutil._psutil_posix' extension 13:19:27 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 13:19:28 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 13:19:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:28 INFO - Successfully installed psutil 13:19:28 INFO - Cleaning up... 13:19:28 INFO - Return code: 0 13:19:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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', '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 0x7f9adbc0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e1410>, '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 0x13e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e27a0>, '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': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', '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 13:19: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:19: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 mozsystemmonitor==0.0.0 13:19:28 INFO - Using env: {'DISPLAY': ':0', 13:19:28 INFO - 'HOME': '/home/cltbld', 13:19:28 INFO - 'LANG': 'en_US.UTF-8', 13:19:28 INFO - 'LANGUAGE': 'en_US:en', 13:19:28 INFO - 'LOGNAME': 'cltbld', 13:19:28 INFO - 'MAIL': '/var/mail/cltbld', 13:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:28 INFO - 'MOZ_NO_REMOTE': '1', 13:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:28 INFO - 'NO_EM_RESTART': '1', 13:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:28 INFO - 'PWD': '/builds/slave/test', 13:19:28 INFO - 'SHELL': '/bin/bash', 13:19:28 INFO - 'SHLVL': '1', 13:19:28 INFO - 'TERM': 'linux', 13:19:28 INFO - 'TMOUT': '86400', 13:19:28 INFO - 'USER': 'cltbld', 13:19:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', 13:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:28 INFO - '_': '/tools/buildbot/bin/python'} 13:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:19:30 INFO - Installing collected packages: mozsystemmonitor 13:19:30 INFO - Running setup.py install for mozsystemmonitor 13:19:30 INFO - Successfully installed mozsystemmonitor 13:19:30 INFO - Cleaning up... 13:19:30 INFO - Return code: 0 13:19:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9adbc0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e1410>, '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 0x13e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e27a0>, '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': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', '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 13:19:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:19:30 INFO - Using env: {'DISPLAY': ':0', 13:19:30 INFO - 'HOME': '/home/cltbld', 13:19:30 INFO - 'LANG': 'en_US.UTF-8', 13:19:30 INFO - 'LANGUAGE': 'en_US:en', 13:19:30 INFO - 'LOGNAME': 'cltbld', 13:19:30 INFO - 'MAIL': '/var/mail/cltbld', 13:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:30 INFO - 'MOZ_NO_REMOTE': '1', 13:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:30 INFO - 'NO_EM_RESTART': '1', 13:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:30 INFO - 'PWD': '/builds/slave/test', 13:19:30 INFO - 'SHELL': '/bin/bash', 13:19:30 INFO - 'SHLVL': '1', 13:19:30 INFO - 'TERM': 'linux', 13:19:30 INFO - 'TMOUT': '86400', 13:19:30 INFO - 'USER': 'cltbld', 13:19:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', 13:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:30 INFO - '_': '/tools/buildbot/bin/python'} 13:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:32 INFO - Downloading blobuploader-1.2.4.tar.gz 13:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:19:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:19:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:33 INFO - Downloading docopt-0.6.1.tar.gz 13:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:19:33 INFO - Installing collected packages: blobuploader, requests, docopt 13:19:33 INFO - Running setup.py install for blobuploader 13:19:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:19:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:19:33 INFO - Running setup.py install for requests 13:19:33 INFO - Running setup.py install for docopt 13:19:33 INFO - Successfully installed blobuploader requests docopt 13:19:33 INFO - Cleaning up... 13:19:33 INFO - Return code: 0 13:19:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:33 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 0x7f9adbc0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e1410>, '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 0x13e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e27a0>, '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': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', '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 13:19:33 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 13:19:33 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 13:19:33 INFO - Using env: {'DISPLAY': ':0', 13:19:33 INFO - 'HOME': '/home/cltbld', 13:19:33 INFO - 'LANG': 'en_US.UTF-8', 13:19:33 INFO - 'LANGUAGE': 'en_US:en', 13:19:33 INFO - 'LOGNAME': 'cltbld', 13:19:33 INFO - 'MAIL': '/var/mail/cltbld', 13:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:33 INFO - 'MOZ_NO_REMOTE': '1', 13:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:33 INFO - 'NO_EM_RESTART': '1', 13:19:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:33 INFO - 'PWD': '/builds/slave/test', 13:19:33 INFO - 'SHELL': '/bin/bash', 13:19:33 INFO - 'SHLVL': '1', 13:19:33 INFO - 'TERM': 'linux', 13:19:33 INFO - 'TMOUT': '86400', 13:19:33 INFO - 'USER': 'cltbld', 13:19:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', 13:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:33 INFO - '_': '/tools/buildbot/bin/python'} 13:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:34 INFO - Running setup.py (path:/tmp/pip-OlXhWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:34 INFO - Running setup.py (path:/tmp/pip-0B5jZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:34 INFO - Running setup.py (path:/tmp/pip-IfjxXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:34 INFO - Running setup.py (path:/tmp/pip-UKzji5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:34 INFO - Running setup.py (path:/tmp/pip-fNSpwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:34 INFO - Running setup.py (path:/tmp/pip-goV93u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:34 INFO - Running setup.py (path:/tmp/pip-a7t5Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:34 INFO - Running setup.py (path:/tmp/pip-sn3Dp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:34 INFO - Running setup.py (path:/tmp/pip-1F62JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:34 INFO - Running setup.py (path:/tmp/pip-BAMnNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:34 INFO - Running setup.py (path:/tmp/pip-NiPGJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:34 INFO - Running setup.py (path:/tmp/pip-hnGuuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:35 INFO - Running setup.py (path:/tmp/pip-Bo7u9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:35 INFO - Running setup.py (path:/tmp/pip-Nnh5hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:35 INFO - Running setup.py (path:/tmp/pip-tX6FMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:35 INFO - Running setup.py (path:/tmp/pip-OGI4Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:35 INFO - Running setup.py (path:/tmp/pip-nAK0kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:19:35 INFO - Running setup.py install for manifestparser 13:19:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:19:35 INFO - Running setup.py install for mozcrash 13:19:35 INFO - Running setup.py install for mozdebug 13:19:35 INFO - Running setup.py install for mozdevice 13:19:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:19:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:19:35 INFO - Running setup.py install for mozfile 13:19:35 INFO - Running setup.py install for mozhttpd 13:19:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Running setup.py install for mozinfo 13:19:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Running setup.py install for mozInstall 13:19:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Running setup.py install for mozleak 13:19:36 INFO - Running setup.py install for mozlog 13:19:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Running setup.py install for moznetwork 13:19:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Running setup.py install for mozprocess 13:19:36 INFO - Running setup.py install for mozprofile 13:19:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Running setup.py install for mozrunner 13:19:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:19:36 INFO - Running setup.py install for mozscreenshot 13:19:36 INFO - Running setup.py install for moztest 13:19:37 INFO - Running setup.py install for mozversion 13:19:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:19:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:19:37 INFO - Cleaning up... 13:19:37 INFO - Return code: 0 13:19:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:37 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')]} 13:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:37 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')]} 13:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:37 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 0x7f9adbc0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e1410>, '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 0x13e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e27a0>, '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': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', '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 13:19:37 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 13:19:37 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 13:19:37 INFO - Using env: {'DISPLAY': ':0', 13:19:37 INFO - 'HOME': '/home/cltbld', 13:19:37 INFO - 'LANG': 'en_US.UTF-8', 13:19:37 INFO - 'LANGUAGE': 'en_US:en', 13:19:37 INFO - 'LOGNAME': 'cltbld', 13:19:37 INFO - 'MAIL': '/var/mail/cltbld', 13:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:37 INFO - 'MOZ_NO_REMOTE': '1', 13:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:37 INFO - 'NO_EM_RESTART': '1', 13:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:37 INFO - 'PWD': '/builds/slave/test', 13:19:37 INFO - 'SHELL': '/bin/bash', 13:19:37 INFO - 'SHLVL': '1', 13:19:37 INFO - 'TERM': 'linux', 13:19:37 INFO - 'TMOUT': '86400', 13:19:37 INFO - 'USER': 'cltbld', 13:19:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', 13:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:37 INFO - '_': '/tools/buildbot/bin/python'} 13:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:37 INFO - Running setup.py (path:/tmp/pip-pxdIgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:37 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)) 13:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:37 INFO - Running setup.py (path:/tmp/pip-zjne0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:37 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)) 13:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:37 INFO - Running setup.py (path:/tmp/pip-kgZlOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:37 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)) 13:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:37 INFO - Running setup.py (path:/tmp/pip-mzlavV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:37 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)) 13:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:37 INFO - Running setup.py (path:/tmp/pip-6JVD4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:37 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)) 13:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:37 INFO - Running setup.py (path:/tmp/pip-b1f7PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:37 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)) 13:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:37 INFO - Running setup.py (path:/tmp/pip-FjbG8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:37 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)) 13:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:37 INFO - Running setup.py (path:/tmp/pip-ZhH4MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:37 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)) 13:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:37 INFO - Running setup.py (path:/tmp/pip-NfiUPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:38 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)) 13:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:38 INFO - Running setup.py (path:/tmp/pip-Twf53B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:38 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)) 13:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:38 INFO - Running setup.py (path:/tmp/pip-hqtxcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:38 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)) 13:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:38 INFO - Running setup.py (path:/tmp/pip-ckBKpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:38 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)) 13:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:38 INFO - Running setup.py (path:/tmp/pip-MeFqqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:38 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)) 13:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:38 INFO - Running setup.py (path:/tmp/pip-O3To5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:38 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)) 13:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:38 INFO - Running setup.py (path:/tmp/pip-CWn7SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:38 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)) 13:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:38 INFO - Running setup.py (path:/tmp/pip-yqtQug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:38 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)) 13:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:38 INFO - Running setup.py (path:/tmp/pip-djsyZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:38 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)) 13:19:38 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)) 13:19:38 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)) 13:19:38 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)) 13:19:38 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)) 13:19:38 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)) 13:19:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:40 INFO - Downloading blessings-1.6.tar.gz 13:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:19:40 INFO - Installing collected packages: blessings 13:19:40 INFO - Running setup.py install for blessings 13:19:40 INFO - Successfully installed blessings 13:19:40 INFO - Cleaning up... 13:19:40 INFO - Return code: 0 13:19:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:19:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:40 INFO - Reading from file tmpfile_stdout 13:19:40 INFO - Current package versions: 13:19:40 INFO - argparse == 1.2.1 13:19:40 INFO - blessings == 1.6 13:19:40 INFO - blobuploader == 1.2.4 13:19:40 INFO - docopt == 0.6.1 13:19:40 INFO - manifestparser == 1.1 13:19:40 INFO - mozInstall == 1.12 13:19:40 INFO - mozcrash == 0.17 13:19:40 INFO - mozdebug == 0.1 13:19:40 INFO - mozdevice == 0.48 13:19:40 INFO - mozfile == 1.2 13:19:40 INFO - mozhttpd == 0.7 13:19:40 INFO - mozinfo == 0.9 13:19:40 INFO - mozleak == 0.1 13:19:40 INFO - mozlog == 3.1 13:19:40 INFO - moznetwork == 0.27 13:19:40 INFO - mozprocess == 0.22 13:19:40 INFO - mozprofile == 0.28 13:19:40 INFO - mozrunner == 6.11 13:19:40 INFO - mozscreenshot == 0.1 13:19:40 INFO - mozsystemmonitor == 0.0 13:19:40 INFO - moztest == 0.7 13:19:40 INFO - mozversion == 1.4 13:19:40 INFO - psutil == 3.1.1 13:19:40 INFO - requests == 1.2.3 13:19:40 INFO - wsgiref == 0.1.2 13:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:40 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 0x7f9adbc0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e1410>, '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 0x13e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e27a0>, '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': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', '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 13:19:40 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 13:19:40 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 13:19:40 INFO - Using env: {'DISPLAY': ':0', 13:19:40 INFO - 'HOME': '/home/cltbld', 13:19:40 INFO - 'LANG': 'en_US.UTF-8', 13:19:40 INFO - 'LANGUAGE': 'en_US:en', 13:19:40 INFO - 'LOGNAME': 'cltbld', 13:19:40 INFO - 'MAIL': '/var/mail/cltbld', 13:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:40 INFO - 'MOZ_NO_REMOTE': '1', 13:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:40 INFO - 'NO_EM_RESTART': '1', 13:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:40 INFO - 'PWD': '/builds/slave/test', 13:19:40 INFO - 'SHELL': '/bin/bash', 13:19:40 INFO - 'SHLVL': '1', 13:19:40 INFO - 'TERM': 'linux', 13:19:40 INFO - 'TMOUT': '86400', 13:19:40 INFO - 'USER': 'cltbld', 13:19:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', 13:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:40 INFO - '_': '/tools/buildbot/bin/python'} 13:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:41 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)) 13:19:41 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)) 13:19:41 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)) 13:19:41 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)) 13:19:41 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)) 13:19:41 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)) 13:19:41 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)) 13:19:41 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)) 13:19:41 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)) 13:19:41 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)) 13:19:41 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)) 13:19:41 INFO - Cleaning up... 13:19:41 INFO - Return code: 0 13:19:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adbc0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e1410>, '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 0x13e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e27a0>, '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': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', '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 13:19: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', 'jsonschema'] in /builds/slave/test/build 13:19: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 jsonschema 13:19:41 INFO - Using env: {'DISPLAY': ':0', 13:19:41 INFO - 'HOME': '/home/cltbld', 13:19:41 INFO - 'LANG': 'en_US.UTF-8', 13:19:41 INFO - 'LANGUAGE': 'en_US:en', 13:19:41 INFO - 'LOGNAME': 'cltbld', 13:19:41 INFO - 'MAIL': '/var/mail/cltbld', 13:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:41 INFO - 'MOZ_NO_REMOTE': '1', 13:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:41 INFO - 'NO_EM_RESTART': '1', 13:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:41 INFO - 'PWD': '/builds/slave/test', 13:19:41 INFO - 'SHELL': '/bin/bash', 13:19:41 INFO - 'SHLVL': '1', 13:19:41 INFO - 'TERM': 'linux', 13:19:41 INFO - 'TMOUT': '86400', 13:19:41 INFO - 'USER': 'cltbld', 13:19:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', 13:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:41 INFO - '_': '/tools/buildbot/bin/python'} 13:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:41 INFO - Downloading/unpacking jsonschema 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:19:43 INFO - Downloading/unpacking functools32 (from jsonschema) 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:43 INFO - Downloading functools32-3.2.3-2.tar.gz 13:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:19:43 INFO - warning: no files found matching '*.txt' 13:19:43 INFO - no previously-included directories found matching 'build' 13:19:43 INFO - no previously-included directories found matching 'dist' 13:19:43 INFO - no previously-included directories found matching '.git*' 13:19:43 INFO - Installing collected packages: jsonschema, functools32 13:19:43 INFO - Running setup.py install for functools32 13:19:43 INFO - warning: no files found matching '*.txt' 13:19:43 INFO - no previously-included directories found matching 'build' 13:19:43 INFO - no previously-included directories found matching 'dist' 13:19:43 INFO - no previously-included directories found matching '.git*' 13:19:43 INFO - Successfully installed jsonschema functools32 13:19:43 INFO - Cleaning up... 13:19:43 INFO - Return code: 0 13:19:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:43 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 0x7f9adbc0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e1410>, '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 0x13e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e27a0>, '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': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', '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 13:19:43 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 13:19:43 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 13:19:43 INFO - Using env: {'DISPLAY': ':0', 13:19:43 INFO - 'HOME': '/home/cltbld', 13:19:43 INFO - 'LANG': 'en_US.UTF-8', 13:19:43 INFO - 'LANGUAGE': 'en_US:en', 13:19:43 INFO - 'LOGNAME': 'cltbld', 13:19:43 INFO - 'MAIL': '/var/mail/cltbld', 13:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:43 INFO - 'MOZ_NO_REMOTE': '1', 13:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:43 INFO - 'NO_EM_RESTART': '1', 13:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:43 INFO - 'PWD': '/builds/slave/test', 13:19:43 INFO - 'SHELL': '/bin/bash', 13:19:43 INFO - 'SHLVL': '1', 13:19:43 INFO - 'TERM': 'linux', 13:19:43 INFO - 'TMOUT': '86400', 13:19:43 INFO - 'USER': 'cltbld', 13:19:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', 13:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:43 INFO - '_': '/tools/buildbot/bin/python'} 13:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:43 INFO - Downloading/unpacking flake8 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:19:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:19:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:19:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:19:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:19:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:19:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:19:46 INFO - no previously-included directories found matching 'docs/_build' 13:19:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:19:46 INFO - Running setup.py install for pep8 13:19:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:19:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:19:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:19:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:19:46 INFO - no previously-included directories found matching 'docs/_build' 13:19:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:19:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:19:46 INFO - Cleaning up... 13:19:46 INFO - Return code: 0 13:19:46 INFO - Running post-action listener: _resource_record_post_action 13:19:46 INFO - Running post-action listener: _start_resource_monitoring 13:19:46 INFO - Starting resource monitoring. 13:19:46 INFO - ##### 13:19:46 INFO - ##### Running install step. 13:19:46 INFO - ##### 13:19:46 INFO - Running pre-action listener: _resource_record_pre_action 13:19:46 INFO - Running main action method: install 13:19:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:47 INFO - Reading from file tmpfile_stdout 13:19:47 INFO - Detecting whether we're running mozinstall >=1.0... 13:19:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:19:47 INFO - Reading from file tmpfile_stdout 13:19:47 INFO - Output received: 13:19:47 INFO - Usage: mozinstall [options] installer 13:19:47 INFO - Options: 13:19:47 INFO - -h, --help show this help message and exit 13:19:47 INFO - -d DEST, --destination=DEST 13:19:47 INFO - Directory to install application into. [default: 13:19:47 INFO - "/builds/slave/test"] 13:19:47 INFO - --app=APP Application being installed. [default: firefox] 13:19:47 INFO - mkdir: /builds/slave/test/build/application 13:19:47 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'] 13:19:47 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 13:20:02 INFO - Reading from file tmpfile_stdout 13:20:02 INFO - Output received: 13:20:02 INFO - /builds/slave/test/build/application/firefox/firefox 13:20:02 INFO - Running post-action listener: _resource_record_post_action 13:20:02 INFO - ##### 13:20:02 INFO - ##### Running run-tests step. 13:20:02 INFO - ##### 13:20:02 INFO - Running pre-action listener: _resource_record_pre_action 13:20:02 INFO - Running main action method: run_tests 13:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:20:02 INFO - Python 2.7.3 13:20:02 INFO - Return code: 0 13:20:02 INFO - grabbing minidump binary from tooltool 13:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:02 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 0x13e1410>, '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 0x13e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:20:02 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 13:20:02 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 13:20:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:20:02 INFO - Return code: 0 13:20:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:20:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:20:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:20:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:20:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:20:03 INFO - Return code: 0 13:20:03 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/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 13:20:03 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/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 13:20:03 INFO - Using env: {'DISPLAY': ':0', 13:20:03 INFO - 'HOME': '/home/cltbld', 13:20:03 INFO - 'LANG': 'en_US.UTF-8', 13:20:03 INFO - 'LANGUAGE': 'en_US:en', 13:20:03 INFO - 'LOGNAME': 'cltbld', 13:20:03 INFO - 'MAIL': '/var/mail/cltbld', 13:20:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:20:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:03 INFO - 'MOZ_NO_REMOTE': '1', 13:20:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:03 INFO - 'NO_EM_RESTART': '1', 13:20:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:03 INFO - 'PWD': '/builds/slave/test', 13:20:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:20:03 INFO - 'SHELL': '/bin/bash', 13:20:03 INFO - 'SHLVL': '1', 13:20:03 INFO - 'TERM': 'linux', 13:20:03 INFO - 'TMOUT': '86400', 13:20:03 INFO - 'USER': 'cltbld', 13:20:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464725689.321902-180437406', 13:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:03 INFO - '_': '/tools/buildbot/bin/python'} 13:20:03 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/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 13:20:03 INFO - mozversion application_buildid: 20160531103942 13:20:03 INFO - mozversion application_changeset: 9eebb2835273857468a80e0e89013673352a37e7 13:20:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:20:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:20:03 INFO - mozversion application_name: Firefox 13:20:03 INFO - mozversion application_remotingname: firefox-dev 13:20:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:20:03 INFO - mozversion application_vendor: Mozilla 13:20:03 INFO - mozversion application_version: 48.0a2 13:20:03 INFO - mozversion platform_buildid: 20160531103942 13:20:03 INFO - mozversion platform_changeset: 9eebb2835273857468a80e0e89013673352a37e7 13:20:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:20:03 INFO - mozversion platform_version: 48.0a2 13:20:03 INFO - using testdate: 1464726003 13:20:03 INFO - actual date: 1464726003 13:20:03 INFO - starting webserver on 'localhost:42286' 13:20:03 INFO - SUITE-START | Running 2 tests 13:20:03 INFO - TEST-START | dromaeo_css 13:20:03 INFO - operating with platform_type : linux_ 13:20:03 INFO - Initialising browser for dromaeo_css test... 13:20:03 INFO - TEST-INFO | started process 13764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ7oGDj/profile http://localhost:42286/getInfo.html) 13:20:07 INFO - PROCESS | 13764 | 13:20:07 INFO - PROCESS | 13764 | (process:13840): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:20:08 INFO - PROCESS | 13764 | __metrics Screen width/height:1600/1200 13:20:08 INFO - PROCESS | 13764 | colorDepth:24 13:20:08 INFO - PROCESS | 13764 | Browser inner width/height: 1024/697 13:20:08 INFO - PROCESS | 13764 | __metrics 13:20:09 ERROR - PROCESS | 13764 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 13:20:09 INFO - TEST-INFO | 13764: exit 0 13:20:09 INFO - Browser initialized. 13:20:09 INFO - Running cycle 1/1 for dromaeo_css test... 13:20:09 INFO - TEST-INFO | started process 13891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ7oGDj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:11 INFO - PROCESS | 13891 | 13:20:11 INFO - PROCESS | 13891 | (process:13964): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:20:21 INFO - PROCESS | 13891 | RSS: Main: 151805952 13:20:21 INFO - PROCESS | 13891 | 13:21:11 INFO - PROCESS | 13891 | 1464726071386 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] 13:23:19 INFO - PROCESS | 13891 | Cycle 1(1): loaded http://localhost:42286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42286/tests/dromaeo/cssquery-ext.html) 13:23:20 INFO - PROCESS | 13891 | RSS: Main: 155426816 13:23:20 INFO - PROCESS | 13891 | 13:26:22 INFO - PROCESS | 13891 | Cycle 1(1): loaded http://localhost:42286/tests/dromaeo/cssquery-ext.html (next: http://localhost:42286/tests/dromaeo/cssquery-jquery.html) 13:26:22 INFO - PROCESS | 13891 | RSS: Main: 152985600 13:26:22 INFO - PROCESS | 13891 | 13:29:24 INFO - PROCESS | 13891 | Cycle 1(1): loaded http://localhost:42286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42286/tests/dromaeo/cssquery-mootools.html) 13:29:24 INFO - PROCESS | 13891 | RSS: Main: 153231360 13:29:24 INFO - PROCESS | 13891 | 13:32:26 INFO - PROCESS | 13891 | Cycle 1(1): loaded http://localhost:42286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42286/tests/dromaeo/cssquery-prototype.html) 13:32:27 INFO - PROCESS | 13891 | RSS: Main: 152911872 13:32:27 INFO - PROCESS | 13891 | 13:35:29 INFO - PROCESS | 13891 | Cycle 1(1): loaded http://localhost:42286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42286/tests/dromaeo/cssquery-yui.html) 13:35:30 INFO - PROCESS | 13891 | RSS: Main: 154595328 13:35:30 INFO - PROCESS | 13891 | 13:38:32 INFO - PROCESS | 13891 | Cycle 1(1): loaded http://localhost:42286/tests/dromaeo/cssquery-yui.html (next: http://localhost:42286/tests/dromaeo/cssquery-dojo.html) 13:38:32 INFO - PROCESS | 13891 | RSS: Main: 156082176 13:38:32 INFO - PROCESS | 13891 | 13:38:32 INFO - PROCESS | 13891 | __start_tp_report 13:38:32 INFO - PROCESS | 13891 | _x_x_mozilla_page_load 13:38:32 INFO - PROCESS | 13891 | _x_x_mozilla_page_load_details 13:38:32 INFO - PROCESS | 13891 | |i|pagename|runs| 13:38:32 INFO - PROCESS | 13891 | |0;dojo.html;3377.4933759936007;3399.5580574525306;3448.086257141857;3466.272082862599;3468.5664291963503;5748.971255143723;5767.798127065554;5787.450192231742;5795;5812.273465816773;5789.247397838275;5804.564657650682;5805.260268503277;5826.359100498952;5834;5230.92153617696;5249.291345668324;5306.628536002481;5325.840224793263;5332.413434522199;5015.072211640858;5325.760340784674;5429.945700543003;5432.83701488954;5446.400895901447;5109.770060347293;5223.529882310591;5224.817131400402;5260.395054568736;5269.525742683158;5241.449647786984;5288.68267903927;5299.152135658295;5312.468753124656;5320.787168513255;5219.399769026534;5222.973885130588;5234.790608375661;5273.209018647233;5285.682859028432;5437.483439073281;5471.042567550702;5573.8606534836545;5619.522340601013;5636.408177141423;6159.23009623797;6161.661108639023;6169.9383006170265;6175.7529698811995;6181.3818618138275;6198.411150940653;6198.659073750942;6203.2556093269095;6208.286047104596;6217.782377616807;5646.971765141189;5721.599488035798;5742.081266997302;5766.077427611562;5791.189233507313;6265.780697675559;6275.435210831047;6298.02380631003;6309.432151106423;6323.36766323364;5968.820935371946;6049;6065.454109130112;6066.029435290332;6074.301455332693;6084.4828189603495;6121.296050954108;6125.662799505688;6130.459285710702;6140.140380346755;6065.60573562717;6104.755809767648;6107.328193898757;6109.083637454329;6137.754489820447;5891.23413956183;6023.066424704178;6034.39656034393;6078.422549857756;6113.908291375633;4601.861944141681;4607.424071991001;4618.49196588375;4623.075384922961;4633.212353899845;4128.731632443882;4130.648894843912;4133.751974881457;4136.91726165475;4178.686598505064;5747.770089196385;5830.387809279964;5844.6785426801935;5859.736311865976;5890.49930755882;5992.161097446361;6144.600600960924;6193.071039344134;6213.844653883599;6214.1921550198185;5925.081612350093;5925.4370834770625;5929.347771745104;5930.11048342752;5964.850878728066;5160;5233.816816411408;5288.206768984683;5297.073012222845;5316.601254905898;6265.686715664289;6317.4946004319545;6323.114763933053;6345.206849143857;6356.618602883842;6052;6129.601575897642;6135.539834512519;6146.170267014075;6153.953827849366;6274;6362.745490180526;6374.521910856797;6374.90437643445;6376.489880809617;6001.90997135052;6016.2479690038745;6022.337542870368;6022.518198544193;6030.939690603038;5947.702614869326;6063.818085457443;6138.570300078952;6143.6928153593035;6144.262688477412;6017.939820601738;6064.363241859542;6074.119252708244;6079.878402431838;6112.663803490851;5993;6012.098185272244;6037.426444487766;6041.848953776191;6056.57603967718;5745.798897038583;5795.188673585617;5860.208871802252;5866.50134738552;5962.314333851489;5892;5924.940750592611;5950.523958083257;5959.523238141025;5991.221141251609;5847.26909136358;5848.64908105515;5855.414458554111;5860.794872179454;5866.149408335853 13:38:32 INFO - PROCESS | 13891 | |1;ext.html;623.5105442227849;649.0685865782601;654.2182092399579;659.6174218953008;685.6023506366308;38166.42750358743;39142.21715565691;39347.80326098369;39371.60628393715;39377.8031109844;42497;42978.57021429785;43051.35422968658;43081;43096.3535546967;8715.825683486342;8901.421407608517;8914.28685705142;8918.375713700043;8919.643214271453;8676.392652514327;8778.297736181123;8780.25367843734;8842.46945183291;8903.243224325908;8798.956005219998;8828.426152300111;8828.779280517974;8848.115188481133;8856.601452934601;8861.601227944759;8874.778130546756;8916.687915922976;8931.821363572724;8961.910380896174;8993.820123597558;9124;9124.771880702969;9136.08639136081;9141.634334626608;43300.78349608232;43798.12403751939;44044.33933491;44137;44213.77893110546;3842.6541611254843;3930.4693866327966;3950.32844416447;4028.3756017817286;4222.831086756526;32809.3438131236;33006;33052.504212436834;33139.50290745641;34581;4519.887002824923;4598.655100867449;4607.815687372501;4731.33761273422;4773.618110551148;302750;304643;305367;305616.9999999978;305984;38785.61214387877;39519.40720889189;39574.406383904265;39788.801055995114;59467.702661486415;37359.626403735616;37517.437238441446;37762.244755104744;37803.810980944916;37888.62111378851;16823.83176168247;16987.830121698626;16988.57528561771;16998.320067197175;17013.57466063358;13759.10565813219;13840.653983650489;13922.651933701738;13969.930150349182;13972.091814032055;9325.114114159143;9367.437953722798;9491.572879220314;9532.475713835667;9538.52307384628;3643.690286325692;3677.154254521475;3721.9441708374397;3742.045778326509;3760.247950409874;1072.940988245654;1121.9439028048564;1123.1360031918575;1206.6500714792787;1226.1600803449664;33061.504077438854;33304.66695333064;33986.660133398844;34135;34892.30215395678;1116.391566596207;1164.980641938304;1168.39243593331;1205.198542968916;1257.6730050186834;15281;15632.374705011673;15708.764368534481;15786.763198552031;15928.522144335688;476066;547388;577432;578887;580021;56633.7168314164;57620.42379576234;57749.42250577525;57871;57979.71010144922;1480.2302802542617;1512.6747749233969;1513.1526345246698;1524.3064405695604;1605.9437919672755;30074.54888176723;30762.520754342568;31278.687213128487;32618;33340.333193335515;52155;60997.69501152466;62157;62584.37415625968;62635;446005;448754;450954;452035;452493;45976.08047839091;46129.538704613864;46392.30411543762;46831.53168468408;47658.285125723836;50344.49655503545;50478.49521504738;51149.23276150786;51299;52350;42492.78753606212;42521.78739106285;42610.36084458797;42976.57023429726;43993;41516.58483415127;42043.57956420519;42551.36172957346;43004;43919.56080439155;43627;44545.33182002338;44744.55255447404;44949.77525112354;45098.09803803971;36538.8173059133;37165.81417092897;37730.62269377271;38664.226715466095;38731.6126838728;29368.706312936596;29555.915656782003;29558.40883182367;29816.552751709176;30154.24614384658 13:38:32 INFO - PROCESS | 13891 | |2;jquery.html;429.22524842659;433.45384815132934;439.11956527163034;442.8943691975388;454.8203459633445;18296.908515457406;18656.62686746264;19397.41807745768;20175.798242017576;20219.696704549442;19387.127579258933;19668.803311966876;19833.305834295803;20032.399028029184;20247.797522024775;5748.511376533;5769.7115144242825;5975.25309336333;5975.820725378224;6009.429104235112;5919.112133180014;5933.228680271559;5972.19375384324;5978.940210597903;5983.1025346197985;5647.124695672177;5751.338596061444;5772.191893134944;5787.13193021046;5921.585489015771;5785.768569257225;5801.767929282823;5804.65172089676;5829.446202610745;5830.183774271605;5263.236830659533;5279.208118782175;5328.280682107943;5334.733263336818;5348.465153484621;22957.311280661608;23476.295711128692;23716.881415592983;24195.51608967811;24367.878160609085;2503.5243303772227;2648.841069535834;2751.6285301484445;2942.6615939167054;3057.1287183152917;14685.853141468555;14866.628334291621;14880.404783808635;15048.247587620575;15441.845581544154;2045.9693104603443;2069.4722845674405;2097.444177293003;2109.831213502916;2128.287023847013;76163.61918190429;76489.61755191188;76755;78145;78766.60616696937;10654.147668186526;10975.176861735401;11390.316581005167;11700.824487632692;11906.46420911061;14879.628009299855;14959.401623935139;15010.47463338778;15077.849221507864;15203.771943420857;8029.478083924526;8272.627731751965;8372.916270837213;8374.748757537283;8446.775217593415;8113.675452981933;8207.630656620466;8229.79425514367;8245.422820402635;8254.092049874509;4588.816447342069;4620.2607582786595;4652.813887444532;4681.882952926204;4718.3158442025715;2100.653392190302;2156.967645485319;2160.805527502532;2163.1455575047767;2187.55155193185;1061.5256693038878;1092.126298960828;1116.7598966222301;1134.5745345495438;1168.3165348271357;19019.239230430627;19389;19443.8055619442;19468;19475.220991160477;1072.6942821295893;1080.8756992945912;1081.551156270139;1095.39753135775;1104.3042882983668;10838.566457341618;10938.726531836608;11252.099832013582;11283.959806475623;11516.193866429438;494977;503178;521030;525349;531467;76821;96293;97146;99887;102366;1166.03801863463;1179.1981452612306;1186.128195776104;1213.1447329632765;1243.5823161595788;17849.708212483358;17921.37275195362;17933.193006314486;18112.45662630123;18258.26966921308;40414.79792601018;40954;41132;41221.58778412177;42117.78941105397;58645.70677146587;59702.70148649229;60618;60695;61160.38839611547;9029.638814447611;9065.81868362616;9230.953845230732;9244.352895297265;9314.813703726024;10199.031092046243;13312.001599880241;13377.866221337663;13449.731005379643;13756.380962856896;12082.939585302018;12124.393780310773;12171.634850954486;12209.816852747039;12432.627021189379;11212.15908806859;11648.708782280512;11960.700982475508;12004.579839705917;12183.695407614527;11846.526138954345;12019.939900300442;12080.21478603888;12187.939060304641;12305.384730763604;8709.91290087091;8973.775655608662;9123.908760912305;9181.357304988587;9313.25493960468;10682.412467314061;11197.888021119685;11209.663710088711;11337.603183888525;11844.348560829238 13:38:32 INFO - PROCESS | 13891 | |3;mootools.html;1532.1573134775872;1540.3838464614157;1796.146830255628;1936.061010409951;1947.4936516505704;7371.668274927628;8173.5504547249875;8373.958130209348;8577;8584.22741953224;8445.324374050077;8456.408051436401;8495.617697203625;8521;8532.360072994536;2275.6472746724285;2292.151903795598;2294;2298.8735619540917;2305.988470057656;2223.9110435582556;2251.797338239558;2253.6844841722173;2270.0579259607325;2271.5002699406186;2364.302530753423;2365.8462199957034;2382.976170238293;2384.9761502385013;2397.352714767012;2323.8605683659034;2324.651302304651;2327.511222643247;2333.708286464192;2335.322756400642;2324.488612505263;2345;2345.0854166874933;2355.4464700795297;2358.7877091061887;8647.135286471366;8729.738107856774;8787.472751634858;8794.912050879473;8810;5419.376771671269;5500.477454641803;5523.4752698493985;5535.197396377503;5551.77792888284;3422.4524076147695;3478.513008178857;3530.8411121499594;3580.051286409104;3590.335787879251;1121.2823792772633;1124.746931940315;1130.2596799096605;1160.628598848369;1162.5001249462728;12128.57549985755;12138.08964327679;12194.390280486028;12206.938965305117;12233.143679942408;4612.285095810154;4698.506656801055;4742.454617718938;4769.046190761862;4867.659263851568;10443.268971171945;10449.477526123663;10468.214883883738;10511.789764204826;10515.84226236607;5336.279602253724;5338.733063346817;5352.839414817562;5393.83818485446;5411.864703382447;4217.240896638635;4832.130216560982;4916.926246106311;4935.802567897315;4968.1554135797005;4048.4534587830854;4151.066010147692;4214.683898707548;4251.893702657397;4268.509121451011;1330.082243252153;1335.3590276667255;1344.3211178354868;1347.5553067487901;1370.0272806307632;893.5085702863529;899.2940541674753;989.5744829723144;1023.65195833417;1035.984460233097;5686.658800471902;5698.900159958699;5731.168980497888;5771.9711401443565;5809.302883653989;1078.5577913055608;1115.5816568786704;1147.7761836441814;1150.4535345710888;1168.281506873284;3892.6691231245095;3969.980150099231;4027.0737730321603;4028.597140285948;4086.591340865949;10305.072543471124;10627.734306642242;10642.04221620058;10755.731106722238;10832.512536935857;10432.634857779942;10500.159987201005;10508.894911050944;10604.89395106039;10892.891071089347;8137.79655508617;8210.876836847452;8291.253787159065;8349;8359.58202089893;5676;5782.190493331022;5872.060470324727;5908.911366329595;5927.2590926134235;9194.12655797698;9226.261899047926;9252.352335336462;9284.30367722437;9344.392614480037;9335.626574936927;9401.388909720847;9548.665796697082;9599.136077753035;9607.51962401891;7484.738034168778;7594.468387212842;7611.961940190264;7706.190849960673;7716.652750626123;7805.414593905366;7822.100458447124;7886.802829929297;7899.960500197462;7940.126586075412;7331.41348692114;7387.741429049957;7396.3343299103335;7488.438367122597;7624.961875190588;7115.928840711734;7234.855302894018;7287.016252805804;7372.778816635509;7544;6865.41643960269;6881.243063262937;6908.896366554606;6923.515353925177;6946.687399066953;4921.8523444296725;5035.798568057383;5063.113955057924;5068.59451243907;5114.64197506171;4965.851024469272;4975.378077740283;5034.0938631046765;5132.563732082815;5215.713135777417 13:38:32 INFO - PROCESS | 13891 | |4;prototype.html;352.28661959531945;355.39050528343887;360.8917324802559;365.09820742765373;365.917668524582;6540.509461790361;6586.242582103059;6645.501587380942;6695.765648202314;6739.629320387383;6638.369354911288;6662.533622646404;6681.966590167054;6687.398134167924;6688.398044176023;5094.439611642726;5110.492404740592;5111.309973153632;5111.488851114896;5124.333836601237;5084.211947148179;5110.488951104879;5113.437521872591;5122.769475373599;5124.436312005676;5074.2895994560795;5079.923801142986;5086.771095300702;5090.261912022755;5093.643444958854;4986.451490336042;5055.797768089272;5077.213031980049;5087.033463641915;5088.338515992934;4426.911461770746;4454.5990860822685;4455.5098939117;4462.062966776981;4479.3281007848755;6326.87346253077;6365.140706004677;6368.5860419072615;6406.231252249713;6413;5899.498542623882;5925.762969481216;5930.495907847838;5939;5942.227510423617;7035.190953040364;7035.613041282727;7040;7040.366367026941;7047.788566342967;4581.106684196583;4740.051989602059;4759.452662943771;4937;4940.654154209206;7240.52936559122;7286.688396088702;7320.780376588711;7322.377597904185;7329.816754581125;4908.9263661045115;4911.975440122848;4913;4928.876778080505;4937.012597480519;4972.453030166679;4980.452150263468;4985.825496107619;4988.575971042429;4993.800247990112;5805.216295800097;5806.071028635398;5806.274215723035;5811.418858114154;5813.680247586423;6949.409300209438;7061.71753129869;7062.293770622897;7073.257307982588;7084.256153103953;1725.7842769653794;1753.1146770880623;1760.7094829353268;1762.1101343821545;1766.938157164493;1110.622388387952;1135.0975974100609;1136.193302755053;1139.4986206069302;1162.6570161802288;6775.22084960226;6776.7628133015105;6792;6792.320767923267;6810.795676129724;7216.8917466238045;7230.060092188087;7245.021922040457;7245.130584329914;7255.09311336083;6712.731490740316;6724.6301453419555;6748.797536073926;6776.2546119926765;6788.744082344782;3833.6166383361997;3885.786281754474;3931.331673615435;3949.2101579684177;3950.30869597825;7492.587907665131;7503.62481875904;7504.287092726182;7522.736704215326;7533.209013053551;7289.635518224068;7307.5980821055355;7315;7359.926400736032;7366.373858222111;7451.2921272479025;7490.550566966;7497.850042999218;7504.58724770132;7514.436417268617;7101.519768907673;7107.857842843217;7140.428765698628;7213.278672132745;7228.783136505703;7024.4029257513685;7030.226675065636;7082.610456424946;7085.468589855678;7118.466115041289;7352.963235184004;7408.444366672414;7454.440916931143;7465.3654439371085;7491.812704682427;4850;4896;4912.92630610534;4917.164082106122;4921.138800709933;6992.02111704372;7167.1757747859665;7167.820804479721;7171.995920571228;7188.4968052235845;6954.721811127498;6960.651967401711;6967.303269673195;6990.335918087773;6992.545484543489;6949.3745562899585;6953.165620125617;6960.686769095301;6968.581885086911;6971.2331643518155;6836.282190370139;6841.213260475109;6849.828754280983;6851.109355783717;6864.4165245954655;6833.214180369321;6945.548539344926;6982.022516847747;7020.368166865007;7032;6686;6775.390214880685;6885.242623311532;6934.4452443805385;7077.964610176916 13:38:32 INFO - PROCESS | 13891 | |5;yui.html;737.6422435118969;748.244273283983;765.3838659878795;768.400647494954;832.1221111727127;14015.579532614012;14143.858561414383;14232.786508202385;14247.14517128973;14252.643683907894;12970.675733106653;13028.869711302885;13039.478420863177;13053.80419293709;13062.216267023985;728.0353531570663;890.7773056735816;909.3543584055328;910.9453432794021;913.1735779119874;903.7108125399875;904.9592768325441;910.7814124610079;911.9498427586481;911.9635214591408;927.9768005799841;943.5848226780195;944.2823454174808;944.3578366710634;944.9196818270456;926.5228407370209;931.7624005878525;936.091990768953;937.2267878999784;938.5354249646434;688.8656711941173;691.7094820175538;693.1197379328275;696.435886931587;698.0053423871015;13224.404901779442;13224.537141200108;13245.735085298336;13255.337233138402;13259.734805303937;13858.4456621735;13979.65050873726;14002.229877356742;14129.364178611988;14134.081284716563;10551;10641.840372394421;10686;10751.78496430067;10839.512221950032;3882.4758657581147;3913.8238779255003;3944.9408258876138;3950.0914789598555;4029.1337362466916;54051.45948540543;54511.454885451036;55503;55997.44002560004;56242;11281.379524126087;11400.258983166068;11440.427978601037;11492.655220343404;11612.767744645229;20729.792702072788;20816.89591552063;20976.580468390548;21168.576628467345;21264.893675531523;8048.315893149148;8286.04710458305;8312.625931833081;8346.8330633387;8429.241368276884;4779.163646361872;4829.975850120797;4843.685160464559;4890.364252647133;4953.281774142802;3541.94687079694;3557.94663080054;3572.69632081276;3594.6225646307284;3595.658412450813;584.7923986984559;603.9939600603938;618.1839971237923;624.1137584629837;632.0203684289334;687.151368060455;716.9890454459292;776.1229810314421;795.1452188896843;801.3629164813987;9640.228781697448;9938.10557049869;9951.993445931445;9977.650782222732;10116;803.3974519110667;828.159418190537;829.5188790501495;837.4359739420184;843.371688092375;4481.484629267611;4735.668503204812;4741.288806679026;4794.7842347094465;4795.568398844121;61235.69382153061;61860;62479;70305.64847175732;70780.29219707738;57193.428065718814;57232.141517877266;57237.71381143068;58434;58663.120053199236;50551.49448505542;52267;52678;52832;57875.421245787846;9692.70921872345;9870.309078364446;9966.152877005246;9980.800383992135;9992.900070999198;38275.23449530938;38887.6111238884;38929.221415572094;39080.41379379255;39950;44916.77541612271;45060.77469612631;50767.23849142192;50828.23757643564;52366.21450678319;11942.761144777229;12176.634700958986;12461.1900226485;12700.745985080062;12909.289989050692;12619.179753316004;12805.319117311874;12989.28558929268;13251.80122298147;13579.660508487366;11723.531058757895;12376.690582735504;12793.168444051107;13211.075224734177;13247.668808279484;12684.809727854274;13136.211827290394;13193.538226162038;13200.431034482881;13656.385462654005;12375.504979801068;13010.479580816662;13059.934700326437;13122;13318.933405332911;10852.45737713127;10944.726381840517;11029.172812039289;11188;11244.493997769956;10937.507812148313;10944.835827462435;11006.284591501526;11258.943705281421;11307.151963602928 13:38:32 INFO - PROCESS | 13891 | __end_tp_report 13:38:32 INFO - PROCESS | 13891 | __start_cc_report 13:38:32 INFO - PROCESS | 13891 | _x_x_mozilla_cycle_collect,360 13:38:32 INFO - PROCESS | 13891 | __end_cc_report 13:38:32 INFO - PROCESS | 13891 | __startTimestamp1464727112489__endTimestamp 13:38:32 INFO - PROCESS | 13891 | 13:38:32 INFO - PROCESS | 13891 | ------- Summary: start ------- 13:38:32 INFO - PROCESS | 13891 | Number of tests: 6 13:38:32 INFO - PROCESS | 13891 | 13:38:32 INFO - PROCESS | 13891 | [#0] dojo.html Cycles:165 Average:5704.16 Median:5925.08 stddev:635.40 (10.7%) stddev-sans-first:610.57 13:38:32 INFO - PROCESS | 13891 | Values: 3377.5 3399.6 3448.1 3466.3 3468.6 5749.0 5767.8 5787.5 5795.0 5812.3 5789.2 5804.6 5805.3 5826.4 5834.0 5230.9 5249.3 5306.6 5325.8 5332.4 5015.1 5325.8 5429.9 5432.8 5446.4 5109.8 5223.5 5224.8 5260.4 5269.5 5241.4 5288.7 5299.2 5312.5 5320.8 5219.4 5223.0 5234.8 5273.2 5285.7 5437.5 5471.0 5573.9 5619.5 5636.4 6159.2 6161.7 6169.9 6175.8 6181.4 6198.4 6198.7 6203.3 6208.3 6217.8 5647.0 5721.6 5742.1 5766.1 5791.2 6265.8 6275.4 6298.0 6309.4 6323.4 5968.8 6049.0 6065.5 6066.0 6074.3 6084.5 6121.3 6125.7 6130.5 6140.1 6065.6 6104.8 6107.3 6109.1 6137.8 5891.2 6023.1 6034.4 6078.4 6113.9 4601.9 4607.4 4618.5 4623.1 4633.2 4128.7 4130.6 4133.8 4136.9 4178.7 5747.8 5830.4 5844.7 5859.7 5890.5 5992.2 6144.6 6193.1 6213.8 6214.2 5925.1 5925.4 5929.3 5930.1 5964.9 5160.0 5233.8 5288.2 5297.1 5316.6 6265.7 6317.5 6323.1 6345.2 6356.6 6052.0 6129.6 6135.5 6146.2 6154.0 6274.0 6362.7 6374.5 6374.9 6376.5 6001.9 6016.2 6022.3 6022.5 6030.9 5947.7 6063.8 6138.6 6143.7 6144.3 6017.9 6064.4 6074.1 6079.9 6112.7 5993.0 6012.1 6037.4 6041.8 6056.6 5745.8 5795.2 5860.2 5866.5 5962.3 5892.0 5924.9 5950.5 5959.5 5991.2 5847.3 5848.6 5855.4 5860.8 5866.1 13:38:32 INFO - PROCESS | 13891 | 13:38:32 INFO - PROCESS | 13891 | [#1] ext.html Cycles:180 Average:59528.62 Median:42793.47 stddev:119010.60 (278.1%) stddev-sans-first:119262.28 13:38:32 INFO - PROCESS | 13891 | Values: 623.5 649.1 654.2 659.6 685.6 38166.4 39142.2 39347.8 39371.6 39377.8 42497.0 42978.6 43051.4 43081.0 43096.4 8715.8 8901.4 8914.3 8918.4 8919.6 8676.4 8778.3 8780.3 8842.5 8903.2 8799.0 8828.4 8828.8 8848.1 8856.6 8861.6 8874.8 8916.7 8931.8 8961.9 8993.8 9124.0 9124.8 9136.1 9141.6 43300.8 43798.1 44044.3 44137.0 44213.8 3842.7 3930.5 3950.3 4028.4 4222.8 32809.3 33006.0 33052.5 33139.5 34581.0 4519.9 4598.7 4607.8 4731.3 4773.6 302750.0 304643.0 305367.0 305617.0 305984.0 38785.6 39519.4 39574.4 39788.8 59467.7 37359.6 37517.4 37762.2 37803.8 37888.6 16823.8 16987.8 16988.6 16998.3 17013.6 13759.1 13840.7 13922.7 13969.9 13972.1 9325.1 9367.4 9491.6 9532.5 9538.5 3643.7 3677.2 3721.9 3742.0 3760.2 1072.9 1121.9 1123.1 1206.7 1226.2 33061.5 33304.7 33986.7 34135.0 34892.3 1116.4 1165.0 1168.4 1205.2 1257.7 15281.0 15632.4 15708.8 15786.8 15928.5 476066.0 547388.0 577432.0 578887.0 580021.0 56633.7 57620.4 57749.4 57871.0 57979.7 1480.2 1512.7 1513.2 1524.3 1605.9 30074.5 30762.5 31278.7 32618.0 33340.3 52155.0 60997.7 62157.0 62584.4 62635.0 446005.0 448754.0 450954.0 452035.0 452493.0 45976.1 46129.5 46392.3 46831.5 47658.3 50344.5 50478.5 51149.2 51299.0 52350.0 42492.8 42521.8 42610.4 42976.6 43993.0 41516.6 42043.6 42551.4 43004.0 43919.6 43627.0 44545.3 44744.6 44949.8 45098.1 36538.8 37165.8 37730.6 38664.2 38731.6 29368.7 29555.9 29558.4 29816.6 30154.2 13:38:32 INFO - PROCESS | 13891 | 13:38:32 INFO - PROCESS | 13891 | [#2] jquery.html Cycles:180 Average:30007.84 Median:12572.43 stddev:84806.51 (674.5%) stddev-sans-first:85015.33 13:38:32 INFO - PROCESS | 13891 | Values: 429.2 433.5 439.1 442.9 454.8 18296.9 18656.6 19397.4 20175.8 20219.7 19387.1 19668.8 19833.3 20032.4 20247.8 5748.5 5769.7 5975.3 5975.8 6009.4 5919.1 5933.2 5972.2 5978.9 5983.1 5647.1 5751.3 5772.2 5787.1 5921.6 5785.8 5801.8 5804.7 5829.4 5830.2 5263.2 5279.2 5328.3 5334.7 5348.5 22957.3 23476.3 23716.9 24195.5 24367.9 2503.5 2648.8 2751.6 2942.7 3057.1 14685.9 14866.6 14880.4 15048.2 15441.8 2046.0 2069.5 2097.4 2109.8 2128.3 76163.6 76489.6 76755.0 78145.0 78766.6 10654.1 10975.2 11390.3 11700.8 11906.5 14879.6 14959.4 15010.5 15077.8 15203.8 8029.5 8272.6 8372.9 8374.7 8446.8 8113.7 8207.6 8229.8 8245.4 8254.1 4588.8 4620.3 4652.8 4681.9 4718.3 2100.7 2157.0 2160.8 2163.1 2187.6 1061.5 1092.1 1116.8 1134.6 1168.3 19019.2 19389.0 19443.8 19468.0 19475.2 1072.7 1080.9 1081.6 1095.4 1104.3 10838.6 10938.7 11252.1 11284.0 11516.2 494977.0 503178.0 521030.0 525349.0 531467.0 76821.0 96293.0 97146.0 99887.0 102366.0 1166.0 1179.2 1186.1 1213.1 1243.6 17849.7 17921.4 17933.2 18112.5 18258.3 40414.8 40954.0 41132.0 41221.6 42117.8 58645.7 59702.7 60618.0 60695.0 61160.4 9029.6 9065.8 9231.0 9244.4 9314.8 10199.0 13312.0 13377.9 13449.7 13756.4 12082.9 12124.4 12171.6 12209.8 12432.6 11212.2 11648.7 11960.7 12004.6 12183.7 11846.5 12019.9 12080.2 12187.9 12305.4 8709.9 8973.8 9123.9 9181.4 9313.3 10682.4 11197.9 11209.7 11337.6 11844.3 13:38:32 INFO - PROCESS | 13891 | 13:38:32 INFO - PROCESS | 13891 | [#3] mootools.html Cycles:180 Average:5700.88 Median:4928.83 stddev:3147.41 (63.9%) stddev-sans-first:3140.65 13:38:32 INFO - PROCESS | 13891 | Values: 1532.2 1540.4 1796.1 1936.1 1947.5 7371.7 8173.6 8374.0 8577.0 8584.2 8445.3 8456.4 8495.6 8521.0 8532.4 2275.6 2292.2 2294.0 2298.9 2306.0 2223.9 2251.8 2253.7 2270.1 2271.5 2364.3 2365.8 2383.0 2385.0 2397.4 2323.9 2324.7 2327.5 2333.7 2335.3 2324.5 2345.0 2345.1 2355.4 2358.8 8647.1 8729.7 8787.5 8794.9 8810.0 5419.4 5500.5 5523.5 5535.2 5551.8 3422.5 3478.5 3530.8 3580.1 3590.3 1121.3 1124.7 1130.3 1160.6 1162.5 12128.6 12138.1 12194.4 12206.9 12233.1 4612.3 4698.5 4742.5 4769.0 4867.7 10443.3 10449.5 10468.2 10511.8 10515.8 5336.3 5338.7 5352.8 5393.8 5411.9 4217.2 4832.1 4916.9 4935.8 4968.2 4048.5 4151.1 4214.7 4251.9 4268.5 1330.1 1335.4 1344.3 1347.6 1370.0 893.5 899.3 989.6 1023.7 1036.0 5686.7 5698.9 5731.2 5772.0 5809.3 1078.6 1115.6 1147.8 1150.5 1168.3 3892.7 3970.0 4027.1 4028.6 4086.6 10305.1 10627.7 10642.0 10755.7 10832.5 10432.6 10500.2 10508.9 10604.9 10892.9 8137.8 8210.9 8291.3 8349.0 8359.6 5676.0 5782.2 5872.1 5908.9 5927.3 9194.1 9226.3 9252.4 9284.3 9344.4 9335.6 9401.4 9548.7 9599.1 9607.5 7484.7 7594.5 7612.0 7706.2 7716.7 7805.4 7822.1 7886.8 7900.0 7940.1 7331.4 7387.7 7396.3 7488.4 7625.0 7115.9 7234.9 7287.0 7372.8 7544.0 6865.4 6881.2 6908.9 6923.5 6946.7 4921.9 5035.8 5063.1 5068.6 5114.6 4965.9 4975.4 5034.1 5132.6 5215.7 13:38:32 INFO - PROCESS | 13891 | 13:38:32 INFO - PROCESS | 13891 | [#4] prototype.html Cycles:180 Average:5858.68 Median:6718.68 stddev:1767.07 (26.3%) stddev-sans-first:1723.02 13:38:32 INFO - PROCESS | 13891 | Values: 352.3 355.4 360.9 365.1 365.9 6540.5 6586.2 6645.5 6695.8 6739.6 6638.4 6662.5 6682.0 6687.4 6688.4 5094.4 5110.5 5111.3 5111.5 5124.3 5084.2 5110.5 5113.4 5122.8 5124.4 5074.3 5079.9 5086.8 5090.3 5093.6 4986.5 5055.8 5077.2 5087.0 5088.3 4426.9 4454.6 4455.5 4462.1 4479.3 6326.9 6365.1 6368.6 6406.2 6413.0 5899.5 5925.8 5930.5 5939.0 5942.2 7035.2 7035.6 7040.0 7040.4 7047.8 4581.1 4740.1 4759.5 4937.0 4940.7 7240.5 7286.7 7320.8 7322.4 7329.8 4908.9 4912.0 4913.0 4928.9 4937.0 4972.5 4980.5 4985.8 4988.6 4993.8 5805.2 5806.1 5806.3 5811.4 5813.7 6949.4 7061.7 7062.3 7073.3 7084.3 1725.8 1753.1 1760.7 1762.1 1766.9 1110.6 1135.1 1136.2 1139.5 1162.7 6775.2 6776.8 6792.0 6792.3 6810.8 7216.9 7230.1 7245.0 7245.1 7255.1 6712.7 6724.6 6748.8 6776.3 6788.7 3833.6 3885.8 3931.3 3949.2 3950.3 7492.6 7503.6 7504.3 7522.7 7533.2 7289.6 7307.6 7315.0 7359.9 7366.4 7451.3 7490.6 7497.9 7504.6 7514.4 7101.5 7107.9 7140.4 7213.3 7228.8 7024.4 7030.2 7082.6 7085.5 7118.5 7353.0 7408.4 7454.4 7465.4 7491.8 4850.0 4896.0 4912.9 4917.2 4921.1 6992.0 7167.2 7167.8 7172.0 7188.5 6954.7 6960.7 6967.3 6990.3 6992.5 6949.4 6953.2 6960.7 6968.6 6971.2 6836.3 6841.2 6849.8 6851.1 6864.4 6833.2 6945.5 6982.0 7020.4 7032.0 6686.0 6775.4 6885.2 6934.4 7078.0 13:38:32 INFO - PROCESS | 13891 | 13:38:32 INFO - PROCESS | 13891 | [#5] yui.html Cycles:180 Average:15443.43 Median:4760.23 stddev:18072.27 (379.7%) stddev-sans-first:18089.23 13:38:32 INFO - PROCESS | 13891 | Values: 737.6 748.2 765.4 768.4 832.1 14015.6 14143.9 14232.8 14247.1 14252.6 12970.7 13028.9 13039.5 13053.8 13062.2 728.0 890.8 909.4 910.9 913.2 903.7 905.0 910.8 911.9 912.0 928.0 943.6 944.3 944.4 944.9 926.5 931.8 936.1 937.2 938.5 688.9 691.7 693.1 696.4 698.0 13224.4 13224.5 13245.7 13255.3 13259.7 13858.4 13979.7 14002.2 14129.4 14134.1 10551.0 10641.8 10686.0 10751.8 10839.5 3882.5 3913.8 3944.9 3950.1 4029.1 54051.5 54511.5 55503.0 55997.4 56242.0 11281.4 11400.3 11440.4 11492.7 11612.8 20729.8 20816.9 20976.6 21168.6 21264.9 8048.3 8286.0 8312.6 8346.8 8429.2 4779.2 4830.0 4843.7 4890.4 4953.3 3541.9 3557.9 3572.7 3594.6 3595.7 584.8 604.0 618.2 624.1 632.0 687.2 717.0 776.1 795.1 801.4 9640.2 9938.1 9952.0 9977.7 10116.0 803.4 828.2 829.5 837.4 843.4 4481.5 4735.7 4741.3 4794.8 4795.6 61235.7 61860.0 62479.0 70305.6 70780.3 57193.4 57232.1 57237.7 58434.0 58663.1 50551.5 52267.0 52678.0 52832.0 57875.4 9692.7 9870.3 9966.2 9980.8 9992.9 38275.2 38887.6 38929.2 39080.4 39950.0 44916.8 45060.8 50767.2 50828.2 52366.2 11942.8 12176.6 12461.2 12700.7 12909.3 12619.2 12805.3 12989.3 13251.8 13579.7 11723.5 12376.7 12793.2 13211.1 13247.7 12684.8 13136.2 13193.5 13200.4 13656.4 12375.5 13010.5 13059.9 13122.0 13318.9 10852.5 10944.7 11029.2 11188.0 11244.5 10937.5 10944.8 11006.3 11258.9 11307.2 13:38:32 INFO - PROCESS | 13891 | -------- Summary: end -------- 13:38:32 INFO - PROCESS | 13891 | 13:38:33 INFO - TEST-INFO | 13891: exit 0 13:38:33 INFO - TEST-OK | dromaeo_css | took 1109229ms 13:38:33 INFO - TEST-START | kraken 13:38:33 INFO - operating with platform_type : linux_ 13:38:33 INFO - Initialising browser for kraken test... 13:38:33 INFO - TEST-INFO | started process 14141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBsKodK/profile http://localhost:42286/getInfo.html) 13:38:36 INFO - PROCESS | 14141 | 13:38:36 INFO - PROCESS | 14141 | (process:14220): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:38:37 INFO - PROCESS | 14141 | __metrics Screen width/height:1600/1200 13:38:37 INFO - PROCESS | 14141 | colorDepth:24 13:38:37 INFO - PROCESS | 14141 | Browser inner width/height: 1024/697 13:38:37 INFO - PROCESS | 14141 | __metrics 13:38:38 ERROR - PROCESS | 14141 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 13:38:38 INFO - TEST-INFO | 14141: exit 0 13:38:38 INFO - Browser initialized. 13:38:38 INFO - Running cycle 1/1 for kraken test... 13:38:38 INFO - TEST-INFO | started process 14271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBsKodK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:40 INFO - PROCESS | 14271 | 13:38:40 INFO - PROCESS | 14271 | (process:14342): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:38:50 INFO - PROCESS | 14271 | RSS: Main: 152305664 13:38:50 INFO - PROCESS | 14271 | 13:38:53 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42286/tests/kraken/driver.html?testName=audio-beat-detection) 13:38:54 INFO - PROCESS | 14271 | RSS: Main: 156618752 13:38:54 INFO - PROCESS | 14271 | 13:38:56 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42286/tests/kraken/driver.html?testName=audio-dft) 13:38:57 INFO - PROCESS | 14271 | RSS: Main: 157208576 13:38:57 INFO - PROCESS | 14271 | 13:39:00 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42286/tests/kraken/driver.html?testName=audio-fft) 13:39:00 INFO - PROCESS | 14271 | RSS: Main: 157532160 13:39:00 INFO - PROCESS | 14271 | 13:39:03 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42286/tests/kraken/driver.html?testName=audio-oscillator) 13:39:03 INFO - PROCESS | 14271 | RSS: Main: 157372416 13:39:03 INFO - PROCESS | 14271 | 13:39:05 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42286/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:39:06 INFO - PROCESS | 14271 | RSS: Main: 157061120 13:39:06 INFO - PROCESS | 14271 | 13:39:09 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42286/tests/kraken/driver.html?testName=imaging-darkroom) 13:39:10 INFO - PROCESS | 14271 | RSS: Main: 157454336 13:39:10 INFO - PROCESS | 14271 | 13:39:13 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42286/tests/kraken/driver.html?testName=imaging-desaturate) 13:39:14 INFO - PROCESS | 14271 | RSS: Main: 157614080 13:39:14 INFO - PROCESS | 14271 | 13:39:16 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42286/tests/kraken/driver.html?testName=json-parse-financial) 13:39:17 INFO - PROCESS | 14271 | RSS: Main: 158031872 13:39:17 INFO - PROCESS | 14271 | 13:39:19 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42286/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:39:19 INFO - PROCESS | 14271 | RSS: Main: 157081600 13:39:19 INFO - PROCESS | 14271 | 13:39:21 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42286/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:39:22 INFO - PROCESS | 14271 | RSS: Main: 157540352 13:39:22 INFO - PROCESS | 14271 | 13:39:23 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42286/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:39:24 INFO - PROCESS | 14271 | RSS: Main: 157655040 13:39:24 INFO - PROCESS | 14271 | 13:39:27 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:39:27 INFO - PROCESS | 14271 | RSS: Main: 157708288 13:39:27 INFO - PROCESS | 14271 | 13:39:30 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:39:31 INFO - PROCESS | 14271 | RSS: Main: 157945856 13:39:31 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | Cycle 1(1): loaded http://localhost:42286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42286/tests/kraken/driver.html?testName=ai-astar) 13:39:32 INFO - PROCESS | 14271 | RSS: Main: 159473664 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | __start_tp_report 13:39:32 INFO - PROCESS | 14271 | _x_x_mozilla_page_load 13:39:32 INFO - PROCESS | 14271 | _x_x_mozilla_page_load_details 13:39:32 INFO - PROCESS | 14271 | |i|pagename|runs| 13:39:32 INFO - PROCESS | 14271 | |0;ai-astar;108;114;106;110;113;112;102;113;110;111 13:39:32 INFO - PROCESS | 14271 | |1;audio-beat-detection;160;126;160;177;136;151;157;135;185;128 13:39:32 INFO - PROCESS | 14271 | |2;audio-dft;162;162;162;163;161;162;162;163;162;162 13:39:32 INFO - PROCESS | 14271 | |3;audio-fft;73;80;74;168;73;76;78;76;173;77 13:39:32 INFO - PROCESS | 14271 | |4;audio-oscillator;92;93;152;93;95;92;140;92;93;140 13:39:32 INFO - PROCESS | 14271 | |5;imaging-gaussian-blur;118;117;119;118;117;118;118;117;118;117 13:39:32 INFO - PROCESS | 14271 | |6;imaging-darkroom;146;147;147;148;146;148;147;147;146;146 13:39:32 INFO - PROCESS | 14271 | |7;imaging-desaturate;94;95;95;95;95;96;95;95;96;95 13:39:32 INFO - PROCESS | 14271 | |8;json-parse-financial;54;55;55;55;53;54;57;74;57;53 13:39:32 INFO - PROCESS | 14271 | |9;json-stringify-tinderbox;59;59;60;60;60;60;59;60;59;59 13:39:32 INFO - PROCESS | 14271 | |10;stanford-crypto-aes;72;73;72;75;74;87;74;75;74;74 13:39:32 INFO - PROCESS | 14271 | |11;stanford-crypto-ccm;122;116;113;121;115;113;115;110;134;131 13:39:32 INFO - PROCESS | 14271 | |12;stanford-crypto-pbkdf2;165;160;158;160;162;159;159;172;161;161 13:39:32 INFO - PROCESS | 14271 | |13;stanford-crypto-sha256-iterative;65;67;66;72;65;70;68;69;65;66 13:39:32 INFO - PROCESS | 14271 | __end_tp_report 13:39:32 INFO - PROCESS | 14271 | __start_cc_report 13:39:32 INFO - PROCESS | 14271 | _x_x_mozilla_cycle_collect,884 13:39:32 INFO - PROCESS | 14271 | __end_cc_report 13:39:32 INFO - PROCESS | 14271 | __startTimestamp1464727172986__endTimestamp 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | ------- Summary: start ------- 13:39:32 INFO - PROCESS | 14271 | Number of tests: 14 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.70 (3.3%) stddev-sans-first:3.86 13:39:32 INFO - PROCESS | 14271 | Values: 108.0 114.0 106.0 110.0 113.0 112.0 102.0 113.0 110.0 111.0 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:158.50 stddev:20.17 (12.7%) stddev-sans-first:21.16 13:39:32 INFO - PROCESS | 14271 | Values: 160.0 126.0 160.0 177.0 136.0 151.0 157.0 135.0 185.0 128.0 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 13:39:32 INFO - PROCESS | 14271 | Values: 162.0 162.0 162.0 163.0 161.0 162.0 162.0 163.0 162.0 162.0 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:39.97 (52.6%) stddev-sans-first:41.61 13:39:32 INFO - PROCESS | 14271 | Values: 73.0 80.0 74.0 168.0 73.0 76.0 78.0 76.0 173.0 77.0 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:92.50 stddev:24.93 (27.0%) stddev-sans-first:25.75 13:39:32 INFO - PROCESS | 14271 | Values: 92.0 93.0 152.0 93.0 95.0 92.0 140.0 92.0 93.0 140.0 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 13:39:32 INFO - PROCESS | 14271 | Values: 118.0 117.0 119.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 13:39:32 INFO - PROCESS | 14271 | Values: 146.0 147.0 147.0 148.0 146.0 148.0 147.0 147.0 146.0 146.0 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 13:39:32 INFO - PROCESS | 14271 | Values: 94.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 13:39:32 INFO - PROCESS | 14271 | 13:39:32 INFO - PROCESS | 14271 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:55.00 stddev:6.24 (11.3%) stddev-sans-first:6.54 13:39:32 INFO - PROCESS | 14271 | Values: 54.0 55.0 55.0 55.0 53.0 54.0 57.0 74.0 57.0 53.0 13:39:33 INFO - PROCESS | 14271 | 13:39:33 INFO - PROCESS | 14271 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 13:39:33 INFO - PROCESS | 14271 | Values: 59.0 59.0 60.0 60.0 60.0 60.0 59.0 60.0 59.0 59.0 13:39:33 INFO - PROCESS | 14271 | 13:39:33 INFO - PROCESS | 14271 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.00 stddev:4.35 (5.9%) stddev-sans-first:4.47 13:39:33 INFO - PROCESS | 14271 | Values: 72.0 73.0 72.0 75.0 74.0 87.0 74.0 75.0 74.0 74.0 13:39:33 INFO - PROCESS | 14271 | 13:39:33 INFO - PROCESS | 14271 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:118.50 stddev:8.00 (6.8%) stddev-sans-first:8.41 13:39:33 INFO - PROCESS | 14271 | Values: 122.0 116.0 113.0 121.0 115.0 113.0 115.0 110.0 134.0 131.0 13:39:33 INFO - PROCESS | 14271 | 13:39:33 INFO - PROCESS | 14271 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:161.00 stddev:4.11 (2.6%) stddev-sans-first:4.18 13:39:33 INFO - PROCESS | 14271 | Values: 165.0 160.0 158.0 160.0 162.0 159.0 159.0 172.0 161.0 161.0 13:39:33 INFO - PROCESS | 14271 | 13:39:33 INFO - PROCESS | 14271 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:2.41 (3.6%) stddev-sans-first:2.40 13:39:33 INFO - PROCESS | 14271 | Values: 65.0 67.0 66.0 72.0 65.0 70.0 68.0 69.0 65.0 66.0 13:39:33 INFO - PROCESS | 14271 | -------- Summary: end -------- 13:39:33 INFO - PROCESS | 14271 | 13:39:33 INFO - TEST-INFO | 14271: exit 0 13:39:33 INFO - TEST-OK | kraken | took 60738ms 13:39:33 INFO - SUITE-END | took 1169s 13:39:34 INFO - Completed test suite (00:19:30) 13:39:34 INFO - javascript benchmark 13:39:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3377.4933759936007, 3399.5580574525306, 3448.086257141857, 3466.272082862599, 3468.5664291963503, 5748.971255143723, 5767.798127065554, 5787.450192231742, 5795.0, 5812.273465816773, 5789.247397838275, 5804.564657650682, 5805.260268503277, 5826.359100498952, 5834.0, 5230.92153617696, 5249.291345668324, 5306.628536002481, 5325.840224793263, 5332.413434522199, 5015.072211640858, 5325.760340784674, 5429.945700543003, 5432.83701488954, 5446.400895901447, 5109.770060347293, 5223.529882310591, 5224.817131400402, 5260.395054568736, 5269.525742683158, 5241.449647786984, 5288.68267903927, 5299.152135658295, 5312.468753124656, 5320.787168513255, 5219.399769026534, 5222.973885130588, 5234.790608375661, 5273.209018647233, 5285.682859028432, 5437.483439073281, 5471.042567550702, 5573.8606534836545, 5619.522340601013, 5636.408177141423, 6159.23009623797, 6161.661108639023, 6169.9383006170265, 6175.7529698811995, 6181.3818618138275, 6198.411150940653, 6198.659073750942, 6203.2556093269095, 6208.286047104596, 6217.782377616807, 5646.971765141189, 5721.599488035798, 5742.081266997302, 5766.077427611562, 5791.189233507313, 6265.780697675559, 6275.435210831047, 6298.02380631003, 6309.432151106423, 6323.36766323364, 5968.820935371946, 6049.0, 6065.454109130112, 6066.029435290332, 6074.301455332693, 6084.4828189603495, 6121.296050954108, 6125.662799505688, 6130.459285710702, 6140.140380346755, 6065.60573562717, 6104.755809767648, 6107.328193898757, 6109.083637454329, 6137.754489820447, 5891.23413956183, 6023.066424704178, 6034.39656034393, 6078.422549857756, 6113.908291375633, 4601.861944141681, 4607.424071991001, 4618.49196588375, 4623.075384922961, 4633.212353899845, 4128.731632443882, 4130.648894843912, 4133.751974881457, 4136.91726165475, 4178.686598505064, 5747.770089196385, 5830.387809279964, 5844.6785426801935, 5859.736311865976, 5890.49930755882, 5992.161097446361, 6144.600600960924, 6193.071039344134, 6213.844653883599, 6214.1921550198185, 5925.081612350093, 5925.4370834770625, 5929.347771745104, 5930.11048342752, 5964.850878728066, 5160.0, 5233.816816411408, 5288.206768984683, 5297.073012222845, 5316.601254905898, 6265.686715664289, 6317.4946004319545, 6323.114763933053, 6345.206849143857, 6356.618602883842, 6052.0, 6129.601575897642, 6135.539834512519, 6146.170267014075, 6153.953827849366, 6274.0, 6362.745490180526, 6374.521910856797, 6374.90437643445, 6376.489880809617, 6001.90997135052, 6016.2479690038745, 6022.337542870368, 6022.518198544193, 6030.939690603038, 5947.702614869326, 6063.818085457443, 6138.570300078952, 6143.6928153593035, 6144.262688477412, 6017.939820601738, 6064.363241859542, 6074.119252708244, 6079.878402431838, 6112.663803490851, 5993.0, 6012.098185272244, 6037.426444487766, 6041.848953776191, 6056.57603967718, 5745.798897038583, 5795.188673585617, 5860.208871802252, 5866.50134738552, 5962.314333851489, 5892.0, 5924.940750592611, 5950.523958083257, 5959.523238141025, 5991.221141251609, 5847.26909136358, 5848.64908105515, 5855.414458554111, 5860.794872179454, 5866.149408335853], "value": 5662.439058161354, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.5105442227849, 649.0685865782601, 654.2182092399579, 659.6174218953008, 685.6023506366308, 38166.42750358743, 39142.21715565691, 39347.80326098369, 39371.60628393715, 39377.8031109844, 42497.0, 42978.57021429785, 43051.35422968658, 43081.0, 43096.3535546967, 8715.825683486342, 8901.421407608517, 8914.28685705142, 8918.375713700043, 8919.643214271453, 8676.392652514327, 8778.297736181123, 8780.25367843734, 8842.46945183291, 8903.243224325908, 8798.956005219998, 8828.426152300111, 8828.779280517974, 8848.115188481133, 8856.601452934601, 8861.601227944759, 8874.778130546756, 8916.687915922976, 8931.821363572724, 8961.910380896174, 8993.820123597558, 9124.0, 9124.771880702969, 9136.08639136081, 9141.634334626608, 43300.78349608232, 43798.12403751939, 44044.33933491, 44137.0, 44213.77893110546, 3842.6541611254843, 3930.4693866327966, 3950.32844416447, 4028.3756017817286, 4222.831086756526, 32809.3438131236, 33006.0, 33052.504212436834, 33139.50290745641, 34581.0, 4519.887002824923, 4598.655100867449, 4607.815687372501, 4731.33761273422, 4773.618110551148, 302750.0, 304643.0, 305367.0, 305616.9999999978, 305984.0, 38785.61214387877, 39519.40720889189, 39574.406383904265, 39788.801055995114, 59467.702661486415, 37359.626403735616, 37517.437238441446, 37762.244755104744, 37803.810980944916, 37888.62111378851, 16823.83176168247, 16987.830121698626, 16988.57528561771, 16998.320067197175, 17013.57466063358, 13759.10565813219, 13840.653983650489, 13922.651933701738, 13969.930150349182, 13972.091814032055, 9325.114114159143, 9367.437953722798, 9491.572879220314, 9532.475713835667, 9538.52307384628, 3643.690286325692, 3677.154254521475, 3721.9441708374397, 3742.045778326509, 3760.247950409874, 1072.940988245654, 1121.9439028048564, 1123.1360031918575, 1206.6500714792787, 1226.1600803449664, 33061.504077438854, 33304.66695333064, 33986.660133398844, 34135.0, 34892.30215395678, 1116.391566596207, 1164.980641938304, 1168.39243593331, 1205.198542968916, 1257.6730050186834, 15281.0, 15632.374705011673, 15708.764368534481, 15786.763198552031, 15928.522144335688, 476066.0, 547388.0, 577432.0, 578887.0, 580021.0, 56633.7168314164, 57620.42379576234, 57749.42250577525, 57871.0, 57979.71010144922, 1480.2302802542617, 1512.6747749233969, 1513.1526345246698, 1524.3064405695604, 1605.9437919672755, 30074.54888176723, 30762.520754342568, 31278.687213128487, 32618.0, 33340.333193335515, 52155.0, 60997.69501152466, 62157.0, 62584.37415625968, 62635.0, 446005.0, 448754.0, 450954.0, 452035.0, 452493.0, 45976.08047839091, 46129.538704613864, 46392.30411543762, 46831.53168468408, 47658.285125723836, 50344.49655503545, 50478.49521504738, 51149.23276150786, 51299.0, 52350.0, 42492.78753606212, 42521.78739106285, 42610.36084458797, 42976.57023429726, 43993.0, 41516.58483415127, 42043.57956420519, 42551.36172957346, 43004.0, 43919.56080439155, 43627.0, 44545.33182002338, 44744.55255447404, 44949.77525112354, 45098.09803803971, 36538.8173059133, 37165.81417092897, 37730.62269377271, 38664.226715466095, 38731.6126838728, 29368.706312936596, 29555.915656782003, 29558.40883182367, 29816.552751709176, 30154.24614384658], "value": 19766.249427959225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.22524842659, 433.45384815132934, 439.11956527163034, 442.8943691975388, 454.8203459633445, 18296.908515457406, 18656.62686746264, 19397.41807745768, 20175.798242017576, 20219.696704549442, 19387.127579258933, 19668.803311966876, 19833.305834295803, 20032.399028029184, 20247.797522024775, 5748.511376533, 5769.7115144242825, 5975.25309336333, 5975.820725378224, 6009.429104235112, 5919.112133180014, 5933.228680271559, 5972.19375384324, 5978.940210597903, 5983.1025346197985, 5647.124695672177, 5751.338596061444, 5772.191893134944, 5787.13193021046, 5921.585489015771, 5785.768569257225, 5801.767929282823, 5804.65172089676, 5829.446202610745, 5830.183774271605, 5263.236830659533, 5279.208118782175, 5328.280682107943, 5334.733263336818, 5348.465153484621, 22957.311280661608, 23476.295711128692, 23716.881415592983, 24195.51608967811, 24367.878160609085, 2503.5243303772227, 2648.841069535834, 2751.6285301484445, 2942.6615939167054, 3057.1287183152917, 14685.853141468555, 14866.628334291621, 14880.404783808635, 15048.247587620575, 15441.845581544154, 2045.9693104603443, 2069.4722845674405, 2097.444177293003, 2109.831213502916, 2128.287023847013, 76163.61918190429, 76489.61755191188, 76755.0, 78145.0, 78766.60616696937, 10654.147668186526, 10975.176861735401, 11390.316581005167, 11700.824487632692, 11906.46420911061, 14879.628009299855, 14959.401623935139, 15010.47463338778, 15077.849221507864, 15203.771943420857, 8029.478083924526, 8272.627731751965, 8372.916270837213, 8374.748757537283, 8446.775217593415, 8113.675452981933, 8207.630656620466, 8229.79425514367, 8245.422820402635, 8254.092049874509, 4588.816447342069, 4620.2607582786595, 4652.813887444532, 4681.882952926204, 4718.3158442025715, 2100.653392190302, 2156.967645485319, 2160.805527502532, 2163.1455575047767, 2187.55155193185, 1061.5256693038878, 1092.126298960828, 1116.7598966222301, 1134.5745345495438, 1168.3165348271357, 19019.239230430627, 19389.0, 19443.8055619442, 19468.0, 19475.220991160477, 1072.6942821295893, 1080.8756992945912, 1081.551156270139, 1095.39753135775, 1104.3042882983668, 10838.566457341618, 10938.726531836608, 11252.099832013582, 11283.959806475623, 11516.193866429438, 494977.0, 503178.0, 521030.0, 525349.0, 531467.0, 76821.0, 96293.0, 97146.0, 99887.0, 102366.0, 1166.03801863463, 1179.1981452612306, 1186.128195776104, 1213.1447329632765, 1243.5823161595788, 17849.708212483358, 17921.37275195362, 17933.193006314486, 18112.45662630123, 18258.26966921308, 40414.79792601018, 40954.0, 41132.0, 41221.58778412177, 42117.78941105397, 58645.70677146587, 59702.70148649229, 60618.0, 60695.0, 61160.38839611547, 9029.638814447611, 9065.81868362616, 9230.953845230732, 9244.352895297265, 9314.813703726024, 10199.031092046243, 13312.001599880241, 13377.866221337663, 13449.731005379643, 13756.380962856896, 12082.939585302018, 12124.393780310773, 12171.634850954486, 12209.816852747039, 12432.627021189379, 11212.15908806859, 11648.708782280512, 11960.700982475508, 12004.579839705917, 12183.695407614527, 11846.526138954345, 12019.939900300442, 12080.21478603888, 12187.939060304641, 12305.384730763604, 8709.91290087091, 8973.775655608662, 9123.908760912305, 9181.357304988587, 9313.25493960468, 10682.412467314061, 11197.888021119685, 11209.663710088711, 11337.603183888525, 11844.348560829238], "value": 9653.193755064389, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1532.1573134775872, 1540.3838464614157, 1796.146830255628, 1936.061010409951, 1947.4936516505704, 7371.668274927628, 8173.5504547249875, 8373.958130209348, 8577.0, 8584.22741953224, 8445.324374050077, 8456.408051436401, 8495.617697203625, 8521.0, 8532.360072994536, 2275.6472746724285, 2292.151903795598, 2294.0, 2298.8735619540917, 2305.988470057656, 2223.9110435582556, 2251.797338239558, 2253.6844841722173, 2270.0579259607325, 2271.5002699406186, 2364.302530753423, 2365.8462199957034, 2382.976170238293, 2384.9761502385013, 2397.352714767012, 2323.8605683659034, 2324.651302304651, 2327.511222643247, 2333.708286464192, 2335.322756400642, 2324.488612505263, 2345.0, 2345.0854166874933, 2355.4464700795297, 2358.7877091061887, 8647.135286471366, 8729.738107856774, 8787.472751634858, 8794.912050879473, 8810.0, 5419.376771671269, 5500.477454641803, 5523.4752698493985, 5535.197396377503, 5551.77792888284, 3422.4524076147695, 3478.513008178857, 3530.8411121499594, 3580.051286409104, 3590.335787879251, 1121.2823792772633, 1124.746931940315, 1130.2596799096605, 1160.628598848369, 1162.5001249462728, 12128.57549985755, 12138.08964327679, 12194.390280486028, 12206.938965305117, 12233.143679942408, 4612.285095810154, 4698.506656801055, 4742.454617718938, 4769.046190761862, 4867.659263851568, 10443.268971171945, 10449.477526123663, 10468.214883883738, 10511.789764204826, 10515.84226236607, 5336.279602253724, 5338.733063346817, 5352.839414817562, 5393.83818485446, 5411.864703382447, 4217.240896638635, 4832.130216560982, 4916.926246106311, 4935.802567897315, 4968.1554135797005, 4048.4534587830854, 4151.066010147692, 4214.683898707548, 4251.893702657397, 4268.509121451011, 1330.082243252153, 1335.3590276667255, 1344.3211178354868, 1347.5553067487901, 1370.0272806307632, 893.5085702863529, 899.2940541674753, 989.5744829723144, 1023.65195833417, 1035.984460233097, 5686.658800471902, 5698.900159958699, 5731.168980497888, 5771.9711401443565, 5809.302883653989, 1078.5577913055608, 1115.5816568786704, 1147.7761836441814, 1150.4535345710888, 1168.281506873284, 3892.6691231245095, 3969.980150099231, 4027.0737730321603, 4028.597140285948, 4086.591340865949, 10305.072543471124, 10627.734306642242, 10642.04221620058, 10755.731106722238, 10832.512536935857, 10432.634857779942, 10500.159987201005, 10508.894911050944, 10604.89395106039, 10892.891071089347, 8137.79655508617, 8210.876836847452, 8291.253787159065, 8349.0, 8359.58202089893, 5676.0, 5782.190493331022, 5872.060470324727, 5908.911366329595, 5927.2590926134235, 9194.12655797698, 9226.261899047926, 9252.352335336462, 9284.30367722437, 9344.392614480037, 9335.626574936927, 9401.388909720847, 9548.665796697082, 9599.136077753035, 9607.51962401891, 7484.738034168778, 7594.468387212842, 7611.961940190264, 7706.190849960673, 7716.652750626123, 7805.414593905366, 7822.100458447124, 7886.802829929297, 7899.960500197462, 7940.126586075412, 7331.41348692114, 7387.741429049957, 7396.3343299103335, 7488.438367122597, 7624.961875190588, 7115.928840711734, 7234.855302894018, 7287.016252805804, 7372.778816635509, 7544.0, 6865.41643960269, 6881.243063262937, 6908.896366554606, 6923.515353925177, 6946.687399066953, 4921.8523444296725, 5035.798568057383, 5063.113955057924, 5068.59451243907, 5114.64197506171, 4965.851024469272, 4975.378077740283, 5034.0938631046765, 5132.563732082815, 5215.713135777417], "value": 4636.517324380894, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.28661959531945, 355.39050528343887, 360.8917324802559, 365.09820742765373, 365.917668524582, 6540.509461790361, 6586.242582103059, 6645.501587380942, 6695.765648202314, 6739.629320387383, 6638.369354911288, 6662.533622646404, 6681.966590167054, 6687.398134167924, 6688.398044176023, 5094.439611642726, 5110.492404740592, 5111.309973153632, 5111.488851114896, 5124.333836601237, 5084.211947148179, 5110.488951104879, 5113.437521872591, 5122.769475373599, 5124.436312005676, 5074.2895994560795, 5079.923801142986, 5086.771095300702, 5090.261912022755, 5093.643444958854, 4986.451490336042, 5055.797768089272, 5077.213031980049, 5087.033463641915, 5088.338515992934, 4426.911461770746, 4454.5990860822685, 4455.5098939117, 4462.062966776981, 4479.3281007848755, 6326.87346253077, 6365.140706004677, 6368.5860419072615, 6406.231252249713, 6413.0, 5899.498542623882, 5925.762969481216, 5930.495907847838, 5939.0, 5942.227510423617, 7035.190953040364, 7035.613041282727, 7040.0, 7040.366367026941, 7047.788566342967, 4581.106684196583, 4740.051989602059, 4759.452662943771, 4937.0, 4940.654154209206, 7240.52936559122, 7286.688396088702, 7320.780376588711, 7322.377597904185, 7329.816754581125, 4908.9263661045115, 4911.975440122848, 4913.0, 4928.876778080505, 4937.012597480519, 4972.453030166679, 4980.452150263468, 4985.825496107619, 4988.575971042429, 4993.800247990112, 5805.216295800097, 5806.071028635398, 5806.274215723035, 5811.418858114154, 5813.680247586423, 6949.409300209438, 7061.71753129869, 7062.293770622897, 7073.257307982588, 7084.256153103953, 1725.7842769653794, 1753.1146770880623, 1760.7094829353268, 1762.1101343821545, 1766.938157164493, 1110.622388387952, 1135.0975974100609, 1136.193302755053, 1139.4986206069302, 1162.6570161802288, 6775.22084960226, 6776.7628133015105, 6792.0, 6792.320767923267, 6810.795676129724, 7216.8917466238045, 7230.060092188087, 7245.021922040457, 7245.130584329914, 7255.09311336083, 6712.731490740316, 6724.6301453419555, 6748.797536073926, 6776.2546119926765, 6788.744082344782, 3833.6166383361997, 3885.786281754474, 3931.331673615435, 3949.2101579684177, 3950.30869597825, 7492.587907665131, 7503.62481875904, 7504.287092726182, 7522.736704215326, 7533.209013053551, 7289.635518224068, 7307.5980821055355, 7315.0, 7359.926400736032, 7366.373858222111, 7451.2921272479025, 7490.550566966, 7497.850042999218, 7504.58724770132, 7514.436417268617, 7101.519768907673, 7107.857842843217, 7140.428765698628, 7213.278672132745, 7228.783136505703, 7024.4029257513685, 7030.226675065636, 7082.610456424946, 7085.468589855678, 7118.466115041289, 7352.963235184004, 7408.444366672414, 7454.440916931143, 7465.3654439371085, 7491.812704682427, 4850.0, 4896.0, 4912.92630610534, 4917.164082106122, 4921.138800709933, 6992.02111704372, 7167.1757747859665, 7167.820804479721, 7171.995920571228, 7188.4968052235845, 6954.721811127498, 6960.651967401711, 6967.303269673195, 6990.335918087773, 6992.545484543489, 6949.3745562899585, 6953.165620125617, 6960.686769095301, 6968.581885086911, 6971.2331643518155, 6836.282190370139, 6841.213260475109, 6849.828754280983, 6851.109355783717, 6864.4165245954655, 6833.214180369321, 6945.548539344926, 6982.022516847747, 7020.368166865007, 7032.0, 6686.0, 6775.390214880685, 6885.242623311532, 6934.4452443805385, 7077.964610176916], "value": 5274.664875188998, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.6422435118969, 748.244273283983, 765.3838659878795, 768.400647494954, 832.1221111727127, 14015.579532614012, 14143.858561414383, 14232.786508202385, 14247.14517128973, 14252.643683907894, 12970.675733106653, 13028.869711302885, 13039.478420863177, 13053.80419293709, 13062.216267023985, 728.0353531570663, 890.7773056735816, 909.3543584055328, 910.9453432794021, 913.1735779119874, 903.7108125399875, 904.9592768325441, 910.7814124610079, 911.9498427586481, 911.9635214591408, 927.9768005799841, 943.5848226780195, 944.2823454174808, 944.3578366710634, 944.9196818270456, 926.5228407370209, 931.7624005878525, 936.091990768953, 937.2267878999784, 938.5354249646434, 688.8656711941173, 691.7094820175538, 693.1197379328275, 696.435886931587, 698.0053423871015, 13224.404901779442, 13224.537141200108, 13245.735085298336, 13255.337233138402, 13259.734805303937, 13858.4456621735, 13979.65050873726, 14002.229877356742, 14129.364178611988, 14134.081284716563, 10551.0, 10641.840372394421, 10686.0, 10751.78496430067, 10839.512221950032, 3882.4758657581147, 3913.8238779255003, 3944.9408258876138, 3950.0914789598555, 4029.1337362466916, 54051.45948540543, 54511.454885451036, 55503.0, 55997.44002560004, 56242.0, 11281.379524126087, 11400.258983166068, 11440.427978601037, 11492.655220343404, 11612.767744645229, 20729.792702072788, 20816.89591552063, 20976.580468390548, 21168.576628467345, 21264.893675531523, 8048.315893149148, 8286.04710458305, 8312.625931833081, 8346.8330633387, 8429.241368276884, 4779.163646361872, 4829.975850120797, 4843.685160464559, 4890.364252647133, 4953.281774142802, 3541.94687079694, 3557.94663080054, 3572.69632081276, 3594.6225646307284, 3595.658412450813, 584.7923986984559, 603.9939600603938, 618.1839971237923, 624.1137584629837, 632.0203684289334, 687.151368060455, 716.9890454459292, 776.1229810314421, 795.1452188896843, 801.3629164813987, 9640.228781697448, 9938.10557049869, 9951.993445931445, 9977.650782222732, 10116.0, 803.3974519110667, 828.159418190537, 829.5188790501495, 837.4359739420184, 843.371688092375, 4481.484629267611, 4735.668503204812, 4741.288806679026, 4794.7842347094465, 4795.568398844121, 61235.69382153061, 61860.0, 62479.0, 70305.64847175732, 70780.29219707738, 57193.428065718814, 57232.141517877266, 57237.71381143068, 58434.0, 58663.120053199236, 50551.49448505542, 52267.0, 52678.0, 52832.0, 57875.421245787846, 9692.70921872345, 9870.309078364446, 9966.152877005246, 9980.800383992135, 9992.900070999198, 38275.23449530938, 38887.6111238884, 38929.221415572094, 39080.41379379255, 39950.0, 44916.77541612271, 45060.77469612631, 50767.23849142192, 50828.23757643564, 52366.21450678319, 11942.761144777229, 12176.634700958986, 12461.1900226485, 12700.745985080062, 12909.289989050692, 12619.179753316004, 12805.319117311874, 12989.28558929268, 13251.80122298147, 13579.660508487366, 11723.531058757895, 12376.690582735504, 12793.168444051107, 13211.075224734177, 13247.668808279484, 12684.809727854274, 13136.211827290394, 13193.538226162038, 13200.431034482881, 13656.385462654005, 12375.504979801068, 13010.479580816662, 13059.934700326437, 13122.0, 13318.933405332911, 10852.45737713127, 10944.726381840517, 11029.172812039289, 11188.0, 11244.493997769956, 10937.507812148313, 10944.835827462435, 11006.284591501526, 11258.943705281421, 11307.151963602928], "value": 7025.778987892348, "unit": "score"}], "name": "dromaeo_css", "value": 7552.998958696299, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 106.0, 110.0, 113.0, 112.0, 102.0, 113.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 160.0, 177.0, 136.0, 151.0, 157.0, 135.0, 185.0, 128.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 161.0, 162.0, 162.0, 163.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 80.0, 74.0, 168.0, 73.0, 76.0, 78.0, 76.0, 173.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 152.0, 93.0, 95.0, 92.0, 140.0, 92.0, 93.0, 140.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 146.0, 148.0, 147.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 53.0, 54.0, 57.0, 74.0, 57.0, 53.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 75.0, 74.0, 87.0, 74.0, 75.0, 74.0, 74.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 116.0, 113.0, 121.0, 115.0, 113.0, 115.0, 110.0, 134.0, 131.0], "value": 119.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 158.0, 160.0, 162.0, 159.0, 159.0, 172.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 72.0, 65.0, 70.0, 68.0, 69.0, 65.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1525.3, "alertThreshold": 2.0}]} 13:39:34 INFO - Return code: 0 13:39:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:39:34 ERROR - # TBPL SUCCESS # 13:39:34 INFO - Running post-action listener: _resource_record_post_action 13:39:34 INFO - Running post-run listener: _resource_record_post_run 13:39:35 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513814528; Read time: 8; Write time: 509372 13:39:35 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 201400320; Read time: 0; Write time: 313524 13:39:35 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249864192; Read time: 8; Write time: 161468 13:39:35 INFO - Running post-run listener: _upload_blobber_files 13:39:35 INFO - Blob upload gear active. 13:39:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:39:35 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 13:39:35 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'] 13:39:35 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 13:39:35 INFO - (blobuploader) - INFO - Open directory for files ... 13:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:39:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:36 INFO - (blobuploader) - INFO - Done attempting. 13:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:39:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:37 INFO - (blobuploader) - INFO - Done attempting. 13:39:37 INFO - (blobuploader) - INFO - Iteration through files over. 13:39:37 INFO - Return code: 0 13:39:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:39:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:39:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/635105cdcf625452a22712107c0cb117d05b23d649bcc9b6f70b75f85003363900c182de5e2249cb63075bb042c295d07d8a6e28c4a45ef12f5789fa6e8bfbb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd2737938b4af868a57e2b7a100a6f5a90669cb17f33c633ddeb6cf48a63f8d59b7b8e37890d48cb1caf6b6723ded1bff9636355af1e3bc9a454f7bbcda943f0"} 13:39:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:39:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:39:37 INFO - Contents: 13:39:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/635105cdcf625452a22712107c0cb117d05b23d649bcc9b6f70b75f85003363900c182de5e2249cb63075bb042c295d07d8a6e28c4a45ef12f5789fa6e8bfbb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd2737938b4af868a57e2b7a100a6f5a90669cb17f33c633ddeb6cf48a63f8d59b7b8e37890d48cb1caf6b6723ded1bff9636355af1e3bc9a454f7bbcda943f0"} 13:39:37 INFO - Running post-run listener: copy_logs_to_upload_dir 13:39:37 INFO - Copying logs to upload dir... 13:39:37 INFO - mkdir: /builds/slave/test/build/upload/logs 13:39:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.112053 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-31 13:39:36.991858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 13:39:36.994959) ========= 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=232498196343f89f466a4a9a000001c8-1464725689.321902-180437406 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/635105cdcf625452a22712107c0cb117d05b23d649bcc9b6f70b75f85003363900c182de5e2249cb63075bb042c295d07d8a6e28c4a45ef12f5789fa6e8bfbb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd2737938b4af868a57e2b7a100a6f5a90669cb17f33c633ddeb6cf48a63f8d59b7b8e37890d48cb1caf6b6723ded1bff9636355af1e3bc9a454f7bbcda943f0"} build_url:https://queue.taskcluster.net/v1/task/YrDKI9HfQGuUJos8wYJlCw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/YrDKI9HfQGuUJos8wYJlCw/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/635105cdcf625452a22712107c0cb117d05b23d649bcc9b6f70b75f85003363900c182de5e2249cb63075bb042c295d07d8a6e28c4a45ef12f5789fa6e8bfbb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd2737938b4af868a57e2b7a100a6f5a90669cb17f33c633ddeb6cf48a63f8d59b7b8e37890d48cb1caf6b6723ded1bff9636355af1e3bc9a454f7bbcda943f0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 13:39:37.020509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 13:39:37.020797) ========= 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=232498196343f89f466a4a9a000001c8-1464725689.321902-180437406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 13:39:37.105252) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 13:39:37.105573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 13:39:37.105873) ========= ========= Total master_lag: 0.16 =========