builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1460651173.56 results: success (0) buildid: 20160414071051 builduid: 84c751fb1d734afa955c68997472d991 revision: 7bb53c007a2ecde84e470b86ee3ec39fccea9518 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:13.562381) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:13.562920) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:13.563234) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:13.583747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:13.584110) ========= 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=df17445c3590ff7897617a0e00000225-1460651056.329085-53871849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 09:26:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-04-14 09:26:13 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159265 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:13.757748) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:13.758101) ========= 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=df17445c3590ff7897617a0e00000225-1460651056.329085-53871849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015538 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:13.808881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:13.809275) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7bb53c007a2ecde84e470b86ee3ec39fccea9518 --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 7bb53c007a2ecde84e470b86ee3ec39fccea9518 --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=df17445c3590ff7897617a0e00000225-1460651056.329085-53871849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 09:26:14,083 truncating revision to first 12 chars 2016-04-14 09:26:14,083 Setting DEBUG logging. 2016-04-14 09:26:14,083 attempt 1/10 2016-04-14 09:26:14,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7bb53c007a2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 09:26:14,364 unpacking tar archive at: mozilla-aurora-7bb53c007a2e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585927 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:14.408952) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:14.409265) ========= script_repo_revision: 7bb53c007a2ecde84e470b86ee3ec39fccea9518 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:14.409702) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:14.410003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 09:26:14.418030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-14 09:26:14.418329) ========= /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=df17445c3590ff7897617a0e00000225-1460651056.329085-53871849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:26:14 INFO - MultiFileLogger online at 20160414 09:26:14 in /builds/slave/test 09:26:14 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 09:26:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:26:14 INFO - {'append_to_log': False, 09:26:14 INFO - 'base_work_dir': '/builds/slave/test', 09:26:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:26:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:26:14 INFO - 'branch': 'Mozilla-Aurora', 09:26:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:26:14 INFO - 'config_files': ('talos/linux_config.py',), 09:26:14 INFO - 'default_actions': ('clobber', 09:26:14 INFO - 'read-buildbot-config', 09:26:14 INFO - 'download-and-extract', 09:26:14 INFO - 'populate-webroot', 09:26:14 INFO - 'create-virtualenv', 09:26:14 INFO - 'install', 09:26:14 INFO - 'run-tests'), 09:26:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:26:14 INFO - 'download_minidump_stackwalk': True, 09:26:14 INFO - 'download_symbols': 'ondemand', 09:26:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:26:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:26:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:26:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:26:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:26:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:26:14 INFO - 'installer_path': 'installer.exe', 09:26:14 INFO - 'log_level': 'info', 09:26:14 INFO - 'log_name': 'talos', 09:26:14 INFO - 'log_to_console': True, 09:26:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:26:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:26:14 INFO - 'opt_config_files': (), 09:26:14 INFO - 'pip_index': False, 09:26:14 INFO - 'sps_profile': False, 09:26:14 INFO - 'sps_profile_interval': 0, 09:26:14 INFO - 'suite': 'dromaeojs-e10s', 09:26:14 INFO - 'system_bits': '32', 09:26:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:26:14 INFO - 'title': 'talos-linux64-ix-021', 09:26:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:26:14 INFO - 'use_talos_json': True, 09:26:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:26:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:26:14 INFO - 'work_dir': 'build'} 09:26:14 INFO - ##### 09:26:14 INFO - ##### Running clobber step. 09:26:14 INFO - ##### 09:26:14 INFO - Running pre-action listener: _resource_record_pre_action 09:26:14 INFO - Running main action method: clobber 09:26:14 INFO - rmtree: /builds/slave/test/build 09:26:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:26:15 INFO - Running post-action listener: _resource_record_post_action 09:26:15 INFO - ##### 09:26:15 INFO - ##### Running read-buildbot-config step. 09:26:15 INFO - ##### 09:26:15 INFO - Running pre-action listener: _resource_record_pre_action 09:26:15 INFO - Running main action method: read_buildbot_config 09:26:15 INFO - Using buildbot properties: 09:26:15 INFO - { 09:26:15 INFO - "project": "", 09:26:15 INFO - "product": "firefox", 09:26:15 INFO - "script_repo_revision": "production", 09:26:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:26:15 INFO - "repository": "", 09:26:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:26:15 INFO - "buildid": "20160414071051", 09:26:15 INFO - "pgo_build": "True", 09:26:15 INFO - "basedir": "/builds/slave/test", 09:26:15 INFO - "buildnumber": 202, 09:26:15 INFO - "slavename": "talos-linux64-ix-021", 09:26:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:26:15 INFO - "platform": "ubuntu64_hw", 09:26:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:26:15 INFO - "branch": "mozilla-aurora", 09:26:15 INFO - "repo_path": "releases/mozilla-aurora", 09:26:15 INFO - "revision": "7bb53c007a2ecde84e470b86ee3ec39fccea9518", 09:26:15 INFO - "stage_platform": "linux64-pgo", 09:26:15 INFO - "builduid": "84c751fb1d734afa955c68997472d991", 09:26:15 INFO - "slavebuilddir": "test" 09:26:15 INFO - } 09:26:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 09:26:15 INFO - Running post-action listener: _resource_record_post_action 09:26:15 INFO - ##### 09:26:15 INFO - ##### Running download-and-extract step. 09:26:15 INFO - ##### 09:26:15 INFO - Running pre-action listener: _resource_record_pre_action 09:26:15 INFO - Running main action method: download_and_extract 09:26:15 INFO - mkdir: /builds/slave/test/build/tests 09:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:15 INFO - https://queue.taskcluster.net/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:26:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:26:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:26:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:26:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:26:27 INFO - Downloaded 1448 bytes. 09:26:27 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:26:27 INFO - Using the following test package requirements: 09:26:27 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:26:27 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:26:27 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:26:27 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:27 INFO - u'jsshell-linux-x86_64.zip'], 09:26:27 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:26:27 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:26:27 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:26:27 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:26:27 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:26:27 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:26:27 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:26:27 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:26:27 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')]} 09:26:27 INFO - https://queue.taskcluster.net/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:26:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:26:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:26:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:26:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:26:35 INFO - Downloaded 23352318 bytes. 09:26:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:26:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:26:36 INFO - Return code: 0 09:26:36 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:26:36 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')]} 09:26:36 INFO - https://queue.taskcluster.net/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:26:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:26:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:26:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:26:37 INFO - Downloaded 23352318 bytes. 09:26:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:26:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:26:39 INFO - Return code: 0 09:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:39 INFO - https://queue.taskcluster.net/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:26:40 INFO - Downloaded 10845168 bytes. 09:26:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:26:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:26:41 INFO - Return code: 0 09:26: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')]} 09:26:41 INFO - https://queue.taskcluster.net/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:26:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:26:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:26:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:26:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:26:42 INFO - Downloaded 60576010 bytes. 09:26:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:26:42 INFO - mkdir: /builds/slave/test/properties 09:26:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:26:42 INFO - Writing to file /builds/slave/test/properties/build_url 09:26:42 INFO - Contents: 09:26:42 INFO - build_url:https://queue.taskcluster.net/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:26:43 INFO - Running post-action listener: _resource_record_post_action 09:26:43 INFO - Running post-action listener: set_extra_try_arguments 09:26:43 INFO - ##### 09:26:43 INFO - ##### Running populate-webroot step. 09:26:43 INFO - ##### 09:26:43 INFO - Running pre-action listener: _resource_record_pre_action 09:26:43 INFO - Running main action method: populate_webroot 09:26:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:26:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:26:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:26:43 INFO - '--tppagecycles', 09:26:43 INFO - '7'], 09:26:43 INFO - 'tests': ['tsvgm']}}, 09:26:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:26:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:26:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:26:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:26:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:26:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:26:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:43 INFO - 'talos_options': ['--e10s'], 09:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:43 INFO - 'tests': ['damp', 'tps']}, 09:26:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:43 INFO - 'talos_options': ['--e10s'], 09:26:43 INFO - 'tests': ['damp', 'tps']}, 09:26:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:26:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:26:43 INFO - 'other': {'tests': ['a11yr', 09:26:43 INFO - 'ts_paint', 09:26:43 INFO - 'tpaint', 09:26:43 INFO - 'sessionrestore', 09:26:43 INFO - 'sessionrestore_no_auto_restore', 09:26:43 INFO - 'tabpaint']}, 09:26:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:26:43 INFO - 'tests': ['a11yr', 09:26:43 INFO - 'ts_paint', 09:26:43 INFO - 'tpaint', 09:26:43 INFO - 'sessionrestore', 09:26:43 INFO - 'sessionrestore_no_auto_restore', 09:26:43 INFO - 'tabpaint']}, 09:26:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:26:43 INFO - 'tests': ['a11yr', 09:26:43 INFO - 'ts_paint', 09:26:43 INFO - 'tpaint', 09:26:43 INFO - 'sessionrestore', 09:26:43 INFO - 'sessionrestore_no_auto_restore', 09:26:43 INFO - 'tabpaint']}, 09:26:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:26:43 INFO - 'tests': ['a11yr', 09:26:43 INFO - 'ts_paint', 09:26:43 INFO - 'tpaint', 09:26:43 INFO - 'sessionrestore', 09:26:43 INFO - 'sessionrestore_no_auto_restore', 09:26:43 INFO - 'tabpaint']}, 09:26:43 INFO - 'other_l64': {'tests': ['a11yr', 09:26:43 INFO - 'ts_paint', 09:26:43 INFO - 'tpaint', 09:26:43 INFO - 'sessionrestore', 09:26:43 INFO - 'sessionrestore_no_auto_restore', 09:26:43 INFO - 'tabpaint']}, 09:26:43 INFO - 'other_nol64': {'tests': ['a11yr', 09:26:43 INFO - 'ts_paint', 09:26:43 INFO - 'tpaint', 09:26:43 INFO - 'sessionrestore', 09:26:43 INFO - 'sessionrestore_no_auto_restore', 09:26:43 INFO - 'tabpaint']}, 09:26:43 INFO - 'svgr': {'tests': ['tsvgx', 09:26:43 INFO - 'tsvgr_opacity', 09:26:43 INFO - 'tart', 09:26:43 INFO - 'tscrollx', 09:26:43 INFO - 'cart']}, 09:26:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:26:43 INFO - 'tests': ['tsvgx', 09:26:43 INFO - 'tsvgr_opacity', 09:26:43 INFO - 'tart', 09:26:43 INFO - 'tscrollx', 09:26:43 INFO - 'cart']}, 09:26:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:43 INFO - 'tests': ['tp5o']}, 09:26:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:43 INFO - 'talos_options': ['--e10s'], 09:26:43 INFO - 'tests': ['tp5o']}, 09:26:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:43 INFO - 'talos_options': ['--xperf_path', 09:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:43 INFO - 'tests': ['tp5n']}, 09:26:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:43 INFO - 'talos_options': ['--e10s', 09:26:43 INFO - '--xperf_path', 09:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:43 INFO - 'tests': ['tp5n']}}, 09:26:43 INFO - 'talos.zip': {'path': '', 09:26:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:26:43 INFO - Running post-action listener: _resource_record_post_action 09:26:43 INFO - ##### 09:26:43 INFO - ##### Running create-virtualenv step. 09:26:43 INFO - ##### 09:26:43 INFO - Running pre-action listener: _resource_record_pre_action 09:26:43 INFO - Running main action method: create_virtualenv 09:26:43 INFO - Creating virtualenv /builds/slave/test/build/venv 09:26:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:26:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:26:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:26:43 INFO - Using real prefix '/usr' 09:26:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:26:44 INFO - Installing distribute.............................................................................................................................................................................................done. 09:26:46 INFO - Installing pip.................done. 09:26:46 INFO - Return code: 0 09:26:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1757603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f8160>, '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 0x22f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f94f0>, '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': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', '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 09:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:26:46 INFO - Using env: {'DISPLAY': ':0', 09:26:46 INFO - 'HOME': '/home/cltbld', 09:26:46 INFO - 'LANG': 'en_US.UTF-8', 09:26:46 INFO - 'LANGUAGE': 'en_US:en', 09:26:46 INFO - 'LOGNAME': 'cltbld', 09:26:46 INFO - 'MAIL': '/var/mail/cltbld', 09:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:46 INFO - 'MOZ_NO_REMOTE': '1', 09:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:46 INFO - 'NO_EM_RESTART': '1', 09:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:46 INFO - 'PWD': '/builds/slave/test', 09:26:46 INFO - 'SHELL': '/bin/bash', 09:26:46 INFO - 'SHLVL': '1', 09:26:46 INFO - 'TERM': 'linux', 09:26:46 INFO - 'TMOUT': '86400', 09:26:46 INFO - 'USER': 'cltbld', 09:26:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', 09:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:46 INFO - '_': '/tools/buildbot/bin/python'} 09:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:46 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 09:26:46 INFO - Cleaning up... 09:26:46 INFO - Return code: 0 09:26:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1757603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f8160>, '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 0x22f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f94f0>, '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': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', '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 09:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:26:46 INFO - Using env: {'DISPLAY': ':0', 09:26:46 INFO - 'HOME': '/home/cltbld', 09:26:46 INFO - 'LANG': 'en_US.UTF-8', 09:26:46 INFO - 'LANGUAGE': 'en_US:en', 09:26:46 INFO - 'LOGNAME': 'cltbld', 09:26:46 INFO - 'MAIL': '/var/mail/cltbld', 09:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:46 INFO - 'MOZ_NO_REMOTE': '1', 09:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:46 INFO - 'NO_EM_RESTART': '1', 09:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:46 INFO - 'PWD': '/builds/slave/test', 09:26:46 INFO - 'SHELL': '/bin/bash', 09:26:46 INFO - 'SHLVL': '1', 09:26:46 INFO - 'TERM': 'linux', 09:26:46 INFO - 'TMOUT': '86400', 09:26:46 INFO - 'USER': 'cltbld', 09:26:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', 09:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:46 INFO - '_': '/tools/buildbot/bin/python'} 09:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:46 INFO - Downloading/unpacking psutil>=0.7.1 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:26:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:48 INFO - Installing collected packages: psutil 09:26:48 INFO - Running setup.py install for psutil 09:26:48 INFO - building 'psutil._psutil_linux' extension 09:26:48 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 09:26:48 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 09:26:48 INFO - building 'psutil._psutil_posix' extension 09:26:48 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 09:26:49 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 09:26:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:49 INFO - Successfully installed psutil 09:26:49 INFO - Cleaning up... 09:26:49 INFO - Return code: 0 09:26:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1757603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f8160>, '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 0x22f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f94f0>, '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': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', '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 09:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:26:49 INFO - Using env: {'DISPLAY': ':0', 09:26:49 INFO - 'HOME': '/home/cltbld', 09:26:49 INFO - 'LANG': 'en_US.UTF-8', 09:26:49 INFO - 'LANGUAGE': 'en_US:en', 09:26:49 INFO - 'LOGNAME': 'cltbld', 09:26:49 INFO - 'MAIL': '/var/mail/cltbld', 09:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:49 INFO - 'MOZ_NO_REMOTE': '1', 09:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:49 INFO - 'NO_EM_RESTART': '1', 09:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:49 INFO - 'PWD': '/builds/slave/test', 09:26:49 INFO - 'SHELL': '/bin/bash', 09:26:49 INFO - 'SHLVL': '1', 09:26:49 INFO - 'TERM': 'linux', 09:26:49 INFO - 'TMOUT': '86400', 09:26:49 INFO - 'USER': 'cltbld', 09:26:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', 09:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:49 INFO - '_': '/tools/buildbot/bin/python'} 09:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:26:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:26:51 INFO - Installing collected packages: mozsystemmonitor 09:26:51 INFO - Running setup.py install for mozsystemmonitor 09:26:51 INFO - Successfully installed mozsystemmonitor 09:26:51 INFO - Cleaning up... 09:26:51 INFO - Return code: 0 09:26:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:26:51 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')]} 09:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:51 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')]} 09:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:51 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 0x7f1757603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f8160>, '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 0x22f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f94f0>, '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': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', '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 09:26:51 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 09:26:51 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 09:26:51 INFO - Using env: {'DISPLAY': ':0', 09:26:51 INFO - 'HOME': '/home/cltbld', 09:26:51 INFO - 'LANG': 'en_US.UTF-8', 09:26:51 INFO - 'LANGUAGE': 'en_US:en', 09:26:51 INFO - 'LOGNAME': 'cltbld', 09:26:51 INFO - 'MAIL': '/var/mail/cltbld', 09:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:51 INFO - 'MOZ_NO_REMOTE': '1', 09:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:51 INFO - 'NO_EM_RESTART': '1', 09:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:51 INFO - 'PWD': '/builds/slave/test', 09:26:51 INFO - 'SHELL': '/bin/bash', 09:26:51 INFO - 'SHLVL': '1', 09:26:51 INFO - 'TERM': 'linux', 09:26:51 INFO - 'TMOUT': '86400', 09:26:51 INFO - 'USER': 'cltbld', 09:26:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', 09:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:51 INFO - '_': '/tools/buildbot/bin/python'} 09:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:53 INFO - Downloading blobuploader-1.2.4.tar.gz 09:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:26:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:26:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:26:54 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 09:26:54 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 09:26:54 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 09:26:54 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 09:26:54 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 09:26:54 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 09:26:54 INFO - Downloading docopt-0.6.1.tar.gz 09:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:26:54 INFO - Installing collected packages: blobuploader, requests, docopt 09:26:54 INFO - Running setup.py install for blobuploader 09:26:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:26:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:26:54 INFO - Running setup.py install for requests 09:26:54 INFO - Running setup.py install for docopt 09:26:54 INFO - Successfully installed blobuploader requests docopt 09:26:54 INFO - Cleaning up... 09:26:54 INFO - Return code: 0 09:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:54 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')]} 09:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:54 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')]} 09:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:54 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 0x7f1757603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f8160>, '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 0x22f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f94f0>, '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': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', '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 09:26:54 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 09:26:54 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 09:26:54 INFO - Using env: {'DISPLAY': ':0', 09:26:54 INFO - 'HOME': '/home/cltbld', 09:26:54 INFO - 'LANG': 'en_US.UTF-8', 09:26:54 INFO - 'LANGUAGE': 'en_US:en', 09:26:54 INFO - 'LOGNAME': 'cltbld', 09:26:54 INFO - 'MAIL': '/var/mail/cltbld', 09:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:54 INFO - 'MOZ_NO_REMOTE': '1', 09:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:54 INFO - 'NO_EM_RESTART': '1', 09:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:54 INFO - 'PWD': '/builds/slave/test', 09:26:54 INFO - 'SHELL': '/bin/bash', 09:26:54 INFO - 'SHLVL': '1', 09:26:54 INFO - 'TERM': 'linux', 09:26:54 INFO - 'TMOUT': '86400', 09:26:54 INFO - 'USER': 'cltbld', 09:26:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', 09:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:54 INFO - '_': '/tools/buildbot/bin/python'} 09:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:55 INFO - Running setup.py (path:/tmp/pip-0uG1Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:55 INFO - Running setup.py (path:/tmp/pip-Rgm5SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:55 INFO - Running setup.py (path:/tmp/pip-tkJZA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:55 INFO - Running setup.py (path:/tmp/pip-c7DFoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:55 INFO - Running setup.py (path:/tmp/pip-Eup6W3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:55 INFO - Running setup.py (path:/tmp/pip-IJ7oTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:55 INFO - Running setup.py (path:/tmp/pip-ub1nJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:55 INFO - Running setup.py (path:/tmp/pip-teCzOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:55 INFO - Running setup.py (path:/tmp/pip-_UL6AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:55 INFO - Running setup.py (path:/tmp/pip-H9Z2v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:55 INFO - Running setup.py (path:/tmp/pip-nqHSlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:55 INFO - Running setup.py (path:/tmp/pip-nT63qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:56 INFO - Running setup.py (path:/tmp/pip-g1dZTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:56 INFO - Running setup.py (path:/tmp/pip-3GAoJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:56 INFO - Running setup.py (path:/tmp/pip-R5gEFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:56 INFO - Running setup.py (path:/tmp/pip-tR2UF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:56 INFO - Running setup.py (path:/tmp/pip-QxM4VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:26:56 INFO - Running setup.py install for manifestparser 09:26:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:26:56 INFO - Running setup.py install for mozcrash 09:26:56 INFO - Running setup.py install for mozdebug 09:26:56 INFO - Running setup.py install for mozdevice 09:26:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:26:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:26:56 INFO - Running setup.py install for mozfile 09:26:56 INFO - Running setup.py install for mozhttpd 09:26:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:26:56 INFO - Running setup.py install for mozinfo 09:26:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Running setup.py install for mozInstall 09:26:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Running setup.py install for mozleak 09:26:57 INFO - Running setup.py install for mozlog 09:26:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Running setup.py install for moznetwork 09:26:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Running setup.py install for mozprocess 09:26:57 INFO - Running setup.py install for mozprofile 09:26:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Running setup.py install for mozrunner 09:26:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:26:57 INFO - Running setup.py install for mozscreenshot 09:26:57 INFO - Running setup.py install for moztest 09:26:58 INFO - Running setup.py install for mozversion 09:26:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:26:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:26:58 INFO - Cleaning up... 09:26:58 INFO - Return code: 0 09:26:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:58 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')]} 09:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:58 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')]} 09:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:58 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 0x7f1757603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f8160>, '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 0x22f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f94f0>, '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': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', '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 09:26:58 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 09:26:58 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 09:26:58 INFO - Using env: {'DISPLAY': ':0', 09:26:58 INFO - 'HOME': '/home/cltbld', 09:26:58 INFO - 'LANG': 'en_US.UTF-8', 09:26:58 INFO - 'LANGUAGE': 'en_US:en', 09:26:58 INFO - 'LOGNAME': 'cltbld', 09:26:58 INFO - 'MAIL': '/var/mail/cltbld', 09:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:58 INFO - 'MOZ_NO_REMOTE': '1', 09:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:58 INFO - 'NO_EM_RESTART': '1', 09:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:58 INFO - 'PWD': '/builds/slave/test', 09:26:58 INFO - 'SHELL': '/bin/bash', 09:26:58 INFO - 'SHLVL': '1', 09:26:58 INFO - 'TERM': 'linux', 09:26:58 INFO - 'TMOUT': '86400', 09:26:58 INFO - 'USER': 'cltbld', 09:26:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', 09:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:58 INFO - '_': '/tools/buildbot/bin/python'} 09:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:58 INFO - Running setup.py (path:/tmp/pip-zJeWhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:58 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)) 09:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:58 INFO - Running setup.py (path:/tmp/pip-RFh8ZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:58 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)) 09:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:58 INFO - Running setup.py (path:/tmp/pip-KYbVTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:58 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)) 09:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:58 INFO - Running setup.py (path:/tmp/pip-A376Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:58 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)) 09:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:58 INFO - Running setup.py (path:/tmp/pip-LAlBOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:58 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)) 09:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:58 INFO - Running setup.py (path:/tmp/pip-TK6GT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:58 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)) 09:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:58 INFO - Running setup.py (path:/tmp/pip-DaAJv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:58 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)) 09:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:58 INFO - Running setup.py (path:/tmp/pip-lIx92D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:58 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)) 09:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:58 INFO - Running setup.py (path:/tmp/pip-NtDcLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:58 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)) 09:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:59 INFO - Running setup.py (path:/tmp/pip-YMW7Sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:59 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)) 09:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:59 INFO - Running setup.py (path:/tmp/pip-Bs_OWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:59 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)) 09:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:59 INFO - Running setup.py (path:/tmp/pip-LXkwlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:59 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)) 09:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:59 INFO - Running setup.py (path:/tmp/pip-Jkor12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:59 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)) 09:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:59 INFO - Running setup.py (path:/tmp/pip-uGnUMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:59 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)) 09:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:59 INFO - Running setup.py (path:/tmp/pip-WOQ0vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:59 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)) 09:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:59 INFO - Running setup.py (path:/tmp/pip-oa9JYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:59 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)) 09:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:59 INFO - Running setup.py (path:/tmp/pip-kPnZ8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:59 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)) 09:26:59 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)) 09:26:59 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)) 09:26:59 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)) 09:26:59 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)) 09:26:59 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)) 09:26:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:26:59 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 09:26:59 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 09:26:59 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 09:26:59 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 09:26:59 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 09:26:59 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 09:27:01 INFO - Downloading blessings-1.6.tar.gz 09:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:27:01 INFO - Installing collected packages: blessings 09:27:01 INFO - Running setup.py install for blessings 09:27:01 INFO - Successfully installed blessings 09:27:01 INFO - Cleaning up... 09:27:01 INFO - Return code: 0 09:27:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:01 INFO - Reading from file tmpfile_stdout 09:27:01 INFO - Current package versions: 09:27:01 INFO - argparse == 1.2.1 09:27:01 INFO - blessings == 1.6 09:27:01 INFO - blobuploader == 1.2.4 09:27:01 INFO - docopt == 0.6.1 09:27:01 INFO - manifestparser == 1.1 09:27:01 INFO - mozInstall == 1.12 09:27:01 INFO - mozcrash == 0.17 09:27:01 INFO - mozdebug == 0.1 09:27:01 INFO - mozdevice == 0.48 09:27:01 INFO - mozfile == 1.2 09:27:01 INFO - mozhttpd == 0.7 09:27:01 INFO - mozinfo == 0.9 09:27:01 INFO - mozleak == 0.1 09:27:01 INFO - mozlog == 3.1 09:27:01 INFO - moznetwork == 0.27 09:27:01 INFO - mozprocess == 0.22 09:27:01 INFO - mozprofile == 0.28 09:27:01 INFO - mozrunner == 6.11 09:27:01 INFO - mozscreenshot == 0.1 09:27:01 INFO - mozsystemmonitor == 0.0 09:27:01 INFO - moztest == 0.7 09:27:01 INFO - mozversion == 1.4 09:27:01 INFO - psutil == 3.1.1 09:27:01 INFO - requests == 1.2.3 09:27:01 INFO - wsgiref == 0.1.2 09:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:01 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 0x7f1757603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f8160>, '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 0x22f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f94f0>, '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': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', '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 09:27:01 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 09:27:01 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 09:27:01 INFO - Using env: {'DISPLAY': ':0', 09:27:01 INFO - 'HOME': '/home/cltbld', 09:27:01 INFO - 'LANG': 'en_US.UTF-8', 09:27:01 INFO - 'LANGUAGE': 'en_US:en', 09:27:01 INFO - 'LOGNAME': 'cltbld', 09:27:01 INFO - 'MAIL': '/var/mail/cltbld', 09:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:01 INFO - 'MOZ_NO_REMOTE': '1', 09:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:01 INFO - 'NO_EM_RESTART': '1', 09:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:01 INFO - 'PWD': '/builds/slave/test', 09:27:01 INFO - 'SHELL': '/bin/bash', 09:27:01 INFO - 'SHLVL': '1', 09:27:01 INFO - 'TERM': 'linux', 09:27:01 INFO - 'TMOUT': '86400', 09:27:01 INFO - 'USER': 'cltbld', 09:27:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', 09:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:01 INFO - '_': '/tools/buildbot/bin/python'} 09:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:02 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)) 09:27:02 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)) 09:27:02 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)) 09:27:02 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)) 09:27:02 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)) 09:27:02 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)) 09:27:02 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)) 09:27:02 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)) 09:27:02 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)) 09:27:02 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)) 09:27:02 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)) 09:27:02 INFO - Cleaning up... 09:27:02 INFO - Return code: 0 09:27:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:02 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 0x7f1757603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f8160>, '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 0x22f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f94f0>, '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': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', '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 09:27:02 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 09:27:02 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 09:27:02 INFO - Using env: {'DISPLAY': ':0', 09:27:02 INFO - 'HOME': '/home/cltbld', 09:27:02 INFO - 'LANG': 'en_US.UTF-8', 09:27:02 INFO - 'LANGUAGE': 'en_US:en', 09:27:02 INFO - 'LOGNAME': 'cltbld', 09:27:02 INFO - 'MAIL': '/var/mail/cltbld', 09:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:02 INFO - 'MOZ_NO_REMOTE': '1', 09:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:02 INFO - 'NO_EM_RESTART': '1', 09:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:02 INFO - 'PWD': '/builds/slave/test', 09:27:02 INFO - 'SHELL': '/bin/bash', 09:27:02 INFO - 'SHLVL': '1', 09:27:02 INFO - 'TERM': 'linux', 09:27:02 INFO - 'TMOUT': '86400', 09:27:02 INFO - 'USER': 'cltbld', 09:27:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', 09:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:02 INFO - '_': '/tools/buildbot/bin/python'} 09:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:02 INFO - Downloading/unpacking jsonschema 09:27:02 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 09:27:02 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 09:27:02 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 09:27:02 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 09:27:02 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 09:27:02 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 09:27:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:27:04 INFO - Downloading/unpacking functools32 (from jsonschema) 09:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:27:04 INFO - warning: no files found matching '*.txt' 09:27:04 INFO - no previously-included directories found matching 'build' 09:27:04 INFO - no previously-included directories found matching 'dist' 09:27:04 INFO - no previously-included directories found matching '.git*' 09:27:04 INFO - Installing collected packages: jsonschema, functools32 09:27:04 INFO - Running setup.py install for functools32 09:27:04 INFO - warning: no files found matching '*.txt' 09:27:04 INFO - no previously-included directories found matching 'build' 09:27:04 INFO - no previously-included directories found matching 'dist' 09:27:04 INFO - no previously-included directories found matching '.git*' 09:27:04 INFO - Successfully installed jsonschema functools32 09:27:04 INFO - Cleaning up... 09:27:04 INFO - Return code: 0 09:27:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:27:04 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')]} 09:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:04 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')]} 09:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:04 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 0x7f1757603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f8160>, '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 0x22f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f94f0>, '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': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', '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 09:27:04 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 09:27:04 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 09:27:04 INFO - Using env: {'DISPLAY': ':0', 09:27:04 INFO - 'HOME': '/home/cltbld', 09:27:04 INFO - 'LANG': 'en_US.UTF-8', 09:27:04 INFO - 'LANGUAGE': 'en_US:en', 09:27:04 INFO - 'LOGNAME': 'cltbld', 09:27:04 INFO - 'MAIL': '/var/mail/cltbld', 09:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:04 INFO - 'MOZ_NO_REMOTE': '1', 09:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:04 INFO - 'NO_EM_RESTART': '1', 09:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:04 INFO - 'PWD': '/builds/slave/test', 09:27:04 INFO - 'SHELL': '/bin/bash', 09:27:04 INFO - 'SHLVL': '1', 09:27:04 INFO - 'TERM': 'linux', 09:27:04 INFO - 'TMOUT': '86400', 09:27:04 INFO - 'USER': 'cltbld', 09:27:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', 09:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:04 INFO - '_': '/tools/buildbot/bin/python'} 09:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:04 INFO - Downloading/unpacking flake8 09:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:27:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:27:06 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 09:27:06 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 09:27:06 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 09:27:06 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 09:27:06 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 09:27:06 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 09:27:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:27:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:27:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:27:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:27:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:27:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:27:07 INFO - no previously-included directories found matching 'docs/_build' 09:27:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:27:07 INFO - Running setup.py install for pep8 09:27:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:27:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:27:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:27:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:27:07 INFO - no previously-included directories found matching 'docs/_build' 09:27:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:27:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:27:07 INFO - Cleaning up... 09:27:07 INFO - Return code: 0 09:27:07 INFO - Running post-action listener: _resource_record_post_action 09:27:07 INFO - Running post-action listener: _start_resource_monitoring 09:27:07 INFO - Starting resource monitoring. 09:27:07 INFO - ##### 09:27:07 INFO - ##### Running install step. 09:27:07 INFO - ##### 09:27:07 INFO - Running pre-action listener: _resource_record_pre_action 09:27:07 INFO - Running main action method: install 09:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:08 INFO - Reading from file tmpfile_stdout 09:27:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:27:08 INFO - Reading from file tmpfile_stdout 09:27:08 INFO - Output received: 09:27:08 INFO - Usage: mozinstall [options] installer 09:27:08 INFO - Options: 09:27:08 INFO - -h, --help show this help message and exit 09:27:08 INFO - -d DEST, --destination=DEST 09:27:08 INFO - Directory to install application into. [default: 09:27:08 INFO - "/builds/slave/test"] 09:27:08 INFO - --app=APP Application being installed. [default: firefox] 09:27:08 INFO - mkdir: /builds/slave/test/build/application 09:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:27:23 INFO - Reading from file tmpfile_stdout 09:27:23 INFO - Output received: 09:27:23 INFO - /builds/slave/test/build/application/firefox/firefox 09:27:23 INFO - Running post-action listener: _resource_record_post_action 09:27:23 INFO - ##### 09:27:23 INFO - ##### Running run-tests step. 09:27:23 INFO - ##### 09:27:23 INFO - Running pre-action listener: _resource_record_pre_action 09:27:23 INFO - Running main action method: run_tests 09:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:27:23 INFO - Python 2.7.3 09:27:23 INFO - Return code: 0 09:27:23 INFO - grabbing minidump binary from tooltool 09:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:27:23 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 0x22f8160>, '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 0x22f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f94f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:27:23 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 09:27:23 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 09:27:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:27:23 INFO - Return code: 0 09:27:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:27:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:27:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:27:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:27:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:27:24 INFO - Return code: 0 09:27:24 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/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 09:27:24 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/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 09:27:24 INFO - Using env: {'DISPLAY': ':0', 09:27:24 INFO - 'HOME': '/home/cltbld', 09:27:24 INFO - 'LANG': 'en_US.UTF-8', 09:27:24 INFO - 'LANGUAGE': 'en_US:en', 09:27:24 INFO - 'LOGNAME': 'cltbld', 09:27:24 INFO - 'MAIL': '/var/mail/cltbld', 09:27:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:27:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:24 INFO - 'MOZ_NO_REMOTE': '1', 09:27:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:24 INFO - 'NO_EM_RESTART': '1', 09:27:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:24 INFO - 'PWD': '/builds/slave/test', 09:27:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:27:24 INFO - 'SHELL': '/bin/bash', 09:27:24 INFO - 'SHLVL': '1', 09:27:24 INFO - 'TERM': 'linux', 09:27:24 INFO - 'TMOUT': '86400', 09:27:24 INFO - 'USER': 'cltbld', 09:27:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460651056.329085-53871849', 09:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:24 INFO - '_': '/tools/buildbot/bin/python'} 09:27:24 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/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 09:27:24 INFO - mozversion application_buildid: 20160414071051 09:27:24 INFO - mozversion application_changeset: 7bb53c007a2ecde84e470b86ee3ec39fccea9518 09:27:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:27:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:27:24 INFO - mozversion application_name: Firefox 09:27:24 INFO - mozversion application_remotingname: firefox-dev 09:27:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:27:24 INFO - mozversion application_vendor: Mozilla 09:27:24 INFO - mozversion application_version: 47.0a2 09:27:24 INFO - mozversion platform_buildid: 20160414071051 09:27:24 INFO - mozversion platform_changeset: 7bb53c007a2ecde84e470b86ee3ec39fccea9518 09:27:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:27:24 INFO - mozversion platform_version: 47.0a2 09:27:24 INFO - using testdate: 1460651244 09:27:24 INFO - actual date: 1460651244 09:27:24 INFO - starting webserver on 'localhost:56832' 09:27:24 INFO - SUITE-START | Running 2 tests 09:27:24 INFO - TEST-START | dromaeo_css 09:27:24 INFO - operating with platform_type : linux_ 09:27:24 INFO - Initialising browser for dromaeo_css test... 09:27:24 INFO - TEST-INFO | started process 13806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT1MS6h/profile http://localhost:56832/getInfo.html) 09:27:29 INFO - PROCESS | 13806 | 09:27:29 INFO - PROCESS | 13806 | (process:13881): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:27:30 INFO - PROCESS | 13806 | __metrics Screen width/height:1600/1200 09:27:30 INFO - PROCESS | 13806 | colorDepth:24 09:27:30 INFO - PROCESS | 13806 | Browser inner width/height: 1024/697 09:27:30 INFO - PROCESS | 13806 | __metrics 09:27:31 ERROR - PROCESS | 13806 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:27:32 INFO - TEST-INFO | 13806: exit 0 09:27:32 INFO - Browser initialized. 09:27:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:27:32 INFO - TEST-INFO | started process 13932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT1MS6h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:33 INFO - PROCESS | 13932 | 09:27:33 INFO - PROCESS | 13932 | (process:14000): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:27:43 INFO - PROCESS | 13932 | RSS: Main: 150847488 09:27:43 INFO - PROCESS | 13932 | 09:28:33 INFO - PROCESS | 13932 | 1460651313470 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] 09:30:41 INFO - PROCESS | 13932 | Cycle 1(1): loaded http://localhost:56832/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56832/tests/dromaeo/cssquery-ext.html) 09:30:42 INFO - PROCESS | 13932 | RSS: Main: 154939392 09:30:42 INFO - PROCESS | 13932 | 09:33:44 INFO - PROCESS | 13932 | Cycle 1(1): loaded http://localhost:56832/tests/dromaeo/cssquery-ext.html (next: http://localhost:56832/tests/dromaeo/cssquery-jquery.html) 09:33:45 INFO - PROCESS | 13932 | RSS: Main: 153272320 09:33:45 INFO - PROCESS | 13932 | 09:36:46 INFO - PROCESS | 13932 | Cycle 1(1): loaded http://localhost:56832/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56832/tests/dromaeo/cssquery-mootools.html) 09:36:47 INFO - PROCESS | 13932 | RSS: Main: 152756224 09:36:47 INFO - PROCESS | 13932 | 09:39:49 INFO - PROCESS | 13932 | Cycle 1(1): loaded http://localhost:56832/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56832/tests/dromaeo/cssquery-prototype.html) 09:39:49 INFO - PROCESS | 13932 | RSS: Main: 152301568 09:39:49 INFO - PROCESS | 13932 | 09:42:52 INFO - PROCESS | 13932 | Cycle 1(1): loaded http://localhost:56832/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56832/tests/dromaeo/cssquery-yui.html) 09:42:52 INFO - PROCESS | 13932 | RSS: Main: 153980928 09:42:52 INFO - PROCESS | 13932 | 09:45:54 INFO - PROCESS | 13932 | Cycle 1(1): loaded http://localhost:56832/tests/dromaeo/cssquery-yui.html (next: http://localhost:56832/tests/dromaeo/cssquery-dojo.html) 09:45:55 INFO - PROCESS | 13932 | RSS: Main: 155324416 09:45:55 INFO - PROCESS | 13932 | 09:45:55 INFO - PROCESS | 13932 | __start_tp_report 09:45:55 INFO - PROCESS | 13932 | _x_x_mozilla_page_load 09:45:55 INFO - PROCESS | 13932 | _x_x_mozilla_page_load_details 09:45:55 INFO - PROCESS | 13932 | |i|pagename|runs| 09:45:55 INFO - PROCESS | 13932 | |0;dojo.html;3328.6172090209625;3378.7297016238704;3379.442392005319;3415.880444184454;3426.948595771062;5529.060059789836;5552.222688823558;5588.776448942042;5595.86010349741;5636.182753500745;5549.750261238244;5575.080111781562;5579.972100139504;5607.4112218217115;5624.971875140629;5097.311862898517;5150.896982060356;5169.819056333029;5190.143626301656;5191.0656081905245;5062.594992400617;5158.819441319554;5234.214867769846;5235.293235413209;5265.289185959885;5081.618878584102;5163.7418129093585;5174.767135478913;5208.244804503344;5243.659162154467;5178.7928482860825;5190.039842629126;5202.193659982709;5212.53087222148;5234.816781412632;4905.23968784839;4920.8031678732805;4996.600271978269;5051.797928082872;5162.303089082963;5390.272313237702;5412.431694672042;5439.129739241703;5448.264484294609;5470.398256191816;6014.218151640259;6017.1275165100815;6063.666498342589;6080.695965201767;6091.634501929854;5907.379725128885;6034.758609655609;6110.419510146529;6123.2652081750475;6124.265088189446;5627.71861406928;5649;5650.802221922213;5655.802046928337;5663.830085097413;5984.910226346608;6135.202423684982;6148.077788331697;6150.86209051318;6151.384861513902;5910.143029260733;5927.762889484372;5939.792107276225;5943.970280148572;5969.820905372846;6007.459328660441;6030.939690603038;6044;6046.516278697693;6055.788047418319;5827.4172582741385;5972.163897054415;5991;6001.039833626599;6005.03919372907;6038.516918646497;6051;6053.4551890330085;6075.75696972125;6101.908471372933;4613.123506533748;4619.099275641285;4625.421822272216;4627.722336659811;4653.325267836145;4073.7555746655294;4085.530164031115;4137.048478849882;4138.751674899516;4166.812493437803;5474.945250547523;5676.9497642936185;5705.115707065412;5754.251947246831;5826.796062137805;6029.397060293935;6040.335563088057;6043;6050.48570871472;6058.818235452944;5571.554275657938;5664.51851592611;5724.79963201286;5747.39652336507;5757.481826635539;5148.58811295103;5172.560332371715;5179.48205179479;5183.481651834862;5184.066867963803;6234.532410069263;6237.937620623827;6251.343608921089;6258.280297765724;6261.186045814106;5916.792912248051;6022.126791615104;6050.122732203894;6106.870229007648;6140.692965351804;6079;6109.17526133984;6110.69446527663;6121.265448146251;6255.343188965093;5907.025340818888;5915.231019967377;5916.230889984275;5937.554683398676;5961.970190149022;5912.290525137011;5991.071383935497;6061.15143879866;6080.665563393879;6091.604045737013;5869.882602347844;5890.175375447355;5891.263592050994;5922.170896074467;5949.613275137102;5794.7102644866745;5902;5906.911396329145;5929.584929054925;5950.31571369298;5731.3408957968695;5743.052396354555;5779.595428319977;5782.826515204551;5819.679917604572;5921.792737254175;5932.347441781487;5954.851128721643;5961.314448838266;5961.821145365646;5697.800576979786;5760.596758226884;5825.737841797214;5835.299764028344;5861.296644402529 09:45:55 INFO - PROCESS | 13932 | |1;ext.html;506.50615649741485;548.0792268988101;561.2339157050627;564.4750382144605;566.498648695904;39352.40971385428;39880.40179397311;39974.60025399745;40067;40241;44182.33726494105;44185.33721994173;44282.114357712904;44583.55416445834;44703;8793.2965362771;9011.819763604724;9025.232855207316;9056.77358066047;9061.773455663628;8874.334424918125;8978.147076027766;9000.189982901538;9249.306302027342;9263.258939284875;9169.40398874071;9297.44215347078;9306.627734890597;9315.860262096074;9359;9191.08089191079;9243.306751993627;9278.35051546392;9316.767080822965;9325.067493250688;9074.63701451941;9216.815663686688;9253.444793312356;9274.675386361445;9306.53467326631;43250.78374608107;43547.56452435499;43760.562394375964;43791;43809;3160.336329370835;3517.9472307915403;3840.9615903841163;4052.5744796796207;4488.326750987378;29585.70414295851;30082;30140.24649383761;30186;30547.694523054706;4060.3909413587903;4215.936760948588;4255.085156691326;4292.699511034229;4305.698601097924;203135;203233;203431;203728.98135509377;204752.97623511936;47000;47757.522424776005;64621;65479.67260163764;65677;43951.560484395384;43990.780046099564;44000.11999759987;44008;44156.779216103714;15817.841821581867;15940;15954.840451595568;16005.679886402208;16065.678686426207;12612.621621351374;12714.237145771283;12762.489500419879;12765.42555585001;12774.61676149717;15077.246137693071;15689.843101569066;15764.76352854708;15770.526884193492;15811.288492017888;5893.675847828325;5951.345352011275;5971.402859713994;6078.848028799315;6203.286622038523;1075.2473268711933;1087.0705546757567;1107.06453047175;1119.9976021460748;1164.2083383299437;30615.2346191347;30872.382552348827;30904.845475772476;30981.225469363446;31524.684753152633;1071.3357718214756;1099.6646022963073;1112.3326004397297;1144.3191301175787;1246.8254444377794;14168.504102356368;14867.405303787944;15097.773533397009;15306.234688265766;15584.06495610267;341306;809515;809598;811871;843482;63943.36056639467;64415.355846441875;64725.35274647193;64814.0277895832;64861.675691622186;1471.948481803153;1485.3612946433138;1485.628592851787;1515.4847351900187;1519.9240037998056;31560.52659210068;31849.522257165696;32335.35329293448;32510.83744581262;32704.509432358056;53057.73471132619;54258.18612720734;54417.18374224469;54712;54796.72601636966;316990;322382;322592;324810;325483;35230.823845881634;35436;35503.28993420169;35541.64458355383;36198.09504762297;47491;48007.27989080236;48346.274805878646;48620;49287;40474.1905161901;40492.595074048884;40963.1807363857;41362.379564307164;42366.152676946906;40179;40526;40779;41030.38454423246;41438.96402589959;39791;40900.79549602233;41183;41202.79398602988;41551.168976619694;35320.64679353276;35597.110072248404;35751.64248357483;36025.63974360223;36577.45133822942;27835;28283.292917677223;28447.004354847482;28507;28587 09:45:55 INFO - PROCESS | 13932 | |2;jquery.html;369.1159672584161;372.50084886252426;384.2142817937318;384.9980750096249;388.6696308138081;17757.289708411663;18145.7278140828;19004.90497547514;19070.809291907077;19104.42686719399;18083.457496275132;18552.165152568134;18562.35031773888;18600.627987440243;18629.441116766484;5522.861928451781;5727.484526392624;5752.5110365618975;5766.596338256324;5780.653160810344;5660.179274005267;6767.898481522781;7142.892856607155;7158.2125966143685;7161.9973203751515;6412.262589802186;7103.289671032907;7116.359527642511;7123;7125.216226215112;6609.603423794563;6651.434628056621;6675.93185090388;6689.799306020852;6714.529982901199;6545.607263564201;6773.45812335012;6785.6267905265195;6828.624425656587;6838.316168383122;23814.404639883967;25227;25457.10900118487;25715.35711607206;25927;2495.5882279424054;2583.7028741694758;2720.2519307190482;2729.4950434169546;3249.610046794376;14396;14408.06347587414;14994.62513437162;15141;15413.460528881435;1951.4731022623955;1955.7261983322346;1999.1044330563768;2128.7977642123974;2168.6313326734494;78819;81869;82069;82599.58700206521;83253.58373208156;14885.627859303604;15833.287502062434;15915.840841591436;15947.521574352555;16146.192690365435;26815.061472848356;26842.32894177622;27206.591901121497;27321.72678273192;27475.450490990068;9147.77130571741;9475.48899541622;9585.616575337048;9761.316707830383;9798.902010979798;8296.668133274601;8330.333573314121;8369.748907532783;8434.662613495391;8487.533185674723;7862.606869656494;7877.448578599443;7968;7974.5215287082965;7989.960050199828;1931.2854243929835;1998.280618977167;2004.8696834705988;2035.623409669216;2039.6940458930983;967.9758006049764;1006.8288390973552;1099.3898386395626;1116.8548088748412;1139.2879450343535;17910.91044544769;17983.280668773365;18020.459386218434;18168.364107256184;18552.536186595175;1014.264658122855;1032.4837581209395;1038.2524582300732;1061.7611037516651;1077.9299345542515;10265.846012309821;10560.36637801719;10604.310719803188;10684.038436540748;10795;431371;432093;439633;443770;446034;81322;82706.17293827105;83043;83853;84193.57903210445;1057.0697785948316;1061.0821639281965;1076.3541874875011;1093.2292733622776;1093.2675107677876;15982.60043498922;15992.600184995468;16307.673846523241;16475.83524164743;16526.091064991542;35740.82129589439;36208.913732588066;36291.63708362988;36394;36642.7175048872;50848.237276440144;52628.47371526236;53001.20498192607;53107;53577.46422535881;8607.953420208301;8660.39377243587;8783.648654053766;9000.54997250148;9020.05289444599;13405;13823.654408639864;13953.697549957758;14093.295335233403;14258.786118208443;11413.828792567952;12104.576339828063;12107.668156502601;12537.122401432178;12539.310337931502;12180.147389682637;12261.589917159641;12301.876981230072;12359.814602781145;12614.810777838156;11904.702382440508;12330.630081097223;12631.810522842348;12652.873471265537;12687.746245075232;8583.65665373378;8859.3798434109;8992.325575581988;9063.546822658973;9087.818243635222;11409.486573104065;11810.82283765727;11963.940180299043;12176.330301833485;12176.939115304367 09:45:55 INFO - PROCESS | 13932 | |3;mootools.html;1623.9837601623983;1650.9174541272937;1933.4393026022453;1959.8726082804626;2021.3026505855485;7698.191689872567;8285.83428331433;8418.284445822097;8489.151084891508;8503.872441913369;8388.161183881608;8410.327173826094;8521.446106003106;8521.957390213056;8527.445716028455;2400.4838959623676;2440.890159942798;2444.2422848916804;2453.460238747473;2456.9262922112366;2443.6823212982285;2487.8880450379684;2503.8748062596887;2504.2987963370288;2521.962170567434;2447.657327974085;2451.82837201396;2455.9631605525933;2460.5817011108156;2473.245660073677;2439.231642032763;2441.3652450362943;2460.2250291158316;2484.0312278211513;2492.277239600514;2477.0834791127218;2484.9130280440277;2490.3688084304626;2500.374906273432;2517.798576113925;8553.486790792573;8578.742637720878;8627.870581941275;8634.827303453958;8643.567821608958;5164.483551644843;5248.21276808478;5250.94981003797;5299.125644268691;5345.946540534623;3210.5826242588546;3228.790128641631;3244.7345535241275;3254.739620830328;3304.520844477537;965.1024547171128;1017.0897047142839;1032.1742605915313;1050.6900464363032;1058.3808472043863;11843.111766617538;11897.702557436047;11934.522619095313;11956.461959211856;12000.879991200063;4294.26997410441;4336.089421221515;4342.41377414045;4513.909721805546;4525.456945166601;9608.95195524018;9617.759556011155;9629.277804164716;9637.855432168522;9642.903570964201;5219.16493361068;5221.008008478377;5233;5238.266642670029;5243.397009343974;4278.4865816102265;4638.234691275969;4669.976650116728;4722.952770472251;4741.336212930192;3529.0647978285774;3579.3736096183065;3617.9276414471565;3631.618680038611;3639.8544058237376;1067.6690226029955;1096.2107282756403;1096.660035389032;1100.6202860013282;1112.5883423133491;1212.1393810394718;1218.8232706257543;1219.5792451604182;1487.6727120033574;1499.5576304990054;7873.881891771628;8050.798730031796;8276.08963014068;8292.04641466239;8311.709090181814;519.6570263625989;523.2674256041572;525.0680042923841;538.8625900395374;550.867791729982;5989.970050149808;6031.879362412815;6067;6102.816915492543;6115.877682446415;10316.484175791331;10576.418296993585;10607.628732994308;10608.045275925204;10709.946450267698;9850.704478865646;10469.633562825416;10481.056704896597;10487.37075775456;10547.57809687604;8045.316148127475;8092.3121534669035;8152.470089444286;8173.959130204311;8195.877061844078;7955.562444065632;7989.520628762293;7998.680052797823;8057.033156021315;8126.796830079295;9030.322725795722;9160.725178244664;9273.21177699876;9379.108984646447;9429.009953954735;9503.809923801347;9655.806883862142;9704.9029509704;9768.609255629695;9784.364016338915;6946.756863509753;7376.7418140364825;7430.2569743027425;7514.436417268617;7520.398368130427;8136.105028446985;8183.427160098736;8188.5905704715715;8188.976377952756;8189.590520473834;7069.893951590833;7271.127464704269;7397.408207343292;7475.0656167979005;7517.812054698677;7168.139823221039;7182.928170718226;7216.097987751531;7351.522151060378;7536.849263014599;7199.532030418006;7281.199068102399;7299.817504562428;7312.085989251344;7358.785800342884;6924.896126558207;6931.09895713554;7016.5790052597;7023.929760702532;7050.647467626701;7220.628080664867;7284.599347035964;7305.926940730737;7314.743983960536;7323.2676732326345 09:45:55 INFO - PROCESS | 13932 | |4;prototype.html;363.76537133548845;367.2563059803897;372.1310739423446;372.36697614056095;374.8613013185122;6411.1024456576115;6441.613503189812;6452.0967064610995;6462.741490340392;6509.902351464726;6358.268799088106;6367.140436041133;6373.0759039939185;6384.138141350928;6399.872002559946;4856.538628830255;4941.925871111936;4946.109700253962;4956.2070068789;4960.107180707471;4945.381827271591;4960.454350021495;4964.280179373988;4968.726720030397;4970.6520543561965;4942.283368911523;4980.053789779949;4982.277569752384;4982.377202849644;4988.2766998785155;4975.4527002029745;4987.451380348159;4990.3762029746285;4996.225585034325;5020.573251273646;4453.799579018952;4455;4455.8217671293105;4469.061497085616;4470.619997300233;5914.852128696774;6107.114468402101;6162.22972128484;6168.660723660197;6170.136180934673;5737.684427356494;5774;5780.653160810365;5781.508571771363;5792.565557583198;6843.486738494633;6843.8973415398805;6844.28135045823;6845.452363810933;6863.828404289883;4805.783739731721;4814.325994360793;4816.373871396731;4819.927701084486;4828.130936431441;7028.578285302899;7034.5779253244455;7077.539959902641;7122.679479423438;7126.64366781664;4897.289892965571;4906.190478571068;4963.528464795839;4973.6269779765935;5020.472850350734;5026.4973502649445;5032.345795046621;5041.546260836469;5056.089903817275;5058.848234552969;5670.5747068969995;5727.198192253088;5740.971295143498;5754.74103665336;5798.768049278066;6843.0419741236265;6864.24493305736;6869.965650171817;6873.656317184121;6881.346272104142;1799.253309876413;1828.9908550457162;1830.048374845073;1830.6430246101881;1834.3304693786672;1191.3090407563593;1210.6973256685828;1232.7904256276454;1235.765204611121;1242.3043095866344;6514.706838192293;6533.738650453929;6547.901781473186;6555.672216389162;6557.278699343068;6950.895736563955;6980.127484064492;7003.194632617212;7017.61403122823;7028.683709232994;6489.513286503531;6543.574667646588;6547.443467305332;6549.639769812611;6558.508111891627;3709.258148370283;3739.476473293741;3789.3558095123344;3801.9239615208094;3810.3712887373827;7276.7453139140935;7407.481476296715;7419.629018549159;7430.702771889064;7441.441891858132;7281.417486601059;7295.6352182390665;7296.233895441009;7302;7305.525140865827;7341.302576255247;7354.963225183733;7365.189829118793;7383.003294555167;7413.8146546336775;6993.335633114846;7097.25478824716;7109;7118.893216601651;7135.143782746104;6991.860162796817;6998.790036298919;7010.509264351446;7014.088168538057;7029.507934444539;7279.636018199175;7306.050213472215;7314.195438501867;7352.448566357438;7362.411007119311;4741.786619602057;4773.856784296477;4783.330333753208;4789.401324834395;4789.976050119727;6734.966325168343;6964.477664175106;7034.155901291878;7123.679434425567;7154.284571542804;6862.553933994274;6867.896981545181;6869.7595584154315;6879.965600171967;6916.3429474199875;6885.827854303482;6891.241963383924;6893.241743408322;6894.345037221456;6909.516333856582;6758.2903795102775;6765.458763298826;6777.830554236183;6790.558613690095;6859.965700171467;6825.55633883796;6894.448444124559;6932.306769323028;6945;6953.20038195614;6717.462602991651;6727.629980351127;6751.257361690112;6755.088063111417;6772.05191273232 09:45:55 INFO - PROCESS | 13932 | |5;yui.html;770.1720650300927;843.3759018326436;864.5590748718151;866;880.6345366672831;12182.634520964375;12958.222506649585;12963.740725185491;13448.394822233011;13526.458941642335;12325.322107284095;12346.259224446518;12363.938180309086;12373.381330933462;12386.628401147958;761.7600455856401;912.6531917871233;927.0405130689737;927.0682963621551;928.4661319741142;918.4443411735904;927.0405130689737;928.401181238101;930.3208657679897;931.3620170183412;955.2739917662592;967.6951760195516;967.9419234845897;972.1396564040839;975.2636759246759;952.3571589177278;966.1111777165025;967.4969016111653;972.2513664478312;981.1464026297095;717.6483523073708;721.6211488968333;723.3598265535039;723.4212629896062;724.2612535214105;12435.502579896793;12464.252144871336;12467.438965246585;12472.376381180904;12547.93726031373;13571.52499662507;13707.725845483134;13745.587632371045;13745.931270343684;13780.586582402444;10162.288639795217;10347;10379.377237365783;10420.374777513374;10445.477726113664;3872.419137129425;3895.9026024349337;3901.7463864848696;3915.158240978175;3941.8029098544957;51074.48925510734;51075;51209.743951280376;51939.48060519384;52134.478655213345;10528.315659482108;10556.102731267774;10696.679099627023;10814.080803131821;10880.401577913133;18658.44024679262;18664.9734264614;19212.903935480233;19680.11439485198;19688.90155549213;7069.540479868792;7167.856642867114;7212.098487689039;7246.855062898712;7327.926720732725;3870.554886188068;3926.862559810393;3930.1613111113293;3966.2662407454714;4101.364288535222;3131.592892923951;3147.118806734118;3159.462891308483;3162.667919868427;3181.0456862941023;579.7970710251462;583.4690431707127;583.8102616649605;586.6480111932806;590.503976659608;533.1416419564498;549.3325609384617;550.5100460590078;605.9697015149225;640.3180612647516;8098.919010809816;8170.591470426455;8203.548804815793;8208.466449680871;8277.875831862528;547.8879961816839;669.6752075243503;672.1396612336217;675.0111087257192;678.2302087131142;3694.445833124999;3748.887533374003;3826.770393776382;3835.520559930009;3924.0974575847144;58919.70540147272;60751.69624151851;61182.694086529285;62203;62322.688386558686;54558.45441545534;54824;55311;55424;55655;48547.271790923165;49197;49451.258231126565;49814;50121.49878501241;7505.624718764149;7625.351845093229;7948.443608947318;7985.92014079875;8051.033875934925;36891;37754.24491510209;37938.8103059483;38005;39239.607603924735;43987;44727;47455.28817067678;47554;48730;9501.952490237505;9539;9791.363561368487;9917.107460328605;10101.747456313651;10017.599296028076;10201.081902628799;10590.205734569783;10639.680809575415;10794.838077429002;9294.442333460014;9499.715008549754;9612.423254604746;9655.662051828433;9689.729880145484;9657.855132173163;9933.453660048766;10017.5492102857;10152.340097893613;10318.793624127626;9287.442753434816;9418.387804792666;9538.761530961503;9578.664746733832;9747.512624368612;8451.408401412087;8718.476891386537;8818.870969348662;8891;8914.955425222832;8120.634571444417;8251.669933202606;8368.539730314891;8573.356998225034;8741.125887411208 09:45:55 INFO - PROCESS | 13932 | __end_tp_report 09:45:55 INFO - PROCESS | 13932 | __start_cc_report 09:45:55 INFO - PROCESS | 13932 | _x_x_mozilla_cycle_collect,341 09:45:55 INFO - PROCESS | 13932 | __end_cc_report 09:45:55 INFO - PROCESS | 13932 | __startTimestamp1460652355102__endTimestamp 09:45:55 INFO - PROCESS | 13932 | 09:45:55 INFO - PROCESS | 13932 | ------- Summary: start ------- 09:45:55 INFO - PROCESS | 13932 | Number of tests: 6 09:45:55 INFO - PROCESS | 13932 | 09:45:55 INFO - PROCESS | 13932 | [#0] dojo.html Cycles:165 Average:5595.34 Median:5825.74 stddev:617.20 (10.6%) stddev-sans-first:592.92 09:45:55 INFO - PROCESS | 13932 | Values: 3328.6 3378.7 3379.4 3415.9 3426.9 5529.1 5552.2 5588.8 5595.9 5636.2 5549.8 5575.1 5580.0 5607.4 5625.0 5097.3 5150.9 5169.8 5190.1 5191.1 5062.6 5158.8 5234.2 5235.3 5265.3 5081.6 5163.7 5174.8 5208.2 5243.7 5178.8 5190.0 5202.2 5212.5 5234.8 4905.2 4920.8 4996.6 5051.8 5162.3 5390.3 5412.4 5439.1 5448.3 5470.4 6014.2 6017.1 6063.7 6080.7 6091.6 5907.4 6034.8 6110.4 6123.3 6124.3 5627.7 5649.0 5650.8 5655.8 5663.8 5984.9 6135.2 6148.1 6150.9 6151.4 5910.1 5927.8 5939.8 5944.0 5969.8 6007.5 6030.9 6044.0 6046.5 6055.8 5827.4 5972.2 5991.0 6001.0 6005.0 6038.5 6051.0 6053.5 6075.8 6101.9 4613.1 4619.1 4625.4 4627.7 4653.3 4073.8 4085.5 4137.0 4138.8 4166.8 5474.9 5676.9 5705.1 5754.3 5826.8 6029.4 6040.3 6043.0 6050.5 6058.8 5571.6 5664.5 5724.8 5747.4 5757.5 5148.6 5172.6 5179.5 5183.5 5184.1 6234.5 6237.9 6251.3 6258.3 6261.2 5916.8 6022.1 6050.1 6106.9 6140.7 6079.0 6109.2 6110.7 6121.3 6255.3 5907.0 5915.2 5916.2 5937.6 5962.0 5912.3 5991.1 6061.2 6080.7 6091.6 5869.9 5890.2 5891.3 5922.2 5949.6 5794.7 5902.0 5906.9 5929.6 5950.3 5731.3 5743.1 5779.6 5782.8 5819.7 5921.8 5932.3 5954.9 5961.3 5961.8 5697.8 5760.6 5825.7 5835.3 5861.3 09:45:55 INFO - PROCESS | 13932 | 09:45:55 INFO - PROCESS | 13932 | [#1] ext.html Cycles:180 Average:57940.75 Median:22419.70 stddev:131296.62 (585.6%) stddev-sans-first:131594.13 09:45:55 INFO - PROCESS | 13932 | Values: 506.5 548.1 561.2 564.5 566.5 39352.4 39880.4 39974.6 40067.0 40241.0 44182.3 44185.3 44282.1 44583.6 44703.0 8793.3 9011.8 9025.2 9056.8 9061.8 8874.3 8978.1 9000.2 9249.3 9263.3 9169.4 9297.4 9306.6 9315.9 9359.0 9191.1 9243.3 9278.4 9316.8 9325.1 9074.6 9216.8 9253.4 9274.7 9306.5 43250.8 43547.6 43760.6 43791.0 43809.0 3160.3 3517.9 3841.0 4052.6 4488.3 29585.7 30082.0 30140.2 30186.0 30547.7 4060.4 4215.9 4255.1 4292.7 4305.7 203135.0 203233.0 203431.0 203729.0 204753.0 47000.0 47757.5 64621.0 65479.7 65677.0 43951.6 43990.8 44000.1 44008.0 44156.8 15817.8 15940.0 15954.8 16005.7 16065.7 12612.6 12714.2 12762.5 12765.4 12774.6 15077.2 15689.8 15764.8 15770.5 15811.3 5893.7 5951.3 5971.4 6078.8 6203.3 1075.2 1087.1 1107.1 1120.0 1164.2 30615.2 30872.4 30904.8 30981.2 31524.7 1071.3 1099.7 1112.3 1144.3 1246.8 14168.5 14867.4 15097.8 15306.2 15584.1 341306.0 809515.0 809598.0 811871.0 843482.0 63943.4 64415.4 64725.4 64814.0 64861.7 1471.9 1485.4 1485.6 1515.5 1519.9 31560.5 31849.5 32335.4 32510.8 32704.5 53057.7 54258.2 54417.2 54712.0 54796.7 316990.0 322382.0 322592.0 324810.0 325483.0 35230.8 35436.0 35503.3 35541.6 36198.1 47491.0 48007.3 48346.3 48620.0 49287.0 40474.2 40492.6 40963.2 41362.4 42366.2 40179.0 40526.0 40779.0 41030.4 41439.0 39791.0 40900.8 41183.0 41202.8 41551.2 35320.6 35597.1 35751.6 36025.6 36577.5 27835.0 28283.3 28447.0 28507.0 28587.0 09:45:55 INFO - PROCESS | 13932 | 09:45:55 INFO - PROCESS | 13932 | [#2] jquery.html Cycles:180 Average:27968.20 Median:26371.03 stddev:72183.43 (273.7%) stddev-sans-first:72356.18 09:45:55 INFO - PROCESS | 13932 | Values: 369.1 372.5 384.2 385.0 388.7 17757.3 18145.7 19004.9 19070.8 19104.4 18083.5 18552.2 18562.4 18600.6 18629.4 5522.9 5727.5 5752.5 5766.6 5780.7 5660.2 6767.9 7142.9 7158.2 7162.0 6412.3 7103.3 7116.4 7123.0 7125.2 6609.6 6651.4 6675.9 6689.8 6714.5 6545.6 6773.5 6785.6 6828.6 6838.3 23814.4 25227.0 25457.1 25715.4 25927.0 2495.6 2583.7 2720.3 2729.5 3249.6 14396.0 14408.1 14994.6 15141.0 15413.5 1951.5 1955.7 1999.1 2128.8 2168.6 78819.0 81869.0 82069.0 82599.6 83253.6 14885.6 15833.3 15915.8 15947.5 16146.2 26815.1 26842.3 27206.6 27321.7 27475.5 9147.8 9475.5 9585.6 9761.3 9798.9 8296.7 8330.3 8369.7 8434.7 8487.5 7862.6 7877.4 7968.0 7974.5 7990.0 1931.3 1998.3 2004.9 2035.6 2039.7 968.0 1006.8 1099.4 1116.9 1139.3 17910.9 17983.3 18020.5 18168.4 18552.5 1014.3 1032.5 1038.3 1061.8 1077.9 10265.8 10560.4 10604.3 10684.0 10795.0 431371.0 432093.0 439633.0 443770.0 446034.0 81322.0 82706.2 83043.0 83853.0 84193.6 1057.1 1061.1 1076.4 1093.2 1093.3 15982.6 15992.6 16307.7 16475.8 16526.1 35740.8 36208.9 36291.6 36394.0 36642.7 50848.2 52628.5 53001.2 53107.0 53577.5 8608.0 8660.4 8783.6 9000.5 9020.1 13405.0 13823.7 13953.7 14093.3 14258.8 11413.8 12104.6 12107.7 12537.1 12539.3 12180.1 12261.6 12301.9 12359.8 12614.8 11904.7 12330.6 12631.8 12652.9 12687.7 8583.7 8859.4 8992.3 9063.5 9087.8 11409.5 11810.8 11963.9 12176.3 12176.9 09:45:55 INFO - PROCESS | 13932 | 09:45:55 INFO - PROCESS | 13932 | [#3] mootools.html Cycles:180 Average:5928.40 Median:2942.40 stddev:3160.35 (107.4%) stddev-sans-first:3152.65 09:45:55 INFO - PROCESS | 13932 | Values: 1624.0 1650.9 1933.4 1959.9 2021.3 7698.2 8285.8 8418.3 8489.2 8503.9 8388.2 8410.3 8521.4 8522.0 8527.4 2400.5 2440.9 2444.2 2453.5 2456.9 2443.7 2487.9 2503.9 2504.3 2522.0 2447.7 2451.8 2456.0 2460.6 2473.2 2439.2 2441.4 2460.2 2484.0 2492.3 2477.1 2484.9 2490.4 2500.4 2517.8 8553.5 8578.7 8627.9 8634.8 8643.6 5164.5 5248.2 5250.9 5299.1 5345.9 3210.6 3228.8 3244.7 3254.7 3304.5 965.1 1017.1 1032.2 1050.7 1058.4 11843.1 11897.7 11934.5 11956.5 12000.9 4294.3 4336.1 4342.4 4513.9 4525.5 9609.0 9617.8 9629.3 9637.9 9642.9 5219.2 5221.0 5233.0 5238.3 5243.4 4278.5 4638.2 4670.0 4723.0 4741.3 3529.1 3579.4 3617.9 3631.6 3639.9 1067.7 1096.2 1096.7 1100.6 1112.6 1212.1 1218.8 1219.6 1487.7 1499.6 7873.9 8050.8 8276.1 8292.0 8311.7 519.7 523.3 525.1 538.9 550.9 5990.0 6031.9 6067.0 6102.8 6115.9 10316.5 10576.4 10607.6 10608.0 10709.9 9850.7 10469.6 10481.1 10487.4 10547.6 8045.3 8092.3 8152.5 8174.0 8195.9 7955.6 7989.5 7998.7 8057.0 8126.8 9030.3 9160.7 9273.2 9379.1 9429.0 9503.8 9655.8 9704.9 9768.6 9784.4 6946.8 7376.7 7430.3 7514.4 7520.4 8136.1 8183.4 8188.6 8189.0 8189.6 7069.9 7271.1 7397.4 7475.1 7517.8 7168.1 7182.9 7216.1 7351.5 7536.8 7199.5 7281.2 7299.8 7312.1 7358.8 6924.9 6931.1 7016.6 7023.9 7050.6 7220.6 7284.6 7305.9 7314.7 7323.3 09:45:55 INFO - PROCESS | 13932 | 09:45:55 INFO - PROCESS | 13932 | [#4] prototype.html Cycles:180 Average:5753.42 Median:6512.30 stddev:1713.37 (26.3%) stddev-sans-first:1669.74 09:45:55 INFO - PROCESS | 13932 | Values: 363.8 367.3 372.1 372.4 374.9 6411.1 6441.6 6452.1 6462.7 6509.9 6358.3 6367.1 6373.1 6384.1 6399.9 4856.5 4941.9 4946.1 4956.2 4960.1 4945.4 4960.5 4964.3 4968.7 4970.7 4942.3 4980.1 4982.3 4982.4 4988.3 4975.5 4987.5 4990.4 4996.2 5020.6 4453.8 4455.0 4455.8 4469.1 4470.6 5914.9 6107.1 6162.2 6168.7 6170.1 5737.7 5774.0 5780.7 5781.5 5792.6 6843.5 6843.9 6844.3 6845.5 6863.8 4805.8 4814.3 4816.4 4819.9 4828.1 7028.6 7034.6 7077.5 7122.7 7126.6 4897.3 4906.2 4963.5 4973.6 5020.5 5026.5 5032.3 5041.5 5056.1 5058.8 5670.6 5727.2 5741.0 5754.7 5798.8 6843.0 6864.2 6870.0 6873.7 6881.3 1799.3 1829.0 1830.0 1830.6 1834.3 1191.3 1210.7 1232.8 1235.8 1242.3 6514.7 6533.7 6547.9 6555.7 6557.3 6950.9 6980.1 7003.2 7017.6 7028.7 6489.5 6543.6 6547.4 6549.6 6558.5 3709.3 3739.5 3789.4 3801.9 3810.4 7276.7 7407.5 7419.6 7430.7 7441.4 7281.4 7295.6 7296.2 7302.0 7305.5 7341.3 7355.0 7365.2 7383.0 7413.8 6993.3 7097.3 7109.0 7118.9 7135.1 6991.9 6998.8 7010.5 7014.1 7029.5 7279.6 7306.1 7314.2 7352.4 7362.4 4741.8 4773.9 4783.3 4789.4 4790.0 6735.0 6964.5 7034.2 7123.7 7154.3 6862.6 6867.9 6869.8 6880.0 6916.3 6885.8 6891.2 6893.2 6894.3 6909.5 6758.3 6765.5 6777.8 6790.6 6860.0 6825.6 6894.4 6932.3 6945.0 6953.2 6717.5 6727.6 6751.3 6755.1 6772.1 09:45:55 INFO - PROCESS | 13932 | 09:45:55 INFO - PROCESS | 13932 | [#5] yui.html Cycles:180 Average:14028.78 Median:55367.50 stddev:17143.50 (31.0%) stddev-sans-first:17162.68 09:45:55 INFO - PROCESS | 13932 | Values: 770.2 843.4 864.6 866.0 880.6 12182.6 12958.2 12963.7 13448.4 13526.5 12325.3 12346.3 12363.9 12373.4 12386.6 761.8 912.7 927.0 927.1 928.5 918.4 927.0 928.4 930.3 931.4 955.3 967.7 967.9 972.1 975.3 952.4 966.1 967.5 972.3 981.1 717.6 721.6 723.4 723.4 724.3 12435.5 12464.3 12467.4 12472.4 12547.9 13571.5 13707.7 13745.6 13745.9 13780.6 10162.3 10347.0 10379.4 10420.4 10445.5 3872.4 3895.9 3901.7 3915.2 3941.8 51074.5 51075.0 51209.7 51939.5 52134.5 10528.3 10556.1 10696.7 10814.1 10880.4 18658.4 18665.0 19212.9 19680.1 19688.9 7069.5 7167.9 7212.1 7246.9 7327.9 3870.6 3926.9 3930.2 3966.3 4101.4 3131.6 3147.1 3159.5 3162.7 3181.0 579.8 583.5 583.8 586.6 590.5 533.1 549.3 550.5 606.0 640.3 8098.9 8170.6 8203.5 8208.5 8277.9 547.9 669.7 672.1 675.0 678.2 3694.4 3748.9 3826.8 3835.5 3924.1 58919.7 60751.7 61182.7 62203.0 62322.7 54558.5 54824.0 55311.0 55424.0 55655.0 48547.3 49197.0 49451.3 49814.0 50121.5 7505.6 7625.4 7948.4 7985.9 8051.0 36891.0 37754.2 37938.8 38005.0 39239.6 43987.0 44727.0 47455.3 47554.0 48730.0 9502.0 9539.0 9791.4 9917.1 10101.7 10017.6 10201.1 10590.2 10639.7 10794.8 9294.4 9499.7 9612.4 9655.7 9689.7 9657.9 9933.5 10017.5 10152.3 10318.8 9287.4 9418.4 9538.8 9578.7 9747.5 8451.4 8718.5 8818.9 8891.0 8915.0 8120.6 8251.7 8368.5 8573.4 8741.1 09:45:55 INFO - PROCESS | 13932 | -------- Summary: end -------- 09:45:55 INFO - PROCESS | 13932 | 09:45:55 INFO - TEST-INFO | 13932: exit 0 09:45:55 INFO - TEST-OK | dromaeo_css | took 1111174ms 09:45:55 INFO - TEST-START | kraken 09:45:55 INFO - operating with platform_type : linux_ 09:45:55 INFO - Initialising browser for kraken test... 09:45:55 INFO - TEST-INFO | started process 14174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCy0kzW/profile http://localhost:56832/getInfo.html) 09:45:59 INFO - PROCESS | 14174 | 09:45:59 INFO - PROCESS | 14174 | (process:14249): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:46:00 INFO - PROCESS | 14174 | __metrics Screen width/height:1600/1200 09:46:00 INFO - PROCESS | 14174 | colorDepth:24 09:46:00 INFO - PROCESS | 14174 | Browser inner width/height: 1024/697 09:46:00 INFO - PROCESS | 14174 | __metrics 09:46:01 ERROR - PROCESS | 14174 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:46:02 INFO - TEST-INFO | 14174: exit 0 09:46:02 INFO - Browser initialized. 09:46:02 INFO - Running cycle 1/1 for kraken test... 09:46:02 INFO - TEST-INFO | started process 14300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCy0kzW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:04 INFO - PROCESS | 14300 | 09:46:04 INFO - PROCESS | 14300 | (process:14368): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:46:14 INFO - PROCESS | 14300 | RSS: Main: 151420928 09:46:14 INFO - PROCESS | 14300 | 09:46:16 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56832/tests/kraken/driver.html?testName=audio-beat-detection) 09:46:17 INFO - PROCESS | 14300 | RSS: Main: 155447296 09:46:17 INFO - PROCESS | 14300 | 09:46:20 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56832/tests/kraken/driver.html?testName=audio-dft) 09:46:20 INFO - PROCESS | 14300 | RSS: Main: 155570176 09:46:20 INFO - PROCESS | 14300 | 09:46:23 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56832/tests/kraken/driver.html?testName=audio-fft) 09:46:24 INFO - PROCESS | 14300 | RSS: Main: 156745728 09:46:24 INFO - PROCESS | 14300 | 09:46:26 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56832/tests/kraken/driver.html?testName=audio-oscillator) 09:46:26 INFO - PROCESS | 14300 | RSS: Main: 155840512 09:46:26 INFO - PROCESS | 14300 | 09:46:29 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56832/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:46:29 INFO - PROCESS | 14300 | RSS: Main: 155787264 09:46:29 INFO - PROCESS | 14300 | 09:46:32 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56832/tests/kraken/driver.html?testName=imaging-darkroom) 09:46:33 INFO - PROCESS | 14300 | RSS: Main: 155893760 09:46:33 INFO - PROCESS | 14300 | 09:46:36 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56832/tests/kraken/driver.html?testName=imaging-desaturate) 09:46:37 INFO - PROCESS | 14300 | RSS: Main: 156106752 09:46:37 INFO - PROCESS | 14300 | 09:46:40 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56832/tests/kraken/driver.html?testName=json-parse-financial) 09:46:40 INFO - PROCESS | 14300 | RSS: Main: 156737536 09:46:40 INFO - PROCESS | 14300 | 09:46:42 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56832/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:46:42 INFO - PROCESS | 14300 | RSS: Main: 156577792 09:46:42 INFO - PROCESS | 14300 | 09:46:44 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56832/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:46:45 INFO - PROCESS | 14300 | RSS: Main: 156000256 09:46:45 INFO - PROCESS | 14300 | 09:46:47 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56832/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:46:47 INFO - PROCESS | 14300 | RSS: Main: 156524544 09:46:47 INFO - PROCESS | 14300 | 09:46:50 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:46:50 INFO - PROCESS | 14300 | RSS: Main: 156540928 09:46:50 INFO - PROCESS | 14300 | 09:46:53 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:46:54 INFO - PROCESS | 14300 | RSS: Main: 156418048 09:46:54 INFO - PROCESS | 14300 | 09:46:55 INFO - PROCESS | 14300 | Cycle 1(1): loaded http://localhost:56832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56832/tests/kraken/driver.html?testName=ai-astar) 09:46:56 INFO - PROCESS | 14300 | RSS: Main: 158322688 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | __start_tp_report 09:46:56 INFO - PROCESS | 14300 | _x_x_mozilla_page_load 09:46:56 INFO - PROCESS | 14300 | _x_x_mozilla_page_load_details 09:46:56 INFO - PROCESS | 14300 | |i|pagename|runs| 09:46:56 INFO - PROCESS | 14300 | |0;ai-astar;111;105;111;111;111;121;110;112;110;112 09:46:56 INFO - PROCESS | 14300 | |1;audio-beat-detection;159;128;160;165;127;153;157;128;166;127 09:46:56 INFO - PROCESS | 14300 | |2;audio-dft;163;160;163;162;164;162;163;161;164;162 09:46:56 INFO - PROCESS | 14300 | |3;audio-fft;75;73;75;165;76;76;77;74;167;75 09:46:56 INFO - PROCESS | 14300 | |4;audio-oscillator;93;93;149;93;93;93;142;94;93;146 09:46:56 INFO - PROCESS | 14300 | |5;imaging-gaussian-blur;117;118;116;118;118;118;118;117;117;119 09:46:56 INFO - PROCESS | 14300 | |6;imaging-darkroom;146;147;146;147;149;146;146;147;148;147 09:46:56 INFO - PROCESS | 14300 | |7;imaging-desaturate;97;96;97;96;97;96;96;96;96;97 09:46:56 INFO - PROCESS | 14300 | |8;json-parse-financial;57;58;56;56;56;55;58;61;54;53 09:46:56 INFO - PROCESS | 14300 | |9;json-stringify-tinderbox;66;66;64;65;65;66;65;64;64;64 09:46:56 INFO - PROCESS | 14300 | |10;stanford-crypto-aes;84;77;78;80;78;86;79;79;78;79 09:46:56 INFO - PROCESS | 14300 | |11;stanford-crypto-ccm;110;112;111;111;111;113;115;115;116;116 09:46:56 INFO - PROCESS | 14300 | |12;stanford-crypto-pbkdf2;137;145;159;144;141;146;146;151;163;148 09:46:56 INFO - PROCESS | 14300 | |13;stanford-crypto-sha256-iterative;67;69;69;67;70;68;68;71;67;67 09:46:56 INFO - PROCESS | 14300 | __end_tp_report 09:46:56 INFO - PROCESS | 14300 | __start_cc_report 09:46:56 INFO - PROCESS | 14300 | _x_x_mozilla_cycle_collect,845 09:46:56 INFO - PROCESS | 14300 | __end_cc_report 09:46:56 INFO - PROCESS | 14300 | __startTimestamp1460652416031__endTimestamp 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | ------- Summary: start ------- 09:46:56 INFO - PROCESS | 14300 | Number of tests: 14 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:3.92 (3.5%) stddev-sans-first:4.16 09:46:56 INFO - PROCESS | 14300 | Values: 111.0 105.0 111.0 111.0 111.0 121.0 110.0 112.0 110.0 112.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:158.00 stddev:17.18 (10.9%) stddev-sans-first:17.66 09:46:56 INFO - PROCESS | 14300 | Values: 159.0 128.0 160.0 165.0 127.0 153.0 157.0 128.0 166.0 127.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 09:46:56 INFO - PROCESS | 14300 | Values: 163.0 160.0 163.0 162.0 164.0 162.0 163.0 161.0 164.0 162.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.00 stddev:38.33 (51.1%) stddev-sans-first:40.08 09:46:56 INFO - PROCESS | 14300 | Values: 75.0 73.0 75.0 165.0 76.0 76.0 77.0 74.0 167.0 75.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.00 stddev:25.43 (27.3%) stddev-sans-first:26.31 09:46:56 INFO - PROCESS | 14300 | Values: 93.0 93.0 149.0 93.0 93.0 93.0 142.0 94.0 93.0 146.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.84 (0.7%) stddev-sans-first:0.87 09:46:56 INFO - PROCESS | 14300 | Values: 117.0 118.0 116.0 118.0 118.0 118.0 118.0 117.0 117.0 119.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 09:46:56 INFO - PROCESS | 14300 | Values: 146.0 147.0 146.0 147.0 149.0 146.0 146.0 147.0 148.0 147.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:46:56 INFO - PROCESS | 14300 | Values: 97.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:2.27 (4.0%) stddev-sans-first:2.40 09:46:56 INFO - PROCESS | 14300 | Values: 57.0 58.0 56.0 56.0 56.0 55.0 58.0 61.0 54.0 53.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 09:46:56 INFO - PROCESS | 14300 | Values: 66.0 66.0 64.0 65.0 65.0 66.0 65.0 64.0 64.0 64.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:2.90 (3.7%) stddev-sans-first:2.65 09:46:56 INFO - PROCESS | 14300 | Values: 84.0 77.0 78.0 80.0 78.0 86.0 79.0 79.0 78.0 79.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#11] stanford-crypto-ccm Cycles:10 Average:113.00 Median:114.00 stddev:2.31 (2.0%) stddev-sans-first:2.18 09:46:56 INFO - PROCESS | 14300 | Values: 110.0 112.0 111.0 111.0 111.0 113.0 115.0 115.0 116.0 116.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:147.00 stddev:7.87 (5.4%) stddev-sans-first:7.28 09:46:56 INFO - PROCESS | 14300 | Values: 137.0 145.0 159.0 144.0 141.0 146.0 146.0 151.0 163.0 148.0 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - PROCESS | 14300 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.42 (2.1%) stddev-sans-first:1.42 09:46:56 INFO - PROCESS | 14300 | Values: 67.0 69.0 69.0 67.0 70.0 68.0 68.0 71.0 67.0 67.0 09:46:56 INFO - PROCESS | 14300 | -------- Summary: end -------- 09:46:56 INFO - PROCESS | 14300 | 09:46:56 INFO - TEST-INFO | 14300: exit 0 09:46:56 INFO - TEST-OK | kraken | took 61151ms 09:46:56 INFO - SUITE-END | took 1172s 09:46:57 INFO - Completed test suite (00:19:32) 09:46:57 INFO - javascript benchmark 09:46:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3328.6172090209625, 3378.7297016238704, 3379.442392005319, 3415.880444184454, 3426.948595771062, 5529.060059789836, 5552.222688823558, 5588.776448942042, 5595.86010349741, 5636.182753500745, 5549.750261238244, 5575.080111781562, 5579.972100139504, 5607.4112218217115, 5624.971875140629, 5097.311862898517, 5150.896982060356, 5169.819056333029, 5190.143626301656, 5191.0656081905245, 5062.594992400617, 5158.819441319554, 5234.214867769846, 5235.293235413209, 5265.289185959885, 5081.618878584102, 5163.7418129093585, 5174.767135478913, 5208.244804503344, 5243.659162154467, 5178.7928482860825, 5190.039842629126, 5202.193659982709, 5212.53087222148, 5234.816781412632, 4905.23968784839, 4920.8031678732805, 4996.600271978269, 5051.797928082872, 5162.303089082963, 5390.272313237702, 5412.431694672042, 5439.129739241703, 5448.264484294609, 5470.398256191816, 6014.218151640259, 6017.1275165100815, 6063.666498342589, 6080.695965201767, 6091.634501929854, 5907.379725128885, 6034.758609655609, 6110.419510146529, 6123.2652081750475, 6124.265088189446, 5627.71861406928, 5649.0, 5650.802221922213, 5655.802046928337, 5663.830085097413, 5984.910226346608, 6135.202423684982, 6148.077788331697, 6150.86209051318, 6151.384861513902, 5910.143029260733, 5927.762889484372, 5939.792107276225, 5943.970280148572, 5969.820905372846, 6007.459328660441, 6030.939690603038, 6044.0, 6046.516278697693, 6055.788047418319, 5827.4172582741385, 5972.163897054415, 5991.0, 6001.039833626599, 6005.03919372907, 6038.516918646497, 6051.0, 6053.4551890330085, 6075.75696972125, 6101.908471372933, 4613.123506533748, 4619.099275641285, 4625.421822272216, 4627.722336659811, 4653.325267836145, 4073.7555746655294, 4085.530164031115, 4137.048478849882, 4138.751674899516, 4166.812493437803, 5474.945250547523, 5676.9497642936185, 5705.115707065412, 5754.251947246831, 5826.796062137805, 6029.397060293935, 6040.335563088057, 6043.0, 6050.48570871472, 6058.818235452944, 5571.554275657938, 5664.51851592611, 5724.79963201286, 5747.39652336507, 5757.481826635539, 5148.58811295103, 5172.560332371715, 5179.48205179479, 5183.481651834862, 5184.066867963803, 6234.532410069263, 6237.937620623827, 6251.343608921089, 6258.280297765724, 6261.186045814106, 5916.792912248051, 6022.126791615104, 6050.122732203894, 6106.870229007648, 6140.692965351804, 6079.0, 6109.17526133984, 6110.69446527663, 6121.265448146251, 6255.343188965093, 5907.025340818888, 5915.231019967377, 5916.230889984275, 5937.554683398676, 5961.970190149022, 5912.290525137011, 5991.071383935497, 6061.15143879866, 6080.665563393879, 6091.604045737013, 5869.882602347844, 5890.175375447355, 5891.263592050994, 5922.170896074467, 5949.613275137102, 5794.7102644866745, 5902.0, 5906.911396329145, 5929.584929054925, 5950.31571369298, 5731.3408957968695, 5743.052396354555, 5779.595428319977, 5782.826515204551, 5819.679917604572, 5921.792737254175, 5932.347441781487, 5954.851128721643, 5961.314448838266, 5961.821145365646, 5697.800576979786, 5760.596758226884, 5825.737841797214, 5835.299764028344, 5861.296644402529], "unit": "score", "name": "dojo.html", "value": 5555.505508582044}, {"lowerIsBetter": false, "replicates": [506.50615649741485, 548.0792268988101, 561.2339157050627, 564.4750382144605, 566.498648695904, 39352.40971385428, 39880.40179397311, 39974.60025399745, 40067.0, 40241.0, 44182.33726494105, 44185.33721994173, 44282.114357712904, 44583.55416445834, 44703.0, 8793.2965362771, 9011.819763604724, 9025.232855207316, 9056.77358066047, 9061.773455663628, 8874.334424918125, 8978.147076027766, 9000.189982901538, 9249.306302027342, 9263.258939284875, 9169.40398874071, 9297.44215347078, 9306.627734890597, 9315.860262096074, 9359.0, 9191.08089191079, 9243.306751993627, 9278.35051546392, 9316.767080822965, 9325.067493250688, 9074.63701451941, 9216.815663686688, 9253.444793312356, 9274.675386361445, 9306.53467326631, 43250.78374608107, 43547.56452435499, 43760.562394375964, 43791.0, 43809.0, 3160.336329370835, 3517.9472307915403, 3840.9615903841163, 4052.5744796796207, 4488.326750987378, 29585.70414295851, 30082.0, 30140.24649383761, 30186.0, 30547.694523054706, 4060.3909413587903, 4215.936760948588, 4255.085156691326, 4292.699511034229, 4305.698601097924, 203135.0, 203233.0, 203431.0, 203728.98135509377, 204752.97623511936, 47000.0, 47757.522424776005, 64621.0, 65479.67260163764, 65677.0, 43951.560484395384, 43990.780046099564, 44000.11999759987, 44008.0, 44156.779216103714, 15817.841821581867, 15940.0, 15954.840451595568, 16005.679886402208, 16065.678686426207, 12612.621621351374, 12714.237145771283, 12762.489500419879, 12765.42555585001, 12774.61676149717, 15077.246137693071, 15689.843101569066, 15764.76352854708, 15770.526884193492, 15811.288492017888, 5893.675847828325, 5951.345352011275, 5971.402859713994, 6078.848028799315, 6203.286622038523, 1075.2473268711933, 1087.0705546757567, 1107.06453047175, 1119.9976021460748, 1164.2083383299437, 30615.2346191347, 30872.382552348827, 30904.845475772476, 30981.225469363446, 31524.684753152633, 1071.3357718214756, 1099.6646022963073, 1112.3326004397297, 1144.3191301175787, 1246.8254444377794, 14168.504102356368, 14867.405303787944, 15097.773533397009, 15306.234688265766, 15584.06495610267, 341306.0, 809515.0, 809598.0, 811871.0, 843482.0, 63943.36056639467, 64415.355846441875, 64725.35274647193, 64814.0277895832, 64861.675691622186, 1471.948481803153, 1485.3612946433138, 1485.628592851787, 1515.4847351900187, 1519.9240037998056, 31560.52659210068, 31849.522257165696, 32335.35329293448, 32510.83744581262, 32704.509432358056, 53057.73471132619, 54258.18612720734, 54417.18374224469, 54712.0, 54796.72601636966, 316990.0, 322382.0, 322592.0, 324810.0, 325483.0, 35230.823845881634, 35436.0, 35503.28993420169, 35541.64458355383, 36198.09504762297, 47491.0, 48007.27989080236, 48346.274805878646, 48620.0, 49287.0, 40474.1905161901, 40492.595074048884, 40963.1807363857, 41362.379564307164, 42366.152676946906, 40179.0, 40526.0, 40779.0, 41030.38454423246, 41438.96402589959, 39791.0, 40900.79549602233, 41183.0, 41202.79398602988, 41551.168976619694, 35320.64679353276, 35597.110072248404, 35751.64248357483, 36025.63974360223, 36577.45133822942, 27835.0, 28283.292917677223, 28447.004354847482, 28507.0, 28587.0], "unit": "score", "name": "ext.html", "value": 19656.93358630685}, {"lowerIsBetter": false, "replicates": [369.1159672584161, 372.50084886252426, 384.2142817937318, 384.9980750096249, 388.6696308138081, 17757.289708411663, 18145.7278140828, 19004.90497547514, 19070.809291907077, 19104.42686719399, 18083.457496275132, 18552.165152568134, 18562.35031773888, 18600.627987440243, 18629.441116766484, 5522.861928451781, 5727.484526392624, 5752.5110365618975, 5766.596338256324, 5780.653160810344, 5660.179274005267, 6767.898481522781, 7142.892856607155, 7158.2125966143685, 7161.9973203751515, 6412.262589802186, 7103.289671032907, 7116.359527642511, 7123.0, 7125.216226215112, 6609.603423794563, 6651.434628056621, 6675.93185090388, 6689.799306020852, 6714.529982901199, 6545.607263564201, 6773.45812335012, 6785.6267905265195, 6828.624425656587, 6838.316168383122, 23814.404639883967, 25227.0, 25457.10900118487, 25715.35711607206, 25927.0, 2495.5882279424054, 2583.7028741694758, 2720.2519307190482, 2729.4950434169546, 3249.610046794376, 14396.0, 14408.06347587414, 14994.62513437162, 15141.0, 15413.460528881435, 1951.4731022623955, 1955.7261983322346, 1999.1044330563768, 2128.7977642123974, 2168.6313326734494, 78819.0, 81869.0, 82069.0, 82599.58700206521, 83253.58373208156, 14885.627859303604, 15833.287502062434, 15915.840841591436, 15947.521574352555, 16146.192690365435, 26815.061472848356, 26842.32894177622, 27206.591901121497, 27321.72678273192, 27475.450490990068, 9147.77130571741, 9475.48899541622, 9585.616575337048, 9761.316707830383, 9798.902010979798, 8296.668133274601, 8330.333573314121, 8369.748907532783, 8434.662613495391, 8487.533185674723, 7862.606869656494, 7877.448578599443, 7968.0, 7974.5215287082965, 7989.960050199828, 1931.2854243929835, 1998.280618977167, 2004.8696834705988, 2035.623409669216, 2039.6940458930983, 967.9758006049764, 1006.8288390973552, 1099.3898386395626, 1116.8548088748412, 1139.2879450343535, 17910.91044544769, 17983.280668773365, 18020.459386218434, 18168.364107256184, 18552.536186595175, 1014.264658122855, 1032.4837581209395, 1038.2524582300732, 1061.7611037516651, 1077.9299345542515, 10265.846012309821, 10560.36637801719, 10604.310719803188, 10684.038436540748, 10795.0, 431371.0, 432093.0, 439633.0, 443770.0, 446034.0, 81322.0, 82706.17293827105, 83043.0, 83853.0, 84193.57903210445, 1057.0697785948316, 1061.0821639281965, 1076.3541874875011, 1093.2292733622776, 1093.2675107677876, 15982.60043498922, 15992.600184995468, 16307.673846523241, 16475.83524164743, 16526.091064991542, 35740.82129589439, 36208.913732588066, 36291.63708362988, 36394.0, 36642.7175048872, 50848.237276440144, 52628.47371526236, 53001.20498192607, 53107.0, 53577.46422535881, 8607.953420208301, 8660.39377243587, 8783.648654053766, 9000.54997250148, 9020.05289444599, 13405.0, 13823.654408639864, 13953.697549957758, 14093.295335233403, 14258.786118208443, 11413.828792567952, 12104.576339828063, 12107.668156502601, 12537.122401432178, 12539.310337931502, 12180.147389682637, 12261.589917159641, 12301.876981230072, 12359.814602781145, 12614.810777838156, 11904.702382440508, 12330.630081097223, 12631.810522842348, 12652.873471265537, 12687.746245075232, 8583.65665373378, 8859.3798434109, 8992.325575581988, 9063.546822658973, 9087.818243635222, 11409.486573104065, 11810.82283765727, 11963.940180299043, 12176.330301833485, 12176.939115304367], "unit": "score", "name": "jquery.html", "value": 9984.152427254814}, {"lowerIsBetter": false, "replicates": [1623.9837601623983, 1650.9174541272937, 1933.4393026022453, 1959.8726082804626, 2021.3026505855485, 7698.191689872567, 8285.83428331433, 8418.284445822097, 8489.151084891508, 8503.872441913369, 8388.161183881608, 8410.327173826094, 8521.446106003106, 8521.957390213056, 8527.445716028455, 2400.4838959623676, 2440.890159942798, 2444.2422848916804, 2453.460238747473, 2456.9262922112366, 2443.6823212982285, 2487.8880450379684, 2503.8748062596887, 2504.2987963370288, 2521.962170567434, 2447.657327974085, 2451.82837201396, 2455.9631605525933, 2460.5817011108156, 2473.245660073677, 2439.231642032763, 2441.3652450362943, 2460.2250291158316, 2484.0312278211513, 2492.277239600514, 2477.0834791127218, 2484.9130280440277, 2490.3688084304626, 2500.374906273432, 2517.798576113925, 8553.486790792573, 8578.742637720878, 8627.870581941275, 8634.827303453958, 8643.567821608958, 5164.483551644843, 5248.21276808478, 5250.94981003797, 5299.125644268691, 5345.946540534623, 3210.5826242588546, 3228.790128641631, 3244.7345535241275, 3254.739620830328, 3304.520844477537, 965.1024547171128, 1017.0897047142839, 1032.1742605915313, 1050.6900464363032, 1058.3808472043863, 11843.111766617538, 11897.702557436047, 11934.522619095313, 11956.461959211856, 12000.879991200063, 4294.26997410441, 4336.089421221515, 4342.41377414045, 4513.909721805546, 4525.456945166601, 9608.95195524018, 9617.759556011155, 9629.277804164716, 9637.855432168522, 9642.903570964201, 5219.16493361068, 5221.008008478377, 5233.0, 5238.266642670029, 5243.397009343974, 4278.4865816102265, 4638.234691275969, 4669.976650116728, 4722.952770472251, 4741.336212930192, 3529.0647978285774, 3579.3736096183065, 3617.9276414471565, 3631.618680038611, 3639.8544058237376, 1067.6690226029955, 1096.2107282756403, 1096.660035389032, 1100.6202860013282, 1112.5883423133491, 1212.1393810394718, 1218.8232706257543, 1219.5792451604182, 1487.6727120033574, 1499.5576304990054, 7873.881891771628, 8050.798730031796, 8276.08963014068, 8292.04641466239, 8311.709090181814, 519.6570263625989, 523.2674256041572, 525.0680042923841, 538.8625900395374, 550.867791729982, 5989.970050149808, 6031.879362412815, 6067.0, 6102.816915492543, 6115.877682446415, 10316.484175791331, 10576.418296993585, 10607.628732994308, 10608.045275925204, 10709.946450267698, 9850.704478865646, 10469.633562825416, 10481.056704896597, 10487.37075775456, 10547.57809687604, 8045.316148127475, 8092.3121534669035, 8152.470089444286, 8173.959130204311, 8195.877061844078, 7955.562444065632, 7989.520628762293, 7998.680052797823, 8057.033156021315, 8126.796830079295, 9030.322725795722, 9160.725178244664, 9273.21177699876, 9379.108984646447, 9429.009953954735, 9503.809923801347, 9655.806883862142, 9704.9029509704, 9768.609255629695, 9784.364016338915, 6946.756863509753, 7376.7418140364825, 7430.2569743027425, 7514.436417268617, 7520.398368130427, 8136.105028446985, 8183.427160098736, 8188.5905704715715, 8188.976377952756, 8189.590520473834, 7069.893951590833, 7271.127464704269, 7397.408207343292, 7475.0656167979005, 7517.812054698677, 7168.139823221039, 7182.928170718226, 7216.097987751531, 7351.522151060378, 7536.849263014599, 7199.532030418006, 7281.199068102399, 7299.817504562428, 7312.085989251344, 7358.785800342884, 6924.896126558207, 6931.09895713554, 7016.5790052597, 7023.929760702532, 7050.647467626701, 7220.628080664867, 7284.599347035964, 7305.926940730737, 7314.743983960536, 7323.2676732326345], "unit": "score", "name": "mootools.html", "value": 4750.363390914974}, {"lowerIsBetter": false, "replicates": [363.76537133548845, 367.2563059803897, 372.1310739423446, 372.36697614056095, 374.8613013185122, 6411.1024456576115, 6441.613503189812, 6452.0967064610995, 6462.741490340392, 6509.902351464726, 6358.268799088106, 6367.140436041133, 6373.0759039939185, 6384.138141350928, 6399.872002559946, 4856.538628830255, 4941.925871111936, 4946.109700253962, 4956.2070068789, 4960.107180707471, 4945.381827271591, 4960.454350021495, 4964.280179373988, 4968.726720030397, 4970.6520543561965, 4942.283368911523, 4980.053789779949, 4982.277569752384, 4982.377202849644, 4988.2766998785155, 4975.4527002029745, 4987.451380348159, 4990.3762029746285, 4996.225585034325, 5020.573251273646, 4453.799579018952, 4455.0, 4455.8217671293105, 4469.061497085616, 4470.619997300233, 5914.852128696774, 6107.114468402101, 6162.22972128484, 6168.660723660197, 6170.136180934673, 5737.684427356494, 5774.0, 5780.653160810365, 5781.508571771363, 5792.565557583198, 6843.486738494633, 6843.8973415398805, 6844.28135045823, 6845.452363810933, 6863.828404289883, 4805.783739731721, 4814.325994360793, 4816.373871396731, 4819.927701084486, 4828.130936431441, 7028.578285302899, 7034.5779253244455, 7077.539959902641, 7122.679479423438, 7126.64366781664, 4897.289892965571, 4906.190478571068, 4963.528464795839, 4973.6269779765935, 5020.472850350734, 5026.4973502649445, 5032.345795046621, 5041.546260836469, 5056.089903817275, 5058.848234552969, 5670.5747068969995, 5727.198192253088, 5740.971295143498, 5754.74103665336, 5798.768049278066, 6843.0419741236265, 6864.24493305736, 6869.965650171817, 6873.656317184121, 6881.346272104142, 1799.253309876413, 1828.9908550457162, 1830.048374845073, 1830.6430246101881, 1834.3304693786672, 1191.3090407563593, 1210.6973256685828, 1232.7904256276454, 1235.765204611121, 1242.3043095866344, 6514.706838192293, 6533.738650453929, 6547.901781473186, 6555.672216389162, 6557.278699343068, 6950.895736563955, 6980.127484064492, 7003.194632617212, 7017.61403122823, 7028.683709232994, 6489.513286503531, 6543.574667646588, 6547.443467305332, 6549.639769812611, 6558.508111891627, 3709.258148370283, 3739.476473293741, 3789.3558095123344, 3801.9239615208094, 3810.3712887373827, 7276.7453139140935, 7407.481476296715, 7419.629018549159, 7430.702771889064, 7441.441891858132, 7281.417486601059, 7295.6352182390665, 7296.233895441009, 7302.0, 7305.525140865827, 7341.302576255247, 7354.963225183733, 7365.189829118793, 7383.003294555167, 7413.8146546336775, 6993.335633114846, 7097.25478824716, 7109.0, 7118.893216601651, 7135.143782746104, 6991.860162796817, 6998.790036298919, 7010.509264351446, 7014.088168538057, 7029.507934444539, 7279.636018199175, 7306.050213472215, 7314.195438501867, 7352.448566357438, 7362.411007119311, 4741.786619602057, 4773.856784296477, 4783.330333753208, 4789.401324834395, 4789.976050119727, 6734.966325168343, 6964.477664175106, 7034.155901291878, 7123.679434425567, 7154.284571542804, 6862.553933994274, 6867.896981545181, 6869.7595584154315, 6879.965600171967, 6916.3429474199875, 6885.827854303482, 6891.241963383924, 6893.241743408322, 6894.345037221456, 6909.516333856582, 6758.2903795102775, 6765.458763298826, 6777.830554236183, 6790.558613690095, 6859.965700171467, 6825.55633883796, 6894.448444124559, 6932.306769323028, 6945.0, 6953.20038195614, 6717.462602991651, 6727.629980351127, 6751.257361690112, 6755.088063111417, 6772.05191273232], "unit": "score", "name": "prototype.html", "value": 5203.881638362886}, {"lowerIsBetter": false, "replicates": [770.1720650300927, 843.3759018326436, 864.5590748718151, 866.0, 880.6345366672831, 12182.634520964375, 12958.222506649585, 12963.740725185491, 13448.394822233011, 13526.458941642335, 12325.322107284095, 12346.259224446518, 12363.938180309086, 12373.381330933462, 12386.628401147958, 761.7600455856401, 912.6531917871233, 927.0405130689737, 927.0682963621551, 928.4661319741142, 918.4443411735904, 927.0405130689737, 928.401181238101, 930.3208657679897, 931.3620170183412, 955.2739917662592, 967.6951760195516, 967.9419234845897, 972.1396564040839, 975.2636759246759, 952.3571589177278, 966.1111777165025, 967.4969016111653, 972.2513664478312, 981.1464026297095, 717.6483523073708, 721.6211488968333, 723.3598265535039, 723.4212629896062, 724.2612535214105, 12435.502579896793, 12464.252144871336, 12467.438965246585, 12472.376381180904, 12547.93726031373, 13571.52499662507, 13707.725845483134, 13745.587632371045, 13745.931270343684, 13780.586582402444, 10162.288639795217, 10347.0, 10379.377237365783, 10420.374777513374, 10445.477726113664, 3872.419137129425, 3895.9026024349337, 3901.7463864848696, 3915.158240978175, 3941.8029098544957, 51074.48925510734, 51075.0, 51209.743951280376, 51939.48060519384, 52134.478655213345, 10528.315659482108, 10556.102731267774, 10696.679099627023, 10814.080803131821, 10880.401577913133, 18658.44024679262, 18664.9734264614, 19212.903935480233, 19680.11439485198, 19688.90155549213, 7069.540479868792, 7167.856642867114, 7212.098487689039, 7246.855062898712, 7327.926720732725, 3870.554886188068, 3926.862559810393, 3930.1613111113293, 3966.2662407454714, 4101.364288535222, 3131.592892923951, 3147.118806734118, 3159.462891308483, 3162.667919868427, 3181.0456862941023, 579.7970710251462, 583.4690431707127, 583.8102616649605, 586.6480111932806, 590.503976659608, 533.1416419564498, 549.3325609384617, 550.5100460590078, 605.9697015149225, 640.3180612647516, 8098.919010809816, 8170.591470426455, 8203.548804815793, 8208.466449680871, 8277.875831862528, 547.8879961816839, 669.6752075243503, 672.1396612336217, 675.0111087257192, 678.2302087131142, 3694.445833124999, 3748.887533374003, 3826.770393776382, 3835.520559930009, 3924.0974575847144, 58919.70540147272, 60751.69624151851, 61182.694086529285, 62203.0, 62322.688386558686, 54558.45441545534, 54824.0, 55311.0, 55424.0, 55655.0, 48547.271790923165, 49197.0, 49451.258231126565, 49814.0, 50121.49878501241, 7505.624718764149, 7625.351845093229, 7948.443608947318, 7985.92014079875, 8051.033875934925, 36891.0, 37754.24491510209, 37938.8103059483, 38005.0, 39239.607603924735, 43987.0, 44727.0, 47455.28817067678, 47554.0, 48730.0, 9501.952490237505, 9539.0, 9791.363561368487, 9917.107460328605, 10101.747456313651, 10017.599296028076, 10201.081902628799, 10590.205734569783, 10639.680809575415, 10794.838077429002, 9294.442333460014, 9499.715008549754, 9612.423254604746, 9655.662051828433, 9689.729880145484, 9657.855132173163, 9933.453660048766, 10017.5492102857, 10152.340097893613, 10318.793624127626, 9287.442753434816, 9418.387804792666, 9538.761530961503, 9578.664746733832, 9747.512624368612, 8451.408401412087, 8718.476891386537, 8818.870969348662, 8891.0, 8914.955425222832, 8120.634571444417, 8251.669933202606, 8368.539730314891, 8573.356998225034, 8741.125887411208], "unit": "score", "name": "yui.html", "value": 6282.418013583289}], "name": "dromaeo_css", "value": 7438.091403886652}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 111.0, 111.0, 121.0, 110.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [159.0, 128.0, 160.0, 165.0, 127.0, 153.0, 157.0, 128.0, 166.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 163.0, 162.0, 164.0, 162.0, 163.0, 161.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 75.0, 165.0, 76.0, 76.0, 77.0, 74.0, 167.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 149.0, 93.0, 93.0, 93.0, 142.0, 94.0, 93.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 116.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 149.0, 146.0, 146.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 56.0, 56.0, 56.0, 55.0, 58.0, 61.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 64.0, 65.0, 65.0, 66.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.9}, {"lowerIsBetter": true, "replicates": [84.0, 77.0, 78.0, 80.0, 78.0, 86.0, 79.0, 79.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 111.0, 111.0, 111.0, 113.0, 115.0, 115.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.0}, {"lowerIsBetter": true, "replicates": [137.0, 145.0, 159.0, 144.0, 141.0, 146.0, 146.0, 151.0, 163.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 67.0, 70.0, 68.0, 68.0, 71.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1514.3}]} 09:46:57 INFO - Return code: 0 09:46:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:46:57 ERROR - # TBPL SUCCESS # 09:46:57 INFO - Running post-action listener: _resource_record_post_action 09:46:57 INFO - Running post-run listener: _resource_record_post_run 09:46:58 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 494858240; Read time: 16; Write time: 854916 09:46:58 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 242905088; Read time: 0; Write time: 599244 09:46:58 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249622528; Read time: 16; Write time: 255176 09:46:58 INFO - Running post-run listener: _upload_blobber_files 09:46:58 INFO - Blob upload gear active. 09:46:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:46:58 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 09:46:58 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'] 09:46:58 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 09:46:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:46:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:46:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:46:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:59 INFO - (blobuploader) - INFO - Done attempting. 09:46:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:46:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:00 INFO - (blobuploader) - INFO - Done attempting. 09:47:00 INFO - (blobuploader) - INFO - Iteration through files over. 09:47:00 INFO - Return code: 0 09:47:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:47:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:47:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2b0432e440bc228503d0a4733b585f4901c8a627ac203d229670a92457247c81d090a3a967c8edf17fc28fffa5c714f46778da49a3ad8c3be283776361e652b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1387fe599b0eab48822d48cbc399e203e77045261d048c2bb0de7729f12533e4832e71d4f67f2e67533778b060d70d1f77b702040e1c40d4df7e447ab95abce6"} 09:47:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:47:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:47:00 INFO - Contents: 09:47:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2b0432e440bc228503d0a4733b585f4901c8a627ac203d229670a92457247c81d090a3a967c8edf17fc28fffa5c714f46778da49a3ad8c3be283776361e652b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1387fe599b0eab48822d48cbc399e203e77045261d048c2bb0de7729f12533e4832e71d4f67f2e67533778b060d70d1f77b702040e1c40d4df7e447ab95abce6"} 09:47:00 INFO - Running post-run listener: copy_logs_to_upload_dir 09:47:00 INFO - Copying logs to upload dir... 09:47:00 INFO - mkdir: /builds/slave/test/build/upload/logs 09:47:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.802535 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-14 09:47:00.232345) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 09:47:00.235938) ========= 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=df17445c3590ff7897617a0e00000225-1460651056.329085-53871849 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/c2b0432e440bc228503d0a4733b585f4901c8a627ac203d229670a92457247c81d090a3a967c8edf17fc28fffa5c714f46778da49a3ad8c3be283776361e652b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1387fe599b0eab48822d48cbc399e203e77045261d048c2bb0de7729f12533e4832e71d4f67f2e67533778b060d70d1f77b702040e1c40d4df7e447ab95abce6"} build_url:https://queue.taskcluster.net/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/RlCChW83RY66Gtt2-526JQ/artifacts/public/build/firefox-47.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/c2b0432e440bc228503d0a4733b585f4901c8a627ac203d229670a92457247c81d090a3a967c8edf17fc28fffa5c714f46778da49a3ad8c3be283776361e652b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1387fe599b0eab48822d48cbc399e203e77045261d048c2bb0de7729f12533e4832e71d4f67f2e67533778b060d70d1f77b702040e1c40d4df7e447ab95abce6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 09:47:00.262920) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:47:00.263309) ========= 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=df17445c3590ff7897617a0e00000225-1460651056.329085-53871849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:47:00.345587) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 09:47:00.346054) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 09:47:00.346540) ========= ========= Total master_lag: 0.17 =========