builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1461407474.02 results: success (0) buildid: 20160423004022 builduid: 973597a5c0584e62a5fcd9a4f60287b0 revision: 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:14.025183) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:14.025937) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:14.026444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:14.045200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:14.045847) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 03:31:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.0M=0s 2016-04-23 03:31:15 (25.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121220 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:14.181371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:14.181704) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016255 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:14.231530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 03:31:14.235015) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 --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 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 --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=6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 03:31:15,199 truncating revision to first 12 chars 2016-04-23 03:31:15,199 Setting DEBUG logging. 2016-04-23 03:31:15,199 attempt 1/10 2016-04-23 03:31:15,199 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7e7d31a29b4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 03:31:16,487 unpacking tar archive at: mozilla-aurora-7e7d31a29b4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.579499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 03:31:15.830789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.831128) ========= script_repo_revision: 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.831529) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.834957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.844795) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-23 03:31:15.845209) ========= /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=6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:16 INFO - MultiFileLogger online at 20160423 03:31:16 in /builds/slave/test 03:31:16 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 03:31:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:16 INFO - {'append_to_log': False, 03:31:16 INFO - 'base_work_dir': '/builds/slave/test', 03:31:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:31:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:16 INFO - 'branch': 'Mozilla-Aurora', 03:31:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:16 INFO - 'config_files': ('talos/linux_config.py',), 03:31:16 INFO - 'default_actions': ('clobber', 03:31:16 INFO - 'read-buildbot-config', 03:31:16 INFO - 'download-and-extract', 03:31:16 INFO - 'populate-webroot', 03:31:16 INFO - 'create-virtualenv', 03:31:16 INFO - 'install', 03:31:16 INFO - 'run-tests'), 03:31:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:16 INFO - 'download_minidump_stackwalk': True, 03:31:16 INFO - 'download_symbols': 'ondemand', 03:31:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:16 INFO - 'installer_path': 'installer.exe', 03:31:16 INFO - 'log_level': 'info', 03:31:16 INFO - 'log_name': 'talos', 03:31:16 INFO - 'log_to_console': True, 03:31:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:16 INFO - 'opt_config_files': (), 03:31:16 INFO - 'pip_index': False, 03:31:16 INFO - 'sps_profile': False, 03:31:16 INFO - 'sps_profile_interval': 0, 03:31:16 INFO - 'suite': 'dromaeojs-e10s', 03:31:16 INFO - 'system_bits': '32', 03:31:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:16 INFO - 'title': 'talos-linux64-ix-023', 03:31:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:16 INFO - 'use_talos_json': True, 03:31:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:16 INFO - 'work_dir': 'build'} 03:31:16 INFO - ##### 03:31:16 INFO - ##### Running clobber step. 03:31:16 INFO - ##### 03:31:16 INFO - Running pre-action listener: _resource_record_pre_action 03:31:16 INFO - Running main action method: clobber 03:31:16 INFO - rmtree: /builds/slave/test/build 03:31:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:17 INFO - Running post-action listener: _resource_record_post_action 03:31:17 INFO - ##### 03:31:17 INFO - ##### Running read-buildbot-config step. 03:31:17 INFO - ##### 03:31:17 INFO - Running pre-action listener: _resource_record_pre_action 03:31:17 INFO - Running main action method: read_buildbot_config 03:31:17 INFO - Using buildbot properties: 03:31:17 INFO - { 03:31:17 INFO - "project": "", 03:31:17 INFO - "product": "firefox", 03:31:17 INFO - "script_repo_revision": "production", 03:31:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:31:17 INFO - "repository": "", 03:31:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:31:17 INFO - "buildid": "20160423004022", 03:31:17 INFO - "stage_platform": "linux64-pgo", 03:31:17 INFO - "basedir": "/builds/slave/test", 03:31:17 INFO - "nightly_build": "True", 03:31:17 INFO - "buildnumber": 236, 03:31:17 INFO - "slavename": "talos-linux64-ix-023", 03:31:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:31:17 INFO - "platform": "ubuntu64_hw", 03:31:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:31:17 INFO - "branch": "mozilla-aurora", 03:31:17 INFO - "repo_path": "releases/mozilla-aurora", 03:31:17 INFO - "revision": "7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46", 03:31:17 INFO - "pgo_build": "True", 03:31:17 INFO - "builduid": "973597a5c0584e62a5fcd9a4f60287b0", 03:31:17 INFO - "slavebuilddir": "test" 03:31:17 INFO - } 03:31:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:31:17 INFO - Running post-action listener: _resource_record_post_action 03:31:17 INFO - ##### 03:31:17 INFO - ##### Running download-and-extract step. 03:31:17 INFO - ##### 03:31:17 INFO - Running pre-action listener: _resource_record_pre_action 03:31:17 INFO - Running main action method: download_and_extract 03:31:17 INFO - mkdir: /builds/slave/test/build/tests 03:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:17 INFO - https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:31:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:31:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/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 03:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/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 03:31:22 INFO - Downloaded 1448 bytes. 03:31:22 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:31:22 INFO - Using the following test package requirements: 03:31:22 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:22 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:22 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:31:22 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:22 INFO - u'jsshell-linux-x86_64.zip'], 03:31:22 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:22 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:22 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:31:22 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:31:22 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:22 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:22 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:22 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:22 INFO - https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:31:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:31:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/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 03:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/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 03:31:27 INFO - Downloaded 23358998 bytes. 03:31:27 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'] 03:31:27 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 03:31:28 INFO - Return code: 0 03:31:28 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 03:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:28 INFO - https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:31:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:31:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/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 03:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/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 03:31:32 INFO - Downloaded 23358998 bytes. 03:31:32 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'] 03:31:32 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 03:31:33 INFO - Return code: 0 03:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:33 INFO - https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/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 03:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/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 03:31:34 INFO - Downloaded 10845194 bytes. 03:31:34 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'] 03:31:34 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 03:31:34 INFO - Return code: 0 03:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:34 INFO - https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:31:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:31:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/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 03:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/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 03:31:36 INFO - Downloaded 60835987 bytes. 03:31:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:31:36 INFO - mkdir: /builds/slave/test/properties 03:31:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:36 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:36 INFO - Contents: 03:31:36 INFO - build_url:https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:31:37 INFO - Running post-action listener: _resource_record_post_action 03:31:37 INFO - Running post-action listener: set_extra_try_arguments 03:31:37 INFO - ##### 03:31:37 INFO - ##### Running populate-webroot step. 03:31:37 INFO - ##### 03:31:37 INFO - Running pre-action listener: _resource_record_pre_action 03:31:37 INFO - Running main action method: populate_webroot 03:31:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:37 INFO - '--tppagecycles', 03:31:37 INFO - '7'], 03:31:37 INFO - 'tests': ['tsvgm']}}, 03:31:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:31:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:31:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:31:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:31:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:37 INFO - 'talos_options': ['--e10s'], 03:31:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:37 INFO - 'tests': ['damp', 'tps']}, 03:31:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:37 INFO - 'talos_options': ['--e10s'], 03:31:37 INFO - 'tests': ['damp', 'tps']}, 03:31:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:31:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:37 INFO - 'other': {'tests': ['a11yr', 03:31:37 INFO - 'ts_paint', 03:31:37 INFO - 'tpaint', 03:31:37 INFO - 'sessionrestore', 03:31:37 INFO - 'sessionrestore_no_auto_restore', 03:31:37 INFO - 'tabpaint']}, 03:31:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:31:37 INFO - 'tests': ['a11yr', 03:31:37 INFO - 'ts_paint', 03:31:37 INFO - 'tpaint', 03:31:37 INFO - 'sessionrestore', 03:31:37 INFO - 'sessionrestore_no_auto_restore', 03:31:37 INFO - 'tabpaint']}, 03:31:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:31:37 INFO - 'tests': ['a11yr', 03:31:37 INFO - 'ts_paint', 03:31:37 INFO - 'tpaint', 03:31:37 INFO - 'sessionrestore', 03:31:37 INFO - 'sessionrestore_no_auto_restore', 03:31:37 INFO - 'tabpaint']}, 03:31:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:31:37 INFO - 'tests': ['a11yr', 03:31:37 INFO - 'ts_paint', 03:31:37 INFO - 'tpaint', 03:31:37 INFO - 'sessionrestore', 03:31:37 INFO - 'sessionrestore_no_auto_restore', 03:31:37 INFO - 'tabpaint']}, 03:31:37 INFO - 'other_l64': {'tests': ['a11yr', 03:31:37 INFO - 'ts_paint', 03:31:37 INFO - 'tpaint', 03:31:37 INFO - 'sessionrestore', 03:31:37 INFO - 'sessionrestore_no_auto_restore', 03:31:37 INFO - 'tabpaint']}, 03:31:37 INFO - 'other_nol64': {'tests': ['a11yr', 03:31:37 INFO - 'ts_paint', 03:31:37 INFO - 'tpaint', 03:31:37 INFO - 'sessionrestore', 03:31:37 INFO - 'sessionrestore_no_auto_restore', 03:31:37 INFO - 'tabpaint']}, 03:31:37 INFO - 'svgr': {'tests': ['tsvgx', 03:31:37 INFO - 'tsvgr_opacity', 03:31:37 INFO - 'tart', 03:31:37 INFO - 'tscrollx', 03:31:37 INFO - 'cart']}, 03:31:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:31:37 INFO - 'tests': ['tsvgx', 03:31:37 INFO - 'tsvgr_opacity', 03:31:37 INFO - 'tart', 03:31:37 INFO - 'tscrollx', 03:31:37 INFO - 'cart']}, 03:31:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:37 INFO - 'tests': ['tp5o']}, 03:31:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:37 INFO - 'talos_options': ['--e10s'], 03:31:37 INFO - 'tests': ['tp5o']}, 03:31:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:37 INFO - 'talos_options': ['--xperf_path', 03:31:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:37 INFO - 'tests': ['tp5n']}, 03:31:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:37 INFO - 'talos_options': ['--e10s', 03:31:37 INFO - '--xperf_path', 03:31:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:37 INFO - 'tests': ['tp5n']}}, 03:31:37 INFO - 'talos.zip': {'path': '', 03:31:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:37 INFO - Running post-action listener: _resource_record_post_action 03:31:37 INFO - ##### 03:31:37 INFO - ##### Running create-virtualenv step. 03:31:37 INFO - ##### 03:31:37 INFO - Running pre-action listener: _resource_record_pre_action 03:31:37 INFO - Running main action method: create_virtualenv 03:31:37 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:37 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 03:31:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:37 INFO - Using real prefix '/usr' 03:31:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:37 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:39 INFO - Installing pip.................done. 03:31:39 INFO - Return code: 0 03:31:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:39 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 0x7fbc9eeb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', '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 03:31:39 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 03:31:39 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 03:31:39 INFO - Using env: {'DISPLAY': ':0', 03:31:39 INFO - 'HOME': '/home/cltbld', 03:31:39 INFO - 'LANG': 'en_US.UTF-8', 03:31:39 INFO - 'LANGUAGE': 'en_US:en', 03:31:39 INFO - 'LOGNAME': 'cltbld', 03:31:39 INFO - 'MAIL': '/var/mail/cltbld', 03:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:39 INFO - 'MOZ_NO_REMOTE': '1', 03:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:39 INFO - 'NO_EM_RESTART': '1', 03:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:39 INFO - 'PWD': '/builds/slave/test', 03:31:39 INFO - 'SHELL': '/bin/bash', 03:31:39 INFO - 'SHLVL': '1', 03:31:39 INFO - 'TERM': 'linux', 03:31:39 INFO - 'TMOUT': '86400', 03:31:39 INFO - 'USER': 'cltbld', 03:31:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', 03:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:39 INFO - '_': '/tools/buildbot/bin/python'} 03:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:40 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 03:31:40 INFO - Cleaning up... 03:31:40 INFO - Return code: 0 03:31:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:40 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 0x7fbc9eeb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', '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 03:31:40 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 03:31:40 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 03:31:40 INFO - Using env: {'DISPLAY': ':0', 03:31:40 INFO - 'HOME': '/home/cltbld', 03:31:40 INFO - 'LANG': 'en_US.UTF-8', 03:31:40 INFO - 'LANGUAGE': 'en_US:en', 03:31:40 INFO - 'LOGNAME': 'cltbld', 03:31:40 INFO - 'MAIL': '/var/mail/cltbld', 03:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:40 INFO - 'MOZ_NO_REMOTE': '1', 03:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:40 INFO - 'NO_EM_RESTART': '1', 03:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:40 INFO - 'PWD': '/builds/slave/test', 03:31:40 INFO - 'SHELL': '/bin/bash', 03:31:40 INFO - 'SHLVL': '1', 03:31:40 INFO - 'TERM': 'linux', 03:31:40 INFO - 'TMOUT': '86400', 03:31:40 INFO - 'USER': 'cltbld', 03:31:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', 03:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:40 INFO - '_': '/tools/buildbot/bin/python'} 03:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:40 INFO - Downloading/unpacking psutil>=0.7.1 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:42 INFO - Installing collected packages: psutil 03:31:42 INFO - Running setup.py install for psutil 03:31:42 INFO - building 'psutil._psutil_linux' extension 03:31:42 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 03:31:42 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 03:31:42 INFO - building 'psutil._psutil_posix' extension 03:31:42 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 03:31:42 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 03:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:42 INFO - Successfully installed psutil 03:31:42 INFO - Cleaning up... 03:31:42 INFO - Return code: 0 03:31:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:42 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 0x7fbc9eeb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', '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 03:31:42 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 03:31:42 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 03:31:42 INFO - Using env: {'DISPLAY': ':0', 03:31:42 INFO - 'HOME': '/home/cltbld', 03:31:42 INFO - 'LANG': 'en_US.UTF-8', 03:31:42 INFO - 'LANGUAGE': 'en_US:en', 03:31:42 INFO - 'LOGNAME': 'cltbld', 03:31:42 INFO - 'MAIL': '/var/mail/cltbld', 03:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:42 INFO - 'MOZ_NO_REMOTE': '1', 03:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:42 INFO - 'NO_EM_RESTART': '1', 03:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:42 INFO - 'PWD': '/builds/slave/test', 03:31:42 INFO - 'SHELL': '/bin/bash', 03:31:42 INFO - 'SHLVL': '1', 03:31:42 INFO - 'TERM': 'linux', 03:31:42 INFO - 'TMOUT': '86400', 03:31:42 INFO - 'USER': 'cltbld', 03:31:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', 03:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:42 INFO - '_': '/tools/buildbot/bin/python'} 03:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:31:45 INFO - Installing collected packages: mozsystemmonitor 03:31:45 INFO - Running setup.py install for mozsystemmonitor 03:31:45 INFO - Successfully installed mozsystemmonitor 03:31:45 INFO - Cleaning up... 03:31:45 INFO - Return code: 0 03:31:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:45 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 0x7fbc9eeb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', '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 03:31:45 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 03:31:45 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 03:31:45 INFO - Using env: {'DISPLAY': ':0', 03:31:45 INFO - 'HOME': '/home/cltbld', 03:31:45 INFO - 'LANG': 'en_US.UTF-8', 03:31:45 INFO - 'LANGUAGE': 'en_US:en', 03:31:45 INFO - 'LOGNAME': 'cltbld', 03:31:45 INFO - 'MAIL': '/var/mail/cltbld', 03:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:45 INFO - 'MOZ_NO_REMOTE': '1', 03:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:45 INFO - 'NO_EM_RESTART': '1', 03:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:45 INFO - 'PWD': '/builds/slave/test', 03:31:45 INFO - 'SHELL': '/bin/bash', 03:31:45 INFO - 'SHLVL': '1', 03:31:45 INFO - 'TERM': 'linux', 03:31:45 INFO - 'TMOUT': '86400', 03:31:45 INFO - 'USER': 'cltbld', 03:31:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', 03:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:45 INFO - '_': '/tools/buildbot/bin/python'} 03:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:47 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 03:31:47 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 03:31:47 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 03:31:47 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 03:31:47 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 03:31:47 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 03:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:47 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 03:31:47 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 03:31:47 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 03:31:47 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 03:31:47 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 03:31:47 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 03:31:47 INFO - Downloading docopt-0.6.1.tar.gz 03:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:48 INFO - Running setup.py install for blobuploader 03:31:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:48 INFO - Running setup.py install for requests 03:31:48 INFO - Running setup.py install for docopt 03:31:48 INFO - Successfully installed blobuploader requests docopt 03:31:48 INFO - Cleaning up... 03:31:48 INFO - Return code: 0 03:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:48 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')]} 03:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 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')]} 03:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 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 0x7fbc9eeb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', '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 03:31:48 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 03:31:48 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 03:31:48 INFO - Using env: {'DISPLAY': ':0', 03:31:48 INFO - 'HOME': '/home/cltbld', 03:31:48 INFO - 'LANG': 'en_US.UTF-8', 03:31:48 INFO - 'LANGUAGE': 'en_US:en', 03:31:48 INFO - 'LOGNAME': 'cltbld', 03:31:48 INFO - 'MAIL': '/var/mail/cltbld', 03:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:48 INFO - 'MOZ_NO_REMOTE': '1', 03:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:48 INFO - 'NO_EM_RESTART': '1', 03:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:48 INFO - 'PWD': '/builds/slave/test', 03:31:48 INFO - 'SHELL': '/bin/bash', 03:31:48 INFO - 'SHLVL': '1', 03:31:48 INFO - 'TERM': 'linux', 03:31:48 INFO - 'TMOUT': '86400', 03:31:48 INFO - 'USER': 'cltbld', 03:31:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', 03:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:48 INFO - '_': '/tools/buildbot/bin/python'} 03:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:48 INFO - Running setup.py (path:/tmp/pip-18yhrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:48 INFO - Running setup.py (path:/tmp/pip-Hjb6GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:49 INFO - Running setup.py (path:/tmp/pip-fNZzuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:49 INFO - Running setup.py (path:/tmp/pip-Y5SxHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:49 INFO - Running setup.py (path:/tmp/pip-sWfsl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:49 INFO - Running setup.py (path:/tmp/pip-V28o5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:49 INFO - Running setup.py (path:/tmp/pip-HZUE0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:49 INFO - Running setup.py (path:/tmp/pip-p4qDWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:49 INFO - Running setup.py (path:/tmp/pip-w48aNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:49 INFO - Running setup.py (path:/tmp/pip-k78UUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:49 INFO - Running setup.py (path:/tmp/pip-VGRDmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:49 INFO - Running setup.py (path:/tmp/pip-0xjwET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:49 INFO - Running setup.py (path:/tmp/pip-GhcfJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:49 INFO - Running setup.py (path:/tmp/pip-_fi_Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:49 INFO - Running setup.py (path:/tmp/pip-2OkwM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:49 INFO - Running setup.py (path:/tmp/pip-YaDkz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:50 INFO - Running setup.py (path:/tmp/pip-fi1cXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:50 INFO - Running setup.py install for manifestparser 03:31:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozcrash 03:31:50 INFO - Running setup.py install for mozdebug 03:31:50 INFO - Running setup.py install for mozdevice 03:31:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozfile 03:31:50 INFO - Running setup.py install for mozhttpd 03:31:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozinfo 03:31:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozInstall 03:31:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozleak 03:31:51 INFO - Running setup.py install for mozlog 03:31:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Running setup.py install for moznetwork 03:31:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Running setup.py install for mozprocess 03:31:51 INFO - Running setup.py install for mozprofile 03:31:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Running setup.py install for mozrunner 03:31:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Running setup.py install for mozscreenshot 03:31:51 INFO - Running setup.py install for moztest 03:31:51 INFO - Running setup.py install for mozversion 03:31:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:51 INFO - Cleaning up... 03:31:51 INFO - Return code: 0 03:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:51 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 0x7fbc9eeb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', '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 03:31:51 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 03:31:51 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 03:31:51 INFO - Using env: {'DISPLAY': ':0', 03:31:51 INFO - 'HOME': '/home/cltbld', 03:31:51 INFO - 'LANG': 'en_US.UTF-8', 03:31:51 INFO - 'LANGUAGE': 'en_US:en', 03:31:51 INFO - 'LOGNAME': 'cltbld', 03:31:51 INFO - 'MAIL': '/var/mail/cltbld', 03:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:51 INFO - 'MOZ_NO_REMOTE': '1', 03:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:51 INFO - 'NO_EM_RESTART': '1', 03:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:51 INFO - 'PWD': '/builds/slave/test', 03:31:51 INFO - 'SHELL': '/bin/bash', 03:31:51 INFO - 'SHLVL': '1', 03:31:51 INFO - 'TERM': 'linux', 03:31:51 INFO - 'TMOUT': '86400', 03:31:51 INFO - 'USER': 'cltbld', 03:31:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', 03:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:51 INFO - '_': '/tools/buildbot/bin/python'} 03:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:52 INFO - Running setup.py (path:/tmp/pip-yeFYZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:52 INFO - Running setup.py (path:/tmp/pip-GeLWH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:52 INFO - Running setup.py (path:/tmp/pip-CqYBzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:52 INFO - Running setup.py (path:/tmp/pip-aqJMaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:52 INFO - Running setup.py (path:/tmp/pip-MBaTIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:52 INFO - Running setup.py (path:/tmp/pip-CgmuGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:52 INFO - Running setup.py (path:/tmp/pip-gpJSRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:52 INFO - Running setup.py (path:/tmp/pip-Q3lw27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:52 INFO - Running setup.py (path:/tmp/pip-c6s4L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:52 INFO - Running setup.py (path:/tmp/pip-j_Xqpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:52 INFO - Running setup.py (path:/tmp/pip-6nk0LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:52 INFO - Running setup.py (path:/tmp/pip-LJspL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:52 INFO - Running setup.py (path:/tmp/pip-Q6Osit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:53 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)) 03:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:53 INFO - Running setup.py (path:/tmp/pip-EQ7EGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:53 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)) 03:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:53 INFO - Running setup.py (path:/tmp/pip-tVuPnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:53 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)) 03:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:53 INFO - Running setup.py (path:/tmp/pip-UXTuVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:53 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)) 03:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:53 INFO - Running setup.py (path:/tmp/pip-B2IEA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:53 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)) 03:31:53 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)) 03:31:53 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)) 03:31:53 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)) 03:31:53 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)) 03:31:53 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)) 03:31:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:55 INFO - Downloading blessings-1.6.tar.gz 03:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:55 INFO - Installing collected packages: blessings 03:31:55 INFO - Running setup.py install for blessings 03:31:55 INFO - Successfully installed blessings 03:31:55 INFO - Cleaning up... 03:31:55 INFO - Return code: 0 03:31:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:55 INFO - Reading from file tmpfile_stdout 03:31:55 INFO - Current package versions: 03:31:55 INFO - argparse == 1.2.1 03:31:55 INFO - blessings == 1.6 03:31:55 INFO - blobuploader == 1.2.4 03:31:55 INFO - docopt == 0.6.1 03:31:55 INFO - manifestparser == 1.1 03:31:55 INFO - mozInstall == 1.12 03:31:55 INFO - mozcrash == 0.17 03:31:55 INFO - mozdebug == 0.1 03:31:55 INFO - mozdevice == 0.48 03:31:55 INFO - mozfile == 1.2 03:31:55 INFO - mozhttpd == 0.7 03:31:55 INFO - mozinfo == 0.9 03:31:55 INFO - mozleak == 0.1 03:31:55 INFO - mozlog == 3.1 03:31:55 INFO - moznetwork == 0.27 03:31:55 INFO - mozprocess == 0.22 03:31:55 INFO - mozprofile == 0.28 03:31:55 INFO - mozrunner == 6.11 03:31:55 INFO - mozscreenshot == 0.1 03:31:55 INFO - mozsystemmonitor == 0.0 03:31:55 INFO - moztest == 0.7 03:31:55 INFO - mozversion == 1.4 03:31:55 INFO - psutil == 3.1.1 03:31:55 INFO - requests == 1.2.3 03:31:55 INFO - wsgiref == 0.1.2 03:31:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:55 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')]} 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 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')]} 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 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 0x7fbc9eeb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', '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 03:31:55 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 03:31:55 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 03:31:55 INFO - Using env: {'DISPLAY': ':0', 03:31:55 INFO - 'HOME': '/home/cltbld', 03:31:55 INFO - 'LANG': 'en_US.UTF-8', 03:31:55 INFO - 'LANGUAGE': 'en_US:en', 03:31:55 INFO - 'LOGNAME': 'cltbld', 03:31:55 INFO - 'MAIL': '/var/mail/cltbld', 03:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:55 INFO - 'MOZ_NO_REMOTE': '1', 03:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:55 INFO - 'NO_EM_RESTART': '1', 03:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:55 INFO - 'PWD': '/builds/slave/test', 03:31:55 INFO - 'SHELL': '/bin/bash', 03:31:55 INFO - 'SHLVL': '1', 03:31:55 INFO - 'TERM': 'linux', 03:31:55 INFO - 'TMOUT': '86400', 03:31:55 INFO - 'USER': 'cltbld', 03:31:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', 03:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:55 INFO - '_': '/tools/buildbot/bin/python'} 03:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:55 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)) 03:31:55 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)) 03:31:55 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)) 03:31:55 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)) 03:31:55 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)) 03:31:55 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)) 03:31:55 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)) 03:31:55 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)) 03:31:55 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)) 03:31:55 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)) 03:31:55 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)) 03:31:55 INFO - Cleaning up... 03:31:55 INFO - Return code: 0 03:31:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:55 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')]} 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 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')]} 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 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 0x7fbc9eeb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', '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 03:31:55 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 03:31:55 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 03:31:55 INFO - Using env: {'DISPLAY': ':0', 03:31:55 INFO - 'HOME': '/home/cltbld', 03:31:55 INFO - 'LANG': 'en_US.UTF-8', 03:31:55 INFO - 'LANGUAGE': 'en_US:en', 03:31:55 INFO - 'LOGNAME': 'cltbld', 03:31:55 INFO - 'MAIL': '/var/mail/cltbld', 03:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:55 INFO - 'MOZ_NO_REMOTE': '1', 03:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:55 INFO - 'NO_EM_RESTART': '1', 03:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:55 INFO - 'PWD': '/builds/slave/test', 03:31:55 INFO - 'SHELL': '/bin/bash', 03:31:55 INFO - 'SHLVL': '1', 03:31:55 INFO - 'TERM': 'linux', 03:31:55 INFO - 'TMOUT': '86400', 03:31:55 INFO - 'USER': 'cltbld', 03:31:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', 03:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:55 INFO - '_': '/tools/buildbot/bin/python'} 03:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:56 INFO - Downloading/unpacking jsonschema 03:31:56 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 03:31:56 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 03:31:56 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 03:31:56 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 03:31:56 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 03:31:56 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 03:31:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:57 INFO - Downloading/unpacking functools32 (from jsonschema) 03:31:57 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 03:31:57 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 03:31:57 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 03:31:57 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 03:31:57 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 03:31:57 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 03:31:58 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:58 INFO - warning: no files found matching '*.txt' 03:31:58 INFO - no previously-included directories found matching 'build' 03:31:58 INFO - no previously-included directories found matching 'dist' 03:31:58 INFO - no previously-included directories found matching '.git*' 03:31:58 INFO - Installing collected packages: jsonschema, functools32 03:31:58 INFO - Running setup.py install for functools32 03:31:58 INFO - warning: no files found matching '*.txt' 03:31:58 INFO - no previously-included directories found matching 'build' 03:31:58 INFO - no previously-included directories found matching 'dist' 03:31:58 INFO - no previously-included directories found matching '.git*' 03:31:58 INFO - Successfully installed jsonschema functools32 03:31:58 INFO - Cleaning up... 03:31:58 INFO - Return code: 0 03:31:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:58 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 0x7fbc9eeb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', '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 03:31:58 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 03:31:58 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 03:31:58 INFO - Using env: {'DISPLAY': ':0', 03:31:58 INFO - 'HOME': '/home/cltbld', 03:31:58 INFO - 'LANG': 'en_US.UTF-8', 03:31:58 INFO - 'LANGUAGE': 'en_US:en', 03:31:58 INFO - 'LOGNAME': 'cltbld', 03:31:58 INFO - 'MAIL': '/var/mail/cltbld', 03:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:58 INFO - 'MOZ_NO_REMOTE': '1', 03:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:58 INFO - 'NO_EM_RESTART': '1', 03:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:58 INFO - 'PWD': '/builds/slave/test', 03:31:58 INFO - 'SHELL': '/bin/bash', 03:31:58 INFO - 'SHLVL': '1', 03:31:58 INFO - 'TERM': 'linux', 03:31:58 INFO - 'TMOUT': '86400', 03:31:58 INFO - 'USER': 'cltbld', 03:31:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', 03:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:58 INFO - '_': '/tools/buildbot/bin/python'} 03:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:58 INFO - Downloading/unpacking flake8 03:31:58 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 03:31:58 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 03:31:58 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 03:31:58 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 03:31:58 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 03:31:58 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 03:32:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:32:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:32:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 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 03:32:00 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 03:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:32:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:01 INFO - no previously-included directories found matching 'docs/_build' 03:32:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:32:01 INFO - Running setup.py install for pep8 03:32:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:01 INFO - no previously-included directories found matching 'docs/_build' 03:32:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:32:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:32:01 INFO - Cleaning up... 03:32:01 INFO - Return code: 0 03:32:01 INFO - Running post-action listener: _resource_record_post_action 03:32:01 INFO - Running post-action listener: _start_resource_monitoring 03:32:01 INFO - Starting resource monitoring. 03:32:01 INFO - ##### 03:32:01 INFO - ##### Running install step. 03:32:01 INFO - ##### 03:32:01 INFO - Running pre-action listener: _resource_record_pre_action 03:32:01 INFO - Running main action method: install 03:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:01 INFO - Reading from file tmpfile_stdout 03:32:01 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:01 INFO - Reading from file tmpfile_stdout 03:32:01 INFO - Output received: 03:32:01 INFO - Usage: mozinstall [options] installer 03:32:01 INFO - Options: 03:32:01 INFO - -h, --help show this help message and exit 03:32:01 INFO - -d DEST, --destination=DEST 03:32:01 INFO - Directory to install application into. [default: 03:32:01 INFO - "/builds/slave/test"] 03:32:01 INFO - --app=APP Application being installed. [default: firefox] 03:32:01 INFO - mkdir: /builds/slave/test/build/application 03:32:01 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'] 03:32:01 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 03:32:17 INFO - Reading from file tmpfile_stdout 03:32:17 INFO - Output received: 03:32:17 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:17 INFO - Running post-action listener: _resource_record_post_action 03:32:17 INFO - ##### 03:32:17 INFO - ##### Running run-tests step. 03:32:17 INFO - ##### 03:32:17 INFO - Running pre-action listener: _resource_record_pre_action 03:32:17 INFO - Running main action method: run_tests 03:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:17 INFO - Python 2.7.3 03:32:17 INFO - Return code: 0 03:32:17 INFO - grabbing minidump binary from tooltool 03:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:17 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 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:17 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 03:32:17 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 03:32:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:17 INFO - Return code: 0 03:32:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:18 INFO - Return code: 0 03:32:18 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/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 03:32:18 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/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 03:32:18 INFO - Using env: {'DISPLAY': ':0', 03:32:18 INFO - 'HOME': '/home/cltbld', 03:32:18 INFO - 'LANG': 'en_US.UTF-8', 03:32:18 INFO - 'LANGUAGE': 'en_US:en', 03:32:18 INFO - 'LOGNAME': 'cltbld', 03:32:18 INFO - 'MAIL': '/var/mail/cltbld', 03:32:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:18 INFO - 'MOZ_NO_REMOTE': '1', 03:32:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:18 INFO - 'NO_EM_RESTART': '1', 03:32:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:18 INFO - 'PWD': '/builds/slave/test', 03:32:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:18 INFO - 'SHELL': '/bin/bash', 03:32:18 INFO - 'SHLVL': '1', 03:32:18 INFO - 'TERM': 'linux', 03:32:18 INFO - 'TMOUT': '86400', 03:32:18 INFO - 'USER': 'cltbld', 03:32:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476', 03:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:18 INFO - '_': '/tools/buildbot/bin/python'} 03:32:18 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/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 03:32:18 INFO - mozversion application_buildid: 20160423004022 03:32:18 INFO - mozversion application_changeset: 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 03:32:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:32:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:18 INFO - mozversion application_name: Firefox 03:32:18 INFO - mozversion application_remotingname: firefox-dev 03:32:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:18 INFO - mozversion application_vendor: Mozilla 03:32:18 INFO - mozversion application_version: 47.0a2 03:32:18 INFO - mozversion platform_buildid: 20160423004022 03:32:18 INFO - mozversion platform_changeset: 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 03:32:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:18 INFO - mozversion platform_version: 47.0a2 03:32:18 INFO - using testdate: 1461407538 03:32:18 INFO - actual date: 1461407538 03:32:18 INFO - starting webserver on 'localhost:60939' 03:32:18 INFO - SUITE-START | Running 2 tests 03:32:18 INFO - TEST-START | dromaeo_css 03:32:18 INFO - operating with platform_type : linux_ 03:32:18 INFO - Initialising browser for dromaeo_css test... 03:32:18 INFO - TEST-INFO | started process 23533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDgTnBS/profile http://localhost:60939/getInfo.html) 03:32:21 INFO - PROCESS | 23533 | 03:32:21 INFO - PROCESS | 23533 | (process:23610): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:32:22 INFO - PROCESS | 23533 | __metrics Screen width/height:1600/1200 03:32:22 INFO - PROCESS | 23533 | colorDepth:24 03:32:22 INFO - PROCESS | 23533 | Browser inner width/height: 1024/697 03:32:22 INFO - PROCESS | 23533 | __metrics 03:32:23 ERROR - PROCESS | 23533 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:32:24 INFO - TEST-INFO | 23533: exit 0 03:32:24 INFO - Browser initialized. 03:32:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:24 INFO - TEST-INFO | started process 23661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDgTnBS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:25 INFO - PROCESS | 23661 | 03:32:25 INFO - PROCESS | 23661 | (process:23729): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:32:35 INFO - PROCESS | 23661 | RSS: Main: 150999040 03:32:35 INFO - PROCESS | 23661 | 03:33:25 INFO - PROCESS | 23661 | 1461407605533 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] 03:35:33 INFO - PROCESS | 23661 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60939/tests/dromaeo/cssquery-ext.html) 03:35:34 INFO - PROCESS | 23661 | RSS: Main: 155373568 03:35:34 INFO - PROCESS | 23661 | 03:38:36 INFO - PROCESS | 23661 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-ext.html (next: http://localhost:60939/tests/dromaeo/cssquery-jquery.html) 03:38:37 INFO - PROCESS | 23661 | RSS: Main: 153657344 03:38:37 INFO - PROCESS | 23661 | 03:41:39 INFO - PROCESS | 23661 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60939/tests/dromaeo/cssquery-mootools.html) 03:41:39 INFO - PROCESS | 23661 | RSS: Main: 153276416 03:41:39 INFO - PROCESS | 23661 | 03:44:41 INFO - PROCESS | 23661 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60939/tests/dromaeo/cssquery-prototype.html) 03:44:41 INFO - PROCESS | 23661 | RSS: Main: 153112576 03:44:41 INFO - PROCESS | 23661 | 03:47:44 INFO - PROCESS | 23661 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60939/tests/dromaeo/cssquery-yui.html) 03:47:44 INFO - PROCESS | 23661 | RSS: Main: 153776128 03:47:44 INFO - PROCESS | 23661 | 03:50:46 INFO - PROCESS | 23661 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-yui.html (next: http://localhost:60939/tests/dromaeo/cssquery-dojo.html) 03:50:46 INFO - PROCESS | 23661 | RSS: Main: 155525120 03:50:46 INFO - PROCESS | 23661 | 03:50:47 INFO - PROCESS | 23661 | __start_tp_report 03:50:47 INFO - PROCESS | 23661 | _x_x_mozilla_page_load 03:50:47 INFO - PROCESS | 23661 | _x_x_mozilla_page_load_details 03:50:47 INFO - PROCESS | 23661 | |i|pagename|runs| 03:50:47 INFO - PROCESS | 23661 | |0;dojo.html;3286.4413049781533;3397.9320413591745;3398.4562470004803;3431.3137372525503;3445.310937812438;5516.338039435268;5542.695151766651;5571.052921003429;5585.944140558593;5589.66462012279;5558.360788509322;5574.916376254349;5604.243427137335;5611.466910643482;5630.352509461413;5042.773075211615;5120.948790512084;5126.077306084903;5161.251618515313;5177.58579313654;4928.1129396708575;5045.889904221065;5160.329157209558;5237.580993520509;5241.764120614563;5095.082885080684;5114.846554603349;5167.276581278624;5173.767180476869;5177.068127737025;5096.3884333879805;5132.384113906336;5132.794688212504;5133.589312854962;5151.922721159186;4887.3402090717655;4900.215965445512;5001.174806157016;5046.798128074873;5081.771320290559;5393.460653934614;5404.081306177959;5444.700541470217;5449.56403487724;5454.400015998237;6018.759249630053;6020.367861374581;6073.541190927502;6098.54260930432;6113.816585502397;5915.792947246826;5978.8505287367725;6042.637441753509;6055.364186760371;6067.059605761114;5552.139418390156;5594.356648985378;5601.019821531257;5601.187827764951;5606.551475881961;5963.970180149072;6043.758249669964;6047.213862197887;6054.51563874889;6055.303640081447;5887.76448942046;5965.3139888912465;5970.373110823301;5973.253343332083;5999.760009599654;5934.109883517421;5958.195643588147;5970.13433052205;5970.313413957364;5975.342712301644;5706.885862282731;5916.645001299849;5925.229720136354;5935.643861368331;5962.40375962409;5892.793752218652;5934.228550288435;5940.61386009908;5942.64344139353;5952.166696662471;4407.6914615976575;4446.288593824973;4465.977670111629;4467.597916187558;4474.038081812426;3996.040950171996;4029.8589549365634;4044.919101617951;4045.474088368552;4087.346024636044;5448.863778405493;5589.580781441408;5644.97177514118;5664.461876121762;5718.370979192286;6001.879962400728;6024.427679370453;6045.063015232646;6048.395160483917;6059.091136329585;5507.146392309119;5638.887222255532;5670.092785154356;5689.715514224272;5689.971550142305;5080.187170052848;5108.182690769459;5121.180611102206;5136.203888397305;5166.276721259027;6198.039303907902;6221.191245138193;6224.9377506224355;6225.221847269091;6237.4698150656795;5880.088586269135;6000.639961602318;6036.33600303975;6047.485963693135;6084.209052823105;6167.629942203482;6186.783462578788;6188.81433556994;6191.566590338633;6221.222347206599;5884.9705751470965;5892.616979896293;5893.974316760008;5911.793087241926;5930.318013428511;5735.8566035849435;5971.4327138921735;6024.638521688713;6036.034234522455;6080.726367313393;5846.824595262149;5853.385394533512;5855.648661080349;5878.382769809108;5890.322612899571;5837.737301821343;5880.970595146997;5886.470217680429;5888.528917686489;5890.823275301748;5623.409541998031;5743.339515955551;5782.739776710142;5810.4189581041555;5855.2973643163095;5790.681512516852;5819.883602328015;5852.209951656642;5859.970700146642;5864;5561.833145005657;5725.370209276893;5736.856578585569;5768.019436695688;5774.42255774436 03:50:47 INFO - PROCESS | 23661 | |1;ext.html;523.5157479331617;528.5982653183579;530.3979982719612;570.4580648384035;577.428345937522;38702.61297387025;38906.80546597267;38932.61067389325;39130.80434597823;39205.803970980174;40950.7952460238;41416.585834141646;41523.58476415235;41835.372469412985;41924.371134432935;8926.73219803407;9137.086291370842;9140.6800761973;9145.679901203459;9169.08309169081;8956.686515971942;9124.726258212264;9125.406848554856;9392.577334019985;9430.717078487656;9290.907090929106;9345;9390.014048524874;9400.57697403615;9437;9279.95360023199;9281.118293762082;9341.626334946593;9368.2973776967;9370.016148304398;9144.222741067017;9280.303977201736;9334.579943902541;9336.11306925841;9344.11230933067;44259;44790.32814507785;44806.77596612029;44845;44943.775281123715;2945.7937944343903;3516.244007538366;3703.2618529233305;3740.251949610089;3815.5802861685193;31438.842805786055;31519.527207091913;31593.84203078993;31943.84028079868;32334.838325808454;4182.414461975326;4255.829766809324;4271.081717430768;4329.220740266751;4362.411074504933;249567;249990;250725.99999999817;251142;251873;60559;61609.38390616126;61618.38381616216;61646.69176654178;61803.38196618066;65127.348726513075;70954.29045709477;72042.63978680073;72177.63911180515;72249.6387518059;15491.922540387452;15650.217489125498;15713.135777532118;15790.763138552931;15875;11488.368139752227;11572.826407603892;11587.478563464665;11601.593944211912;11607.825882611767;21917;22119.336419907428;22242.555148896932;22321.21875734374;22325;8282.17178282167;8338;8409.32725381968;8548.316134709208;8642.265407440438;1030.9742256443649;1085.7339951711724;1088.5210507376728;1129.8079326514512;1160.843286156358;30005.549916751264;30176;30387.696123038928;30534.236644084074;30682;1110.3615421132881;1129.6046383765615;1220.4142011834192;1228.2323547782637;1259.703969567151;15680;15840.60398490047;15874.730021598245;15892.76160857588;16120.919395403182;328505;525853;530635;534191;534981;55840;56276;56704.71647641818;56740.71629641826;56897;1445.530202684111;1445.645816774897;1466.7726502392147;1469.162577330911;1474.6387135151956;28352;31024.379512409174;31106.066817995496;31126;31868;48633.270500941806;49540.50459495359;49566.50433495619;49707.254391184884;50101.49898500968;316903;318810;321496;322205;323055;34439.827800861836;34649.48025779565;35122;35174.472382913766;35433.291334173686;45696;46163.538364615924;46417.53582464132;47433;47799;39448.40827387534;39455.013624658466;39729.40405893856;39833.80083099566;40546.59453405428;39073.413898790976;41850;43744.170619423276;46753.76623116999;47425;39941.2011759769;40167;40323.1935361297;42350;43288.78355608202;33442.327883605234;34802.129946751535;34943.301133977686;34994.82502587471;35533.64466355303;26903.730962690122;27354.316142096606;27481.17556473309;27686.169414916778;27814.721852782022 03:50:47 INFO - PROCESS | 23661 | |2;jquery.html;384.82328379229455;389.94150877368406;391.59078762692985;395.2707255114314;403.5157810627248;14657;17769.20038598263;17945.282188712452;18444.17001234946;18496.445106646806;17017.744733829004;17292.13539323035;17336.219870105844;17782.555436114104;17896;5540.529055030307;5566.666000040001;5805.73874175661;5815.796447124351;5838.4453476919625;5716.1711551824965;5793.391693872146;5825.8834823303505;5829.8251052468495;5830.329512106098;5524.613277070606;5744.109663002241;5755.712214389285;5760.654360738348;5770.336411312711;5689.4879460848515;5692.402297758758;5726.599138060316;5730.19777231188;5773.884522309551;5122;5126.846194614168;5129.1024070787835;5149.407818100892;5170.9741451292875;21435.464113397134;21628.134874604995;21800.781992180193;22061.448463788372;22179.66730499044;2593.4424098818654;2639.881205345764;2641.8414895106357;2645.4180080382284;2858.285428642839;13461.798073028913;13895.930520347334;13980.650483737887;14171.220582867938;14320.856791432056;1924.191839427444;1984.3154111831395;1995.4512509060125;2009.869358491708;2039.3983774786325;65300.67349663221;66200.3379966199;67618.3238167617;68173.65913170452;68227.3177268226;10028.147607453302;10084.949575252223;10208.948955255177;10226.64206752775;10261.640842570474;13151;13682.52111176104;14475.92762036183;14495.565133046026;14563.344649490798;7280.526765760209;7447.478676492594;7480.625968701544;7592;7593.810154746176;7209.326667630378;7214.74748383804;7236.819079522948;7277.563346199245;7296;6107.206063211754;6183.072539119078;6241.34465881085;6292.552712876064;6338.7464501420345;1930.749002629649;1965.83290420313;1981.94054178372;1985.9404217873487;1986.5629561496448;1003.518311210623;1015.8019186258608;1045.581767293089;1070.9303895246785;1130.6947124276398;16479.258433370527;16813.57966050834;17237.655246894992;17857.464276071478;17951.640967180585;1067.781104873499;1091.2034215023077;1108.661858133277;1109.046220250584;1131.0781712904122;10331.845022324671;10529.473526323807;10593.205509586813;10705.411202383788;10796.190285728602;400908;412674;420278;421127;422142;44075.559244407785;46805;50585.74707126514;67986.32013679898;69283.30716692768;1071.164491696478;1071.3571856885962;1080.4543705428866;1085.180688580117;1085.5874767588266;15880.205989700238;16078.35686572524;16137.515874523782;16286.67426651484;16421;32969.01092967215;33549.83225083859;33729.83135084309;33948.49077263794;34934;45437.31844022276;45857.312140317255;46327.30509042434;46336.53663463322;46428.30357544572;8488.405811593377;8498.065212826461;8508.74473765788;8610.741677749678;8645.91354086451;12200.633980980585;12244.326562039174;12321.568745093879;12348.197367171106;12930;10632.820271844408;10916.836247456453;10921.83617245726;11092.611758588411;11275.548978040786;10809.405482698527;10814.675559733221;10844.511996960313;10988.560457581607;11021.944890275818;11156.49795759209;11330.716732081764;11428.657140285804;11597.130215233723;11679.708007299885;8080.313173380328;8088;8245.340372770044;8257.669693212205;8282.50304981703;11316.717082073013;11433.371164586028;11457.713557161138;11498.482568284615;11537.07703383744 03:50:47 INFO - PROCESS | 23661 | |3;mootools.html;1582.0744864254411;1608.7506436502342;1819.9909000455004;1926.9614607707838;1954.8045195480445;7237.782866514;7993.760187194393;8101.675932962682;8304.709335173271;8307.252347288742;8106.91893081069;8125.674973001072;8197;8237.95881020594;8247.711330103448;2412.9034838606435;2418.7944024757917;2432.5499782540196;2436.196055301755;2446.645236440715;2422.382292515406;2444.8044156467527;2446.559619268531;2450.5098980203943;2455.9386015349583;2408.313630615275;2449.546833835746;2464.494778570389;2508.39798448372;2518.7733104020635;2480.4047028713157;2481.888315025828;2500.6874140732407;2512.8617926014063;2520.4581015081662;2455.533448644752;2455.680761501011;2468.790152837011;2469.4567195217023;2485.7389974052644;8274.048484424307;8343.165683431609;8349.874751878726;8363.874541881876;8377.539235342054;5252.553532949704;5380.542653874425;5412.242286079952;5419;5430.456954304577;3244.91887702807;3259.3807176636365;3324.900252992414;3356.1777364545596;3371.7134043606325;1043.4261156363968;1046.1369370269558;1068.4444089073716;1080.3193987787722;1085.6905781852213;10679.519421625968;10753.462326883702;10920.399378034204;10920.781584368347;10934.070603998669;4445.466544014739;4541.069080838421;4574.771261436981;4584.1977653910435;4659.044895796354;9110.407823491452;9111.362204645744;9143.77140571491;9176.724698259062;9209.35534512591;5222.843314700565;5252.369715634149;5264.657797243243;5278.419373868871;5291.259223708684;4632.907341853144;4763.904721905612;4782.856514304576;4792.137415265286;4936;3762.2663580602066;3801.068738159169;3878.45701601776;3889.844406223776;3900.258950799339;1202.0623913347604;1219.2806244315896;1223.2721530689225;1230.5200971621075;1231.741334319803;1268.5496648689766;1274.9681257968625;1336.3852627791325;1459.9343029563695;1475.3877140986585;7925;8096.068952070587;8134;8135.1051384347675;8139.511629302261;549.3794599759127;549.5878091431426;553.595875011236;568.5054003017401;575.9683217422998;6144.38556144382;6162.506999440034;6176.629402235881;6202.875942481125;6252;9938.652147174958;10311.22665800068;10330.431826249478;10475.790484190273;10499.947500262602;9986.700398988041;10154.87785406353;10228.6419975302;10249.590016399261;10253.384796912209;8023.759287221393;8029.518228906401;8122;8125.593720313961;8157.79605509867;7644.388448924184;7743.225677432211;7778.649960751893;7785.104712957856;7842.098158711821;9077.364584479023;9095.909040909772;9100.576426157979;9179.403338782959;9200.033996430278;9203.76990575241;9423.434593924387;9448.763780905258;9481.810363792823;9607.663731769355;6090.177825993434;6212.968935155295;6422.646754428364;7088.787336379917;7198.20819709821;7790.337821285254;7851.764447066369;7875.133735288999;7881.605919704107;7890.881636775338;6817.318268173143;6890.827729306808;6896.069030680794;6906.551074180162;7014.789556313319;7280.781576552712;7292.307230813064;7311.634418279171;7358.632068396666;7367.8158046049275;7338.046054012944;7580.62096895142;7835.216478352119;7864.016997875266;7873.448858579844;7040.366367026787;7043.190033146254;7049.753258635923;7053.541519801196;7064.823379415556;7031.7890463286185;7107.431405487445;7151.570905745672;7152;7156.033935418652 03:50:47 INFO - PROCESS | 23661 | |4;prototype.html;364.58619466905066;364.80118335507177;369.8631506342652;372.1904856936164;378.6232698465026;6371.904421433676;6389.424951754341;6439.774607888713;6443.742250309988;6450.483961283097;6295.590786598867;6323.146375239341;6327;6338.112664227012;6338.366163383659;4717.69334993226;4823.421189457253;4848.248521479177;4901.044296362211;4935.506449355072;4854.077725232212;4871.732054736988;4874.780634871421;4890.853274401774;4895.902081958358;4832.855014349575;4853.077915196119;4860.9756951215195;4861.975690121544;4866.6106711463;4845.030993801236;4849.2968519564465;4851.175300198975;4862.222044472903;4864.489228630996;4197.727147735387;4200.264953633102;4239.618434340893;4242.300020496646;4251.638610718092;5901.822945311647;6022.337542870281;6036.698165091728;6060.757569697207;6077.544184186204;5652.971735141339;5653.434656534314;5663.838913022821;5664.716764161817;5667.546596272288;6673.93326066738;6689.665516724144;6702.765403210864;6710.93289067108;6722.361375669304;4659.301104834268;4660.300954856764;4662.3705799716945;4670.743109128996;4674.462436819741;6999.475039372017;7056.506044576881;7072.257412971615;7083.362497375209;7090.893636595455;4682.601978831769;4774.618030557547;4777.665563410597;4778.331033655291;4788.186008378514;4842.297866809364;4880.145974454456;4882.218844984856;4888.193448081098;4905.141600219948;5607.355154157242;5615.298087739033;5621.325440947113;5628.352739434936;5644.633098848643;6760.594364338155;6779.118714567075;6789.456843452611;6791.864162716718;6802.6258555779905;1708.1715368046487;1732.9429048280538;1734.765806616116;1737.8175291594453;1737.965240695179;1116.447358557503;1139.3790384240442;1141.0260249767948;1145.3128123126223;1160.0081929949772;6483.578567393199;6485.935140648628;6498.122753428227;6544.345565443417;6546.116274303004;6946.583205007716;6974.37230649244;7013.158420989514;7024.5434046786795;7029.29707029293;6277.089821975788;6385.361463853577;6524.543281970216;6592.637404942679;6609.20689517261;3783.4135708965155;3798.1833905710405;3806.2958352704836;3821.7898015609408;3826.311263972512;7269.709211631582;7281.05346304977;7298.598577078205;7303.89044164338;7308.342249197598;7236.167840698282;7246.5289756165685;7259.128904531384;7272.56364618114;7287.6356182190675;7020.08666403447;7287.562746235243;7321.816954576178;7323.194448610649;7329.633518324063;7059.047028651272;7084.114485689289;7091.11361079865;7103.325184107502;7108.07595012645;6908.827279318058;6943.819550676296;6953;6954.895676564956;6972.58164510131;7284.890726639211;7290.97424568798;7317.085364329459;7317.304856038668;7324.597147156957;4648.140094082605;4811.903761924812;4820.831270905502;4827.975860120677;4835.95164048369;6958.408535274559;6961.651917404009;6993.370596646327;7010.298970102949;7023.473239506955;6754.797356079325;6782.694778735067;6793;6801.693923773343;6806.659667016728;6782.728690852508;6793.150856142982;6793.2867048961125;6797.762078327235;6798.422134118655;6574.8356291091195;6667.49993750461;6724.731010759515;6735;6745;6869.553479023847;6872.312768723088;6886.345797149263;6890.414314783299;6903.482238832007;6684.298148694317;6690.464762818866;6732;6732.192136943402;6736.360045795642 03:50:47 INFO - PROCESS | 23661 | |5;yui.html;792.3106896999609;846.3408933819323;888.8133491966687;918.3525614441817;935.7567032571529;13431.32843357832;13515.662108447294;13529.255890925995;13591.184528928272;13636.727265454698;12829.294388808612;12855.871441285584;12871.935640321784;12872.292023938702;12877.227366358025;772.4013889235831;901.3375169250595;920.7882187096972;921.9953900230489;923.4413180026105;934.4066517761237;935.3078721745893;935.7660584853786;943.5848226780195;943.8772959515253;971.6647756524023;972.0959507657875;972.7762614598611;975;976.8583555384465;966.709987003896;968.990310096897;971.0823272007955;973.090160699741;974.7319487141058;721.9530730502553;722.9674664640104;724.688383994882;724.916634587024;726.8182954261434;12936.417861196269;13060.151090179108;13064.412101455457;13089.607311780663;13110.934445327808;13851.792223116661;13904.721905561832;14029.579112626638;14096.718065638732;14110;10879.184061195441;10963.397013164273;11019.889801101966;11267.492962816694;11329.09367250618;3784.2242340320167;3811.123441608446;3815.7138214634015;3875.1087249932675;3899.78551179685;50604.240936385984;51843.74078129623;53289.2006619901;53563.46436535624;53838.461615383734;11008.339499629888;11021.393823339793;11080.168987325982;11133.10935125188;11163.609273675382;20368.592628147355;20457.693134602992;20650.58698826015;20688.17247310091;20744;7538.623068846646;7751.7674469766;7801.804954876174;7985.760427187193;8074.878876816852;4186.204621121977;4211.473565804275;4238.215930052888;4262.7016108872085;4281.357796330575;3408.9829550852087;3440.1915549845767;3450.6376830432946;3461.100113970386;3461.2212252243044;565.8019693107461;590.6721769418015;593.551868339401;598.294013064588;599.9310079340844;628.2712054017318;635.6374777427358;662.3773652766384;790.426940468156;790.6402586822982;9108.954455227682;9113.498757568264;9452.243820494481;9892.307538472238;10248.436336001443;640.7212862404868;680.0988689985788;740.2856243724831;780.4185881518305;791.912889582157;4123.113530590937;4198.28629133042;4215.810288537024;4271.423357846713;4297.205017071852;56227.43772562304;56965.43034569684;57007.42992570021;57684.134737978966;57763;49770;49957.50042499601;50146.749266253435;50629.240561391605;50637.74681126571;45691.54308456873;45839.54160458353;45907.081858362646;46245.30632040522;46256;9151.63393464254;9416.858747118935;9526.571304291461;9530.237580993642;9781.119699227103;33542.664573353955;33837.32325353529;34778.652213477544;34950.650493495756;35189.12027199341;41383.793081034404;41531.1693766129;44126.33810492781;44403.55596443994;45226;12013.279203247834;12075.27548347102;12293.631191064282;12390.504379824706;12474.875251247371;12982.415791289226;12997.935010324887;13093.672658183621;13230.272335021666;13351.065425420127;11296.774064518828;11328.263662861887;11336;11493.885061149282;11535.538578456768;12356.38218089074;12431.12982091281;12467.189632673848;12547.498100075894;12556.560520381743;12242.081843861568;12338.568150115061;12523.499060037497;12583.874161258636;12610.936945315214;10295.961437598282;10371.896281037092;10406.09771335749;10476.68569942903;11066.557337706401;9979.45113018791;10128.59485620567;10131.696049118538;10155.949220253851;10159.746006349606 03:50:47 INFO - PROCESS | 23661 | __end_tp_report 03:50:47 INFO - PROCESS | 23661 | __start_cc_report 03:50:47 INFO - PROCESS | 23661 | _x_x_mozilla_cycle_collect,334 03:50:47 INFO - PROCESS | 23661 | __end_cc_report 03:50:47 INFO - PROCESS | 23661 | __startTimestamp1461408646993__endTimestamp 03:50:47 INFO - PROCESS | 23661 | 03:50:47 INFO - PROCESS | 23661 | ------- Summary: start ------- 03:50:47 INFO - PROCESS | 23661 | Number of tests: 6 03:50:47 INFO - PROCESS | 23661 | 03:50:47 INFO - PROCESS | 23661 | [#0] dojo.html Cycles:165 Average:5550.99 Median:5768.02 stddev:623.59 (10.8%) stddev-sans-first:599.66 03:50:47 INFO - PROCESS | 23661 | Values: 3286.4 3397.9 3398.5 3431.3 3445.3 5516.3 5542.7 5571.1 5585.9 5589.7 5558.4 5574.9 5604.2 5611.5 5630.4 5042.8 5120.9 5126.1 5161.3 5177.6 4928.1 5045.9 5160.3 5237.6 5241.8 5095.1 5114.8 5167.3 5173.8 5177.1 5096.4 5132.4 5132.8 5133.6 5151.9 4887.3 4900.2 5001.2 5046.8 5081.8 5393.5 5404.1 5444.7 5449.6 5454.4 6018.8 6020.4 6073.5 6098.5 6113.8 5915.8 5978.9 6042.6 6055.4 6067.1 5552.1 5594.4 5601.0 5601.2 5606.6 5964.0 6043.8 6047.2 6054.5 6055.3 5887.8 5965.3 5970.4 5973.3 5999.8 5934.1 5958.2 5970.1 5970.3 5975.3 5706.9 5916.6 5925.2 5935.6 5962.4 5892.8 5934.2 5940.6 5942.6 5952.2 4407.7 4446.3 4466.0 4467.6 4474.0 3996.0 4029.9 4044.9 4045.5 4087.3 5448.9 5589.6 5645.0 5664.5 5718.4 6001.9 6024.4 6045.1 6048.4 6059.1 5507.1 5638.9 5670.1 5689.7 5690.0 5080.2 5108.2 5121.2 5136.2 5166.3 6198.0 6221.2 6224.9 6225.2 6237.5 5880.1 6000.6 6036.3 6047.5 6084.2 6167.6 6186.8 6188.8 6191.6 6221.2 5885.0 5892.6 5894.0 5911.8 5930.3 5735.9 5971.4 6024.6 6036.0 6080.7 5846.8 5853.4 5855.6 5878.4 5890.3 5837.7 5881.0 5886.5 5888.5 5890.8 5623.4 5743.3 5782.7 5810.4 5855.3 5790.7 5819.9 5852.2 5860.0 5864.0 5561.8 5725.4 5736.9 5768.0 5774.4 03:50:47 INFO - PROCESS | 23661 | 03:50:47 INFO - PROCESS | 23661 | [#1] ext.html Cycles:180 Average:53301.30 Median:39887.50 stddev:98244.99 (246.3%) stddev-sans-first:98440.68 03:50:47 INFO - PROCESS | 23661 | Values: 523.5 528.6 530.4 570.5 577.4 38702.6 38906.8 38932.6 39130.8 39205.8 40950.8 41416.6 41523.6 41835.4 41924.4 8926.7 9137.1 9140.7 9145.7 9169.1 8956.7 9124.7 9125.4 9392.6 9430.7 9290.9 9345.0 9390.0 9400.6 9437.0 9280.0 9281.1 9341.6 9368.3 9370.0 9144.2 9280.3 9334.6 9336.1 9344.1 44259.0 44790.3 44806.8 44845.0 44943.8 2945.8 3516.2 3703.3 3740.3 3815.6 31438.8 31519.5 31593.8 31943.8 32334.8 4182.4 4255.8 4271.1 4329.2 4362.4 249567.0 249990.0 250726.0 251142.0 251873.0 60559.0 61609.4 61618.4 61646.7 61803.4 65127.3 70954.3 72042.6 72177.6 72249.6 15491.9 15650.2 15713.1 15790.8 15875.0 11488.4 11572.8 11587.5 11601.6 11607.8 21917.0 22119.3 22242.6 22321.2 22325.0 8282.2 8338.0 8409.3 8548.3 8642.3 1031.0 1085.7 1088.5 1129.8 1160.8 30005.5 30176.0 30387.7 30534.2 30682.0 1110.4 1129.6 1220.4 1228.2 1259.7 15680.0 15840.6 15874.7 15892.8 16120.9 328505.0 525853.0 530635.0 534191.0 534981.0 55840.0 56276.0 56704.7 56740.7 56897.0 1445.5 1445.6 1466.8 1469.2 1474.6 28352.0 31024.4 31106.1 31126.0 31868.0 48633.3 49540.5 49566.5 49707.3 50101.5 316903.0 318810.0 321496.0 322205.0 323055.0 34439.8 34649.5 35122.0 35174.5 35433.3 45696.0 46163.5 46417.5 47433.0 47799.0 39448.4 39455.0 39729.4 39833.8 40546.6 39073.4 41850.0 43744.2 46753.8 47425.0 39941.2 40167.0 40323.2 42350.0 43288.8 33442.3 34802.1 34943.3 34994.8 35533.6 26903.7 27354.3 27481.2 27686.2 27814.7 03:50:47 INFO - PROCESS | 23661 | 03:50:47 INFO - PROCESS | 23661 | [#2] jquery.html Cycles:180 Average:24732.20 Median:21531.80 stddev:67887.82 (315.3%) stddev-sans-first:68053.65 03:50:47 INFO - PROCESS | 23661 | Values: 384.8 389.9 391.6 395.3 403.5 14657.0 17769.2 17945.3 18444.2 18496.4 17017.7 17292.1 17336.2 17782.6 17896.0 5540.5 5566.7 5805.7 5815.8 5838.4 5716.2 5793.4 5825.9 5829.8 5830.3 5524.6 5744.1 5755.7 5760.7 5770.3 5689.5 5692.4 5726.6 5730.2 5773.9 5122.0 5126.8 5129.1 5149.4 5171.0 21435.5 21628.1 21800.8 22061.4 22179.7 2593.4 2639.9 2641.8 2645.4 2858.3 13461.8 13895.9 13980.7 14171.2 14320.9 1924.2 1984.3 1995.5 2009.9 2039.4 65300.7 66200.3 67618.3 68173.7 68227.3 10028.1 10084.9 10208.9 10226.6 10261.6 13151.0 13682.5 14475.9 14495.6 14563.3 7280.5 7447.5 7480.6 7592.0 7593.8 7209.3 7214.7 7236.8 7277.6 7296.0 6107.2 6183.1 6241.3 6292.6 6338.7 1930.7 1965.8 1981.9 1985.9 1986.6 1003.5 1015.8 1045.6 1070.9 1130.7 16479.3 16813.6 17237.7 17857.5 17951.6 1067.8 1091.2 1108.7 1109.0 1131.1 10331.8 10529.5 10593.2 10705.4 10796.2 400908.0 412674.0 420278.0 421127.0 422142.0 44075.6 46805.0 50585.7 67986.3 69283.3 1071.2 1071.4 1080.5 1085.2 1085.6 15880.2 16078.4 16137.5 16286.7 16421.0 32969.0 33549.8 33729.8 33948.5 34934.0 45437.3 45857.3 46327.3 46336.5 46428.3 8488.4 8498.1 8508.7 8610.7 8645.9 12200.6 12244.3 12321.6 12348.2 12930.0 10632.8 10916.8 10921.8 11092.6 11275.5 10809.4 10814.7 10844.5 10988.6 11021.9 11156.5 11330.7 11428.7 11597.1 11679.7 8080.3 8088.0 8245.3 8257.7 8282.5 11316.7 11433.4 11457.7 11498.5 11537.1 03:50:47 INFO - PROCESS | 23661 | 03:50:47 INFO - PROCESS | 23661 | [#3] mootools.html Cycles:180 Average:5824.27 Median:561.05 stddev:3004.54 (535.5%) stddev-sans-first:2996.05 03:50:47 INFO - PROCESS | 23661 | Values: 1582.1 1608.8 1820.0 1927.0 1954.8 7237.8 7993.8 8101.7 8304.7 8307.3 8106.9 8125.7 8197.0 8238.0 8247.7 2412.9 2418.8 2432.5 2436.2 2446.6 2422.4 2444.8 2446.6 2450.5 2455.9 2408.3 2449.5 2464.5 2508.4 2518.8 2480.4 2481.9 2500.7 2512.9 2520.5 2455.5 2455.7 2468.8 2469.5 2485.7 8274.0 8343.2 8349.9 8363.9 8377.5 5252.6 5380.5 5412.2 5419.0 5430.5 3244.9 3259.4 3324.9 3356.2 3371.7 1043.4 1046.1 1068.4 1080.3 1085.7 10679.5 10753.5 10920.4 10920.8 10934.1 4445.5 4541.1 4574.8 4584.2 4659.0 9110.4 9111.4 9143.8 9176.7 9209.4 5222.8 5252.4 5264.7 5278.4 5291.3 4632.9 4763.9 4782.9 4792.1 4936.0 3762.3 3801.1 3878.5 3889.8 3900.3 1202.1 1219.3 1223.3 1230.5 1231.7 1268.5 1275.0 1336.4 1459.9 1475.4 7925.0 8096.1 8134.0 8135.1 8139.5 549.4 549.6 553.6 568.5 576.0 6144.4 6162.5 6176.6 6202.9 6252.0 9938.7 10311.2 10330.4 10475.8 10499.9 9986.7 10154.9 10228.6 10249.6 10253.4 8023.8 8029.5 8122.0 8125.6 8157.8 7644.4 7743.2 7778.6 7785.1 7842.1 9077.4 9095.9 9100.6 9179.4 9200.0 9203.8 9423.4 9448.8 9481.8 9607.7 6090.2 6213.0 6422.6 7088.8 7198.2 7790.3 7851.8 7875.1 7881.6 7890.9 6817.3 6890.8 6896.1 6906.6 7014.8 7280.8 7292.3 7311.6 7358.6 7367.8 7338.0 7580.6 7835.2 7864.0 7873.4 7040.4 7043.2 7049.8 7053.5 7064.8 7031.8 7107.4 7151.6 7152.0 7156.0 03:50:47 INFO - PROCESS | 23661 | 03:50:47 INFO - PROCESS | 23661 | [#4] prototype.html Cycles:180 Average:5677.53 Median:6447.11 stddev:1720.31 (26.7%) stddev-sans-first:1678.29 03:50:47 INFO - PROCESS | 23661 | Values: 364.6 364.8 369.9 372.2 378.6 6371.9 6389.4 6439.8 6443.7 6450.5 6295.6 6323.1 6327.0 6338.1 6338.4 4717.7 4823.4 4848.2 4901.0 4935.5 4854.1 4871.7 4874.8 4890.9 4895.9 4832.9 4853.1 4861.0 4862.0 4866.6 4845.0 4849.3 4851.2 4862.2 4864.5 4197.7 4200.3 4239.6 4242.3 4251.6 5901.8 6022.3 6036.7 6060.8 6077.5 5653.0 5653.4 5663.8 5664.7 5667.5 6673.9 6689.7 6702.8 6710.9 6722.4 4659.3 4660.3 4662.4 4670.7 4674.5 6999.5 7056.5 7072.3 7083.4 7090.9 4682.6 4774.6 4777.7 4778.3 4788.2 4842.3 4880.1 4882.2 4888.2 4905.1 5607.4 5615.3 5621.3 5628.4 5644.6 6760.6 6779.1 6789.5 6791.9 6802.6 1708.2 1732.9 1734.8 1737.8 1738.0 1116.4 1139.4 1141.0 1145.3 1160.0 6483.6 6485.9 6498.1 6544.3 6546.1 6946.6 6974.4 7013.2 7024.5 7029.3 6277.1 6385.4 6524.5 6592.6 6609.2 3783.4 3798.2 3806.3 3821.8 3826.3 7269.7 7281.1 7298.6 7303.9 7308.3 7236.2 7246.5 7259.1 7272.6 7287.6 7020.1 7287.6 7321.8 7323.2 7329.6 7059.0 7084.1 7091.1 7103.3 7108.1 6908.8 6943.8 6953.0 6954.9 6972.6 7284.9 7291.0 7317.1 7317.3 7324.6 4648.1 4811.9 4820.8 4828.0 4836.0 6958.4 6961.7 6993.4 7010.3 7023.5 6754.8 6782.7 6793.0 6801.7 6806.7 6782.7 6793.2 6793.3 6797.8 6798.4 6574.8 6667.5 6724.7 6735.0 6745.0 6869.6 6872.3 6886.3 6890.4 6903.5 6684.3 6690.5 6732.0 6732.2 6736.4 03:50:47 INFO - PROCESS | 23661 | 03:50:47 INFO - PROCESS | 23661 | [#5] yui.html Cycles:180 Average:14231.20 Median:4213.64 stddev:15963.40 (378.9%) stddev-sans-first:15976.28 03:50:47 INFO - PROCESS | 23661 | Values: 792.3 846.3 888.8 918.4 935.8 13431.3 13515.7 13529.3 13591.2 13636.7 12829.3 12855.9 12871.9 12872.3 12877.2 772.4 901.3 920.8 922.0 923.4 934.4 935.3 935.8 943.6 943.9 971.7 972.1 972.8 975.0 976.9 966.7 969.0 971.1 973.1 974.7 722.0 723.0 724.7 724.9 726.8 12936.4 13060.2 13064.4 13089.6 13110.9 13851.8 13904.7 14029.6 14096.7 14110.0 10879.2 10963.4 11019.9 11267.5 11329.1 3784.2 3811.1 3815.7 3875.1 3899.8 50604.2 51843.7 53289.2 53563.5 53838.5 11008.3 11021.4 11080.2 11133.1 11163.6 20368.6 20457.7 20650.6 20688.2 20744.0 7538.6 7751.8 7801.8 7985.8 8074.9 4186.2 4211.5 4238.2 4262.7 4281.4 3409.0 3440.2 3450.6 3461.1 3461.2 565.8 590.7 593.6 598.3 599.9 628.3 635.6 662.4 790.4 790.6 9109.0 9113.5 9452.2 9892.3 10248.4 640.7 680.1 740.3 780.4 791.9 4123.1 4198.3 4215.8 4271.4 4297.2 56227.4 56965.4 57007.4 57684.1 57763.0 49770.0 49957.5 50146.7 50629.2 50637.7 45691.5 45839.5 45907.1 46245.3 46256.0 9151.6 9416.9 9526.6 9530.2 9781.1 33542.7 33837.3 34778.7 34950.7 35189.1 41383.8 41531.2 44126.3 44403.6 45226.0 12013.3 12075.3 12293.6 12390.5 12474.9 12982.4 12997.9 13093.7 13230.3 13351.1 11296.8 11328.3 11336.0 11493.9 11535.5 12356.4 12431.1 12467.2 12547.5 12556.6 12242.1 12338.6 12523.5 12583.9 12610.9 10296.0 10371.9 10406.1 10476.7 11066.6 9979.5 10128.6 10131.7 10155.9 10159.7 03:50:47 INFO - PROCESS | 23661 | -------- Summary: end -------- 03:50:47 INFO - PROCESS | 23661 | 03:50:47 INFO - TEST-INFO | 23661: exit 0 03:50:47 INFO - TEST-OK | dromaeo_css | took 1109290ms 03:50:47 INFO - TEST-START | kraken 03:50:47 INFO - operating with platform_type : linux_ 03:50:47 INFO - Initialising browser for kraken test... 03:50:47 INFO - TEST-INFO | started process 23905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32Hgun/profile http://localhost:60939/getInfo.html) 03:50:51 INFO - PROCESS | 23905 | 03:50:51 INFO - PROCESS | 23905 | (process:23980): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:50:51 INFO - PROCESS | 23905 | __metrics Screen width/height:1600/1200 03:50:51 INFO - PROCESS | 23905 | colorDepth:24 03:50:51 INFO - PROCESS | 23905 | Browser inner width/height: 1024/697 03:50:51 INFO - PROCESS | 23905 | __metrics 03:50:52 ERROR - PROCESS | 23905 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:50:53 INFO - TEST-INFO | 23905: exit 0 03:50:53 INFO - Browser initialized. 03:50:53 INFO - Running cycle 1/1 for kraken test... 03:50:53 INFO - TEST-INFO | started process 24031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32Hgun/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:55 INFO - PROCESS | 24031 | 03:50:55 INFO - PROCESS | 24031 | (process:24099): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:51:05 INFO - PROCESS | 24031 | RSS: Main: 151785472 03:51:05 INFO - PROCESS | 24031 | 03:51:07 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60939/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:08 INFO - PROCESS | 24031 | RSS: Main: 155533312 03:51:08 INFO - PROCESS | 24031 | 03:51:10 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60939/tests/kraken/driver.html?testName=audio-dft) 03:51:11 INFO - PROCESS | 24031 | RSS: Main: 155688960 03:51:11 INFO - PROCESS | 24031 | 03:51:14 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60939/tests/kraken/driver.html?testName=audio-fft) 03:51:14 INFO - PROCESS | 24031 | RSS: Main: 156295168 03:51:14 INFO - PROCESS | 24031 | 03:51:17 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60939/tests/kraken/driver.html?testName=audio-oscillator) 03:51:17 INFO - PROCESS | 24031 | RSS: Main: 156372992 03:51:17 INFO - PROCESS | 24031 | 03:51:19 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:20 INFO - PROCESS | 24031 | RSS: Main: 156205056 03:51:20 INFO - PROCESS | 24031 | 03:51:23 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60939/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:24 INFO - PROCESS | 24031 | RSS: Main: 156585984 03:51:24 INFO - PROCESS | 24031 | 03:51:27 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60939/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:28 INFO - PROCESS | 24031 | RSS: Main: 156426240 03:51:28 INFO - PROCESS | 24031 | 03:51:30 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60939/tests/kraken/driver.html?testName=json-parse-financial) 03:51:31 INFO - PROCESS | 24031 | RSS: Main: 155840512 03:51:31 INFO - PROCESS | 24031 | 03:51:32 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:33 INFO - PROCESS | 24031 | RSS: Main: 156856320 03:51:33 INFO - PROCESS | 24031 | 03:51:35 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:35 INFO - PROCESS | 24031 | RSS: Main: 156323840 03:51:35 INFO - PROCESS | 24031 | 03:51:37 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:38 INFO - PROCESS | 24031 | RSS: Main: 155963392 03:51:38 INFO - PROCESS | 24031 | 03:51:40 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:41 INFO - PROCESS | 24031 | RSS: Main: 156213248 03:51:41 INFO - PROCESS | 24031 | 03:51:43 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:44 INFO - PROCESS | 24031 | RSS: Main: 157405184 03:51:44 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60939/tests/kraken/driver.html?testName=ai-astar) 03:51:46 INFO - PROCESS | 24031 | RSS: Main: 158310400 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | __start_tp_report 03:51:46 INFO - PROCESS | 24031 | _x_x_mozilla_page_load 03:51:46 INFO - PROCESS | 24031 | _x_x_mozilla_page_load_details 03:51:46 INFO - PROCESS | 24031 | |i|pagename|runs| 03:51:46 INFO - PROCESS | 24031 | |0;ai-astar;110;106;110;111;111;121;111;113;112;112 03:51:46 INFO - PROCESS | 24031 | |1;audio-beat-detection;161;126;150;167;128;156;161;129;176;128 03:51:46 INFO - PROCESS | 24031 | |2;audio-dft;164;165;162;164;163;164;163;163;166;164 03:51:46 INFO - PROCESS | 24031 | |3;audio-fft;74;76;73;178;76;74;73;75;164;77 03:51:46 INFO - PROCESS | 24031 | |4;audio-oscillator;92;93;150;92;93;92;139;92;93;145 03:51:46 INFO - PROCESS | 24031 | |5;imaging-gaussian-blur;118;118;117;118;118;117;117;117;117;117 03:51:46 INFO - PROCESS | 24031 | |6;imaging-darkroom;149;148;148;147;147;146;146;147;147;147 03:51:46 INFO - PROCESS | 24031 | |7;imaging-desaturate;96;96;96;97;97;97;95;95;95;97 03:51:46 INFO - PROCESS | 24031 | |8;json-parse-financial;56;57;58;56;60;57;59;63;55;56 03:51:46 INFO - PROCESS | 24031 | |9;json-stringify-tinderbox;66;64;64;64;64;64;63;64;64;64 03:51:46 INFO - PROCESS | 24031 | |10;stanford-crypto-aes;79;79;81;81;82;80;80;81;79;79 03:51:46 INFO - PROCESS | 24031 | |11;stanford-crypto-ccm;113;112;119;117;114;113;120;114;124;112 03:51:46 INFO - PROCESS | 24031 | |12;stanford-crypto-pbkdf2;127;140;144;134;141;136;124;127;137;125 03:51:46 INFO - PROCESS | 24031 | |13;stanford-crypto-sha256-iterative;69;69;67;69;65;66;68;64;71;67 03:51:46 INFO - PROCESS | 24031 | __end_tp_report 03:51:46 INFO - PROCESS | 24031 | __start_cc_report 03:51:46 INFO - PROCESS | 24031 | _x_x_mozilla_cycle_collect,831 03:51:46 INFO - PROCESS | 24031 | __end_cc_report 03:51:46 INFO - PROCESS | 24031 | __startTimestamp1461408706462__endTimestamp 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | ------- Summary: start ------- 03:51:46 INFO - PROCESS | 24031 | Number of tests: 14 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:3.77 (3.4%) stddev-sans-first:3.95 03:51:46 INFO - PROCESS | 24031 | Values: 110.0 106.0 110.0 111.0 111.0 121.0 111.0 113.0 112.0 112.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:158.50 stddev:18.84 (11.9%) stddev-sans-first:19.41 03:51:46 INFO - PROCESS | 24031 | Values: 161.0 126.0 150.0 167.0 128.0 156.0 161.0 129.0 176.0 128.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 03:51:46 INFO - PROCESS | 24031 | Values: 164.0 165.0 162.0 164.0 163.0 164.0 163.0 163.0 166.0 164.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#3] audio-fft Cycles:10 Average:94.00 Median:74.50 stddev:40.74 (54.7%) stddev-sans-first:42.56 03:51:46 INFO - PROCESS | 24031 | Values: 74.0 76.0 73.0 178.0 76.0 74.0 73.0 75.0 164.0 77.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:92.00 stddev:25.37 (27.6%) stddev-sans-first:26.23 03:51:46 INFO - PROCESS | 24031 | Values: 92.0 93.0 150.0 92.0 93.0 92.0 139.0 92.0 93.0 145.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:51:46 INFO - PROCESS | 24031 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 03:51:46 INFO - PROCESS | 24031 | Values: 149.0 148.0 148.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.50 stddev:0.88 (0.9%) stddev-sans-first:0.93 03:51:46 INFO - PROCESS | 24031 | Values: 96.0 96.0 96.0 97.0 97.0 97.0 95.0 95.0 95.0 97.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:2.41 (4.2%) stddev-sans-first:2.47 03:51:46 INFO - PROCESS | 24031 | Values: 56.0 57.0 58.0 56.0 60.0 57.0 59.0 63.0 55.0 56.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.33 03:51:46 INFO - PROCESS | 24031 | Values: 66.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 64.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.50 stddev:1.10 (1.4%) stddev-sans-first:1.09 03:51:46 INFO - PROCESS | 24031 | Values: 79.0 79.0 81.0 81.0 82.0 80.0 80.0 81.0 79.0 79.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:115.50 stddev:4.05 (3.5%) stddev-sans-first:4.17 03:51:46 INFO - PROCESS | 24031 | Values: 113.0 112.0 119.0 117.0 114.0 113.0 120.0 114.0 124.0 112.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.50 Median:136.50 stddev:7.26 (5.3%) stddev-sans-first:7.31 03:51:46 INFO - PROCESS | 24031 | Values: 127.0 140.0 144.0 134.0 141.0 136.0 124.0 127.0 137.0 125.0 03:51:46 INFO - PROCESS | 24031 | 03:51:46 INFO - PROCESS | 24031 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.50 stddev:2.12 (3.1%) stddev-sans-first:2.18 03:51:46 INFO - PROCESS | 24031 | Values: 69.0 69.0 67.0 69.0 65.0 66.0 68.0 64.0 71.0 67.0 03:51:46 INFO - PROCESS | 24031 | -------- Summary: end -------- 03:51:46 INFO - PROCESS | 24031 | 03:51:47 INFO - TEST-INFO | 24031: exit 0 03:51:47 INFO - TEST-OK | kraken | took 59933ms 03:51:47 INFO - SUITE-END | took 1169s 03:51:47 INFO - Completed test suite (00:19:29) 03:51:47 INFO - javascript benchmark 03:51:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3286.4413049781533, 3397.9320413591745, 3398.4562470004803, 3431.3137372525503, 3445.310937812438, 5516.338039435268, 5542.695151766651, 5571.052921003429, 5585.944140558593, 5589.66462012279, 5558.360788509322, 5574.916376254349, 5604.243427137335, 5611.466910643482, 5630.352509461413, 5042.773075211615, 5120.948790512084, 5126.077306084903, 5161.251618515313, 5177.58579313654, 4928.1129396708575, 5045.889904221065, 5160.329157209558, 5237.580993520509, 5241.764120614563, 5095.082885080684, 5114.846554603349, 5167.276581278624, 5173.767180476869, 5177.068127737025, 5096.3884333879805, 5132.384113906336, 5132.794688212504, 5133.589312854962, 5151.922721159186, 4887.3402090717655, 4900.215965445512, 5001.174806157016, 5046.798128074873, 5081.771320290559, 5393.460653934614, 5404.081306177959, 5444.700541470217, 5449.56403487724, 5454.400015998237, 6018.759249630053, 6020.367861374581, 6073.541190927502, 6098.54260930432, 6113.816585502397, 5915.792947246826, 5978.8505287367725, 6042.637441753509, 6055.364186760371, 6067.059605761114, 5552.139418390156, 5594.356648985378, 5601.019821531257, 5601.187827764951, 5606.551475881961, 5963.970180149072, 6043.758249669964, 6047.213862197887, 6054.51563874889, 6055.303640081447, 5887.76448942046, 5965.3139888912465, 5970.373110823301, 5973.253343332083, 5999.760009599654, 5934.109883517421, 5958.195643588147, 5970.13433052205, 5970.313413957364, 5975.342712301644, 5706.885862282731, 5916.645001299849, 5925.229720136354, 5935.643861368331, 5962.40375962409, 5892.793752218652, 5934.228550288435, 5940.61386009908, 5942.64344139353, 5952.166696662471, 4407.6914615976575, 4446.288593824973, 4465.977670111629, 4467.597916187558, 4474.038081812426, 3996.040950171996, 4029.8589549365634, 4044.919101617951, 4045.474088368552, 4087.346024636044, 5448.863778405493, 5589.580781441408, 5644.97177514118, 5664.461876121762, 5718.370979192286, 6001.879962400728, 6024.427679370453, 6045.063015232646, 6048.395160483917, 6059.091136329585, 5507.146392309119, 5638.887222255532, 5670.092785154356, 5689.715514224272, 5689.971550142305, 5080.187170052848, 5108.182690769459, 5121.180611102206, 5136.203888397305, 5166.276721259027, 6198.039303907902, 6221.191245138193, 6224.9377506224355, 6225.221847269091, 6237.4698150656795, 5880.088586269135, 6000.639961602318, 6036.33600303975, 6047.485963693135, 6084.209052823105, 6167.629942203482, 6186.783462578788, 6188.81433556994, 6191.566590338633, 6221.222347206599, 5884.9705751470965, 5892.616979896293, 5893.974316760008, 5911.793087241926, 5930.318013428511, 5735.8566035849435, 5971.4327138921735, 6024.638521688713, 6036.034234522455, 6080.726367313393, 5846.824595262149, 5853.385394533512, 5855.648661080349, 5878.382769809108, 5890.322612899571, 5837.737301821343, 5880.970595146997, 5886.470217680429, 5888.528917686489, 5890.823275301748, 5623.409541998031, 5743.339515955551, 5782.739776710142, 5810.4189581041555, 5855.2973643163095, 5790.681512516852, 5819.883602328015, 5852.209951656642, 5859.970700146642, 5864.0, 5561.833145005657, 5725.370209276893, 5736.856578585569, 5768.019436695688, 5774.42255774436], "unit": "score", "name": "dojo.html", "value": 5510.242869937191}, {"lowerIsBetter": false, "replicates": [523.5157479331617, 528.5982653183579, 530.3979982719612, 570.4580648384035, 577.428345937522, 38702.61297387025, 38906.80546597267, 38932.61067389325, 39130.80434597823, 39205.803970980174, 40950.7952460238, 41416.585834141646, 41523.58476415235, 41835.372469412985, 41924.371134432935, 8926.73219803407, 9137.086291370842, 9140.6800761973, 9145.679901203459, 9169.08309169081, 8956.686515971942, 9124.726258212264, 9125.406848554856, 9392.577334019985, 9430.717078487656, 9290.907090929106, 9345.0, 9390.014048524874, 9400.57697403615, 9437.0, 9279.95360023199, 9281.118293762082, 9341.626334946593, 9368.2973776967, 9370.016148304398, 9144.222741067017, 9280.303977201736, 9334.579943902541, 9336.11306925841, 9344.11230933067, 44259.0, 44790.32814507785, 44806.77596612029, 44845.0, 44943.775281123715, 2945.7937944343903, 3516.244007538366, 3703.2618529233305, 3740.251949610089, 3815.5802861685193, 31438.842805786055, 31519.527207091913, 31593.84203078993, 31943.84028079868, 32334.838325808454, 4182.414461975326, 4255.829766809324, 4271.081717430768, 4329.220740266751, 4362.411074504933, 249567.0, 249990.0, 250725.99999999817, 251142.0, 251873.0, 60559.0, 61609.38390616126, 61618.38381616216, 61646.69176654178, 61803.38196618066, 65127.348726513075, 70954.29045709477, 72042.63978680073, 72177.63911180515, 72249.6387518059, 15491.922540387452, 15650.217489125498, 15713.135777532118, 15790.763138552931, 15875.0, 11488.368139752227, 11572.826407603892, 11587.478563464665, 11601.593944211912, 11607.825882611767, 21917.0, 22119.336419907428, 22242.555148896932, 22321.21875734374, 22325.0, 8282.17178282167, 8338.0, 8409.32725381968, 8548.316134709208, 8642.265407440438, 1030.9742256443649, 1085.7339951711724, 1088.5210507376728, 1129.8079326514512, 1160.843286156358, 30005.549916751264, 30176.0, 30387.696123038928, 30534.236644084074, 30682.0, 1110.3615421132881, 1129.6046383765615, 1220.4142011834192, 1228.2323547782637, 1259.703969567151, 15680.0, 15840.60398490047, 15874.730021598245, 15892.76160857588, 16120.919395403182, 328505.0, 525853.0, 530635.0, 534191.0, 534981.0, 55840.0, 56276.0, 56704.71647641818, 56740.71629641826, 56897.0, 1445.530202684111, 1445.645816774897, 1466.7726502392147, 1469.162577330911, 1474.6387135151956, 28352.0, 31024.379512409174, 31106.066817995496, 31126.0, 31868.0, 48633.270500941806, 49540.50459495359, 49566.50433495619, 49707.254391184884, 50101.49898500968, 316903.0, 318810.0, 321496.0, 322205.0, 323055.0, 34439.827800861836, 34649.48025779565, 35122.0, 35174.472382913766, 35433.291334173686, 45696.0, 46163.538364615924, 46417.53582464132, 47433.0, 47799.0, 39448.40827387534, 39455.013624658466, 39729.40405893856, 39833.80083099566, 40546.59453405428, 39073.413898790976, 41850.0, 43744.170619423276, 46753.76623116999, 47425.0, 39941.2011759769, 40167.0, 40323.1935361297, 42350.0, 43288.78355608202, 33442.327883605234, 34802.129946751535, 34943.301133977686, 34994.82502587471, 35533.64466355303, 26903.730962690122, 27354.316142096606, 27481.17556473309, 27686.169414916778, 27814.721852782022], "unit": "score", "name": "ext.html", "value": 19985.367504529146}, {"lowerIsBetter": false, "replicates": [384.82328379229455, 389.94150877368406, 391.59078762692985, 395.2707255114314, 403.5157810627248, 14657.0, 17769.20038598263, 17945.282188712452, 18444.17001234946, 18496.445106646806, 17017.744733829004, 17292.13539323035, 17336.219870105844, 17782.555436114104, 17896.0, 5540.529055030307, 5566.666000040001, 5805.73874175661, 5815.796447124351, 5838.4453476919625, 5716.1711551824965, 5793.391693872146, 5825.8834823303505, 5829.8251052468495, 5830.329512106098, 5524.613277070606, 5744.109663002241, 5755.712214389285, 5760.654360738348, 5770.336411312711, 5689.4879460848515, 5692.402297758758, 5726.599138060316, 5730.19777231188, 5773.884522309551, 5122.0, 5126.846194614168, 5129.1024070787835, 5149.407818100892, 5170.9741451292875, 21435.464113397134, 21628.134874604995, 21800.781992180193, 22061.448463788372, 22179.66730499044, 2593.4424098818654, 2639.881205345764, 2641.8414895106357, 2645.4180080382284, 2858.285428642839, 13461.798073028913, 13895.930520347334, 13980.650483737887, 14171.220582867938, 14320.856791432056, 1924.191839427444, 1984.3154111831395, 1995.4512509060125, 2009.869358491708, 2039.3983774786325, 65300.67349663221, 66200.3379966199, 67618.3238167617, 68173.65913170452, 68227.3177268226, 10028.147607453302, 10084.949575252223, 10208.948955255177, 10226.64206752775, 10261.640842570474, 13151.0, 13682.52111176104, 14475.92762036183, 14495.565133046026, 14563.344649490798, 7280.526765760209, 7447.478676492594, 7480.625968701544, 7592.0, 7593.810154746176, 7209.326667630378, 7214.74748383804, 7236.819079522948, 7277.563346199245, 7296.0, 6107.206063211754, 6183.072539119078, 6241.34465881085, 6292.552712876064, 6338.7464501420345, 1930.749002629649, 1965.83290420313, 1981.94054178372, 1985.9404217873487, 1986.5629561496448, 1003.518311210623, 1015.8019186258608, 1045.581767293089, 1070.9303895246785, 1130.6947124276398, 16479.258433370527, 16813.57966050834, 17237.655246894992, 17857.464276071478, 17951.640967180585, 1067.781104873499, 1091.2034215023077, 1108.661858133277, 1109.046220250584, 1131.0781712904122, 10331.845022324671, 10529.473526323807, 10593.205509586813, 10705.411202383788, 10796.190285728602, 400908.0, 412674.0, 420278.0, 421127.0, 422142.0, 44075.559244407785, 46805.0, 50585.74707126514, 67986.32013679898, 69283.30716692768, 1071.164491696478, 1071.3571856885962, 1080.4543705428866, 1085.180688580117, 1085.5874767588266, 15880.205989700238, 16078.35686572524, 16137.515874523782, 16286.67426651484, 16421.0, 32969.01092967215, 33549.83225083859, 33729.83135084309, 33948.49077263794, 34934.0, 45437.31844022276, 45857.312140317255, 46327.30509042434, 46336.53663463322, 46428.30357544572, 8488.405811593377, 8498.065212826461, 8508.74473765788, 8610.741677749678, 8645.91354086451, 12200.633980980585, 12244.326562039174, 12321.568745093879, 12348.197367171106, 12930.0, 10632.820271844408, 10916.836247456453, 10921.83617245726, 11092.611758588411, 11275.548978040786, 10809.405482698527, 10814.675559733221, 10844.511996960313, 10988.560457581607, 11021.944890275818, 11156.49795759209, 11330.716732081764, 11428.657140285804, 11597.130215233723, 11679.708007299885, 8080.313173380328, 8088.0, 8245.340372770044, 8257.669693212205, 8282.50304981703, 11316.717082073013, 11433.371164586028, 11457.713557161138, 11498.482568284615, 11537.07703383744], "unit": "score", "name": "jquery.html", "value": 8856.456062875355}, {"lowerIsBetter": false, "replicates": [1582.0744864254411, 1608.7506436502342, 1819.9909000455004, 1926.9614607707838, 1954.8045195480445, 7237.782866514, 7993.760187194393, 8101.675932962682, 8304.709335173271, 8307.252347288742, 8106.91893081069, 8125.674973001072, 8197.0, 8237.95881020594, 8247.711330103448, 2412.9034838606435, 2418.7944024757917, 2432.5499782540196, 2436.196055301755, 2446.645236440715, 2422.382292515406, 2444.8044156467527, 2446.559619268531, 2450.5098980203943, 2455.9386015349583, 2408.313630615275, 2449.546833835746, 2464.494778570389, 2508.39798448372, 2518.7733104020635, 2480.4047028713157, 2481.888315025828, 2500.6874140732407, 2512.8617926014063, 2520.4581015081662, 2455.533448644752, 2455.680761501011, 2468.790152837011, 2469.4567195217023, 2485.7389974052644, 8274.048484424307, 8343.165683431609, 8349.874751878726, 8363.874541881876, 8377.539235342054, 5252.553532949704, 5380.542653874425, 5412.242286079952, 5419.0, 5430.456954304577, 3244.91887702807, 3259.3807176636365, 3324.900252992414, 3356.1777364545596, 3371.7134043606325, 1043.4261156363968, 1046.1369370269558, 1068.4444089073716, 1080.3193987787722, 1085.6905781852213, 10679.519421625968, 10753.462326883702, 10920.399378034204, 10920.781584368347, 10934.070603998669, 4445.466544014739, 4541.069080838421, 4574.771261436981, 4584.1977653910435, 4659.044895796354, 9110.407823491452, 9111.362204645744, 9143.77140571491, 9176.724698259062, 9209.35534512591, 5222.843314700565, 5252.369715634149, 5264.657797243243, 5278.419373868871, 5291.259223708684, 4632.907341853144, 4763.904721905612, 4782.856514304576, 4792.137415265286, 4936.0, 3762.2663580602066, 3801.068738159169, 3878.45701601776, 3889.844406223776, 3900.258950799339, 1202.0623913347604, 1219.2806244315896, 1223.2721530689225, 1230.5200971621075, 1231.741334319803, 1268.5496648689766, 1274.9681257968625, 1336.3852627791325, 1459.9343029563695, 1475.3877140986585, 7925.0, 8096.068952070587, 8134.0, 8135.1051384347675, 8139.511629302261, 549.3794599759127, 549.5878091431426, 553.595875011236, 568.5054003017401, 575.9683217422998, 6144.38556144382, 6162.506999440034, 6176.629402235881, 6202.875942481125, 6252.0, 9938.652147174958, 10311.22665800068, 10330.431826249478, 10475.790484190273, 10499.947500262602, 9986.700398988041, 10154.87785406353, 10228.6419975302, 10249.590016399261, 10253.384796912209, 8023.759287221393, 8029.518228906401, 8122.0, 8125.593720313961, 8157.79605509867, 7644.388448924184, 7743.225677432211, 7778.649960751893, 7785.104712957856, 7842.098158711821, 9077.364584479023, 9095.909040909772, 9100.576426157979, 9179.403338782959, 9200.033996430278, 9203.76990575241, 9423.434593924387, 9448.763780905258, 9481.810363792823, 9607.663731769355, 6090.177825993434, 6212.968935155295, 6422.646754428364, 7088.787336379917, 7198.20819709821, 7790.337821285254, 7851.764447066369, 7875.133735288999, 7881.605919704107, 7890.881636775338, 6817.318268173143, 6890.827729306808, 6896.069030680794, 6906.551074180162, 7014.789556313319, 7280.781576552712, 7292.307230813064, 7311.634418279171, 7358.632068396666, 7367.8158046049275, 7338.046054012944, 7580.62096895142, 7835.216478352119, 7864.016997875266, 7873.448858579844, 7040.366367026787, 7043.190033146254, 7049.753258635923, 7053.541519801196, 7064.823379415556, 7031.7890463286185, 7107.431405487445, 7151.570905745672, 7152.0, 7156.033935418652], "unit": "score", "name": "mootools.html", "value": 4729.0156868572185}, {"lowerIsBetter": false, "replicates": [364.58619466905066, 364.80118335507177, 369.8631506342652, 372.1904856936164, 378.6232698465026, 6371.904421433676, 6389.424951754341, 6439.774607888713, 6443.742250309988, 6450.483961283097, 6295.590786598867, 6323.146375239341, 6327.0, 6338.112664227012, 6338.366163383659, 4717.69334993226, 4823.421189457253, 4848.248521479177, 4901.044296362211, 4935.506449355072, 4854.077725232212, 4871.732054736988, 4874.780634871421, 4890.853274401774, 4895.902081958358, 4832.855014349575, 4853.077915196119, 4860.9756951215195, 4861.975690121544, 4866.6106711463, 4845.030993801236, 4849.2968519564465, 4851.175300198975, 4862.222044472903, 4864.489228630996, 4197.727147735387, 4200.264953633102, 4239.618434340893, 4242.300020496646, 4251.638610718092, 5901.822945311647, 6022.337542870281, 6036.698165091728, 6060.757569697207, 6077.544184186204, 5652.971735141339, 5653.434656534314, 5663.838913022821, 5664.716764161817, 5667.546596272288, 6673.93326066738, 6689.665516724144, 6702.765403210864, 6710.93289067108, 6722.361375669304, 4659.301104834268, 4660.300954856764, 4662.3705799716945, 4670.743109128996, 4674.462436819741, 6999.475039372017, 7056.506044576881, 7072.257412971615, 7083.362497375209, 7090.893636595455, 4682.601978831769, 4774.618030557547, 4777.665563410597, 4778.331033655291, 4788.186008378514, 4842.297866809364, 4880.145974454456, 4882.218844984856, 4888.193448081098, 4905.141600219948, 5607.355154157242, 5615.298087739033, 5621.325440947113, 5628.352739434936, 5644.633098848643, 6760.594364338155, 6779.118714567075, 6789.456843452611, 6791.864162716718, 6802.6258555779905, 1708.1715368046487, 1732.9429048280538, 1734.765806616116, 1737.8175291594453, 1737.965240695179, 1116.447358557503, 1139.3790384240442, 1141.0260249767948, 1145.3128123126223, 1160.0081929949772, 6483.578567393199, 6485.935140648628, 6498.122753428227, 6544.345565443417, 6546.116274303004, 6946.583205007716, 6974.37230649244, 7013.158420989514, 7024.5434046786795, 7029.29707029293, 6277.089821975788, 6385.361463853577, 6524.543281970216, 6592.637404942679, 6609.20689517261, 3783.4135708965155, 3798.1833905710405, 3806.2958352704836, 3821.7898015609408, 3826.311263972512, 7269.709211631582, 7281.05346304977, 7298.598577078205, 7303.89044164338, 7308.342249197598, 7236.167840698282, 7246.5289756165685, 7259.128904531384, 7272.56364618114, 7287.6356182190675, 7020.08666403447, 7287.562746235243, 7321.816954576178, 7323.194448610649, 7329.633518324063, 7059.047028651272, 7084.114485689289, 7091.11361079865, 7103.325184107502, 7108.07595012645, 6908.827279318058, 6943.819550676296, 6953.0, 6954.895676564956, 6972.58164510131, 7284.890726639211, 7290.97424568798, 7317.085364329459, 7317.304856038668, 7324.597147156957, 4648.140094082605, 4811.903761924812, 4820.831270905502, 4827.975860120677, 4835.95164048369, 6958.408535274559, 6961.651917404009, 6993.370596646327, 7010.298970102949, 7023.473239506955, 6754.797356079325, 6782.694778735067, 6793.0, 6801.693923773343, 6806.659667016728, 6782.728690852508, 6793.150856142982, 6793.2867048961125, 6797.762078327235, 6798.422134118655, 6574.8356291091195, 6667.49993750461, 6724.731010759515, 6735.0, 6745.0, 6869.553479023847, 6872.312768723088, 6886.345797149263, 6890.414314783299, 6903.482238832007, 6684.298148694317, 6690.464762818866, 6732.0, 6732.192136943402, 6736.360045795642], "unit": "score", "name": "prototype.html", "value": 5121.660895080378}, {"lowerIsBetter": false, "replicates": [792.3106896999609, 846.3408933819323, 888.8133491966687, 918.3525614441817, 935.7567032571529, 13431.32843357832, 13515.662108447294, 13529.255890925995, 13591.184528928272, 13636.727265454698, 12829.294388808612, 12855.871441285584, 12871.935640321784, 12872.292023938702, 12877.227366358025, 772.4013889235831, 901.3375169250595, 920.7882187096972, 921.9953900230489, 923.4413180026105, 934.4066517761237, 935.3078721745893, 935.7660584853786, 943.5848226780195, 943.8772959515253, 971.6647756524023, 972.0959507657875, 972.7762614598611, 975.0, 976.8583555384465, 966.709987003896, 968.990310096897, 971.0823272007955, 973.090160699741, 974.7319487141058, 721.9530730502553, 722.9674664640104, 724.688383994882, 724.916634587024, 726.8182954261434, 12936.417861196269, 13060.151090179108, 13064.412101455457, 13089.607311780663, 13110.934445327808, 13851.792223116661, 13904.721905561832, 14029.579112626638, 14096.718065638732, 14110.0, 10879.184061195441, 10963.397013164273, 11019.889801101966, 11267.492962816694, 11329.09367250618, 3784.2242340320167, 3811.123441608446, 3815.7138214634015, 3875.1087249932675, 3899.78551179685, 50604.240936385984, 51843.74078129623, 53289.2006619901, 53563.46436535624, 53838.461615383734, 11008.339499629888, 11021.393823339793, 11080.168987325982, 11133.10935125188, 11163.609273675382, 20368.592628147355, 20457.693134602992, 20650.58698826015, 20688.17247310091, 20744.0, 7538.623068846646, 7751.7674469766, 7801.804954876174, 7985.760427187193, 8074.878876816852, 4186.204621121977, 4211.473565804275, 4238.215930052888, 4262.7016108872085, 4281.357796330575, 3408.9829550852087, 3440.1915549845767, 3450.6376830432946, 3461.100113970386, 3461.2212252243044, 565.8019693107461, 590.6721769418015, 593.551868339401, 598.294013064588, 599.9310079340844, 628.2712054017318, 635.6374777427358, 662.3773652766384, 790.426940468156, 790.6402586822982, 9108.954455227682, 9113.498757568264, 9452.243820494481, 9892.307538472238, 10248.436336001443, 640.7212862404868, 680.0988689985788, 740.2856243724831, 780.4185881518305, 791.912889582157, 4123.113530590937, 4198.28629133042, 4215.810288537024, 4271.423357846713, 4297.205017071852, 56227.43772562304, 56965.43034569684, 57007.42992570021, 57684.134737978966, 57763.0, 49770.0, 49957.50042499601, 50146.749266253435, 50629.240561391605, 50637.74681126571, 45691.54308456873, 45839.54160458353, 45907.081858362646, 46245.30632040522, 46256.0, 9151.63393464254, 9416.858747118935, 9526.571304291461, 9530.237580993642, 9781.119699227103, 33542.664573353955, 33837.32325353529, 34778.652213477544, 34950.650493495756, 35189.12027199341, 41383.793081034404, 41531.1693766129, 44126.33810492781, 44403.55596443994, 45226.0, 12013.279203247834, 12075.27548347102, 12293.631191064282, 12390.504379824706, 12474.875251247371, 12982.415791289226, 12997.935010324887, 13093.672658183621, 13230.272335021666, 13351.065425420127, 11296.774064518828, 11328.263662861887, 11336.0, 11493.885061149282, 11535.538578456768, 12356.38218089074, 12431.12982091281, 12467.189632673848, 12547.498100075894, 12556.560520381743, 12242.081843861568, 12338.568150115061, 12523.499060037497, 12583.874161258636, 12610.936945315214, 10295.961437598282, 10371.896281037092, 10406.09771335749, 10476.68569942903, 11066.557337706401, 9979.45113018791, 10128.59485620567, 10131.696049118538, 10155.949220253851, 10159.746006349606], "unit": "score", "name": "yui.html", "value": 6730.072766900877}], "name": "dromaeo_css", "value": 7360.3220261756705}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 110.0, 111.0, 111.0, 121.0, 111.0, 113.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [161.0, 126.0, 150.0, 167.0, 128.0, 156.0, 161.0, 129.0, 176.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 162.0, 164.0, 163.0, 164.0, 163.0, 163.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 73.0, 178.0, 76.0, 74.0, 73.0, 75.0, 164.0, 77.0], "unit": "score", "name": "audio-fft", "value": 94.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 150.0, 92.0, 93.0, 92.0, 139.0, 92.0, 93.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 95.0, 95.0, 95.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 56.0, 60.0, 57.0, 59.0, 63.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [79.0, 79.0, 81.0, 81.0, 82.0, 80.0, 80.0, 81.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.1}, {"lowerIsBetter": true, "replicates": [113.0, 112.0, 119.0, 117.0, 114.0, 113.0, 120.0, 114.0, 124.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.8}, {"lowerIsBetter": true, "replicates": [127.0, 140.0, 144.0, 134.0, 141.0, 136.0, 124.0, 127.0, 137.0, 125.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.5}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 69.0, 65.0, 66.0, 68.0, 64.0, 71.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1505.1999999999998}]} 03:51:47 INFO - Return code: 0 03:51:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:51:47 ERROR - # TBPL SUCCESS # 03:51:47 INFO - Running post-action listener: _resource_record_post_action 03:51:47 INFO - Running post-run listener: _resource_record_post_run 03:51:48 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 500473856; Read time: 316; Write time: 421192 03:51:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 244695040; Read time: 228; Write time: 287556 03:51:48 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 255180800; Read time: 88; Write time: 133636 03:51:48 INFO - Running post-run listener: _upload_blobber_files 03:51:48 INFO - Blob upload gear active. 03:51:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:48 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 03:51:48 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'] 03:51:48 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 03:51:49 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:49 INFO - (blobuploader) - INFO - Done attempting. 03:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:50 INFO - (blobuploader) - INFO - Done attempting. 03:51:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:50 INFO - Return code: 0 03:51:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aada7304b20812d1cb563e7404acbd292d682ad14851565f865f26076209dd6de1974f60a9c4f1e84aad4e78369b5fb085fba0d953fc39d97a776be191cc2a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dbc68acf265427a1b973bb010c9b3b5ec20da93e9b8e321efd4a7592930e3bb2d8fe4dc3775e99c2be28e7d4c04ed1ff72f5a7983eca281b6c36e70199bcd36"} 03:51:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:50 INFO - Contents: 03:51:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aada7304b20812d1cb563e7404acbd292d682ad14851565f865f26076209dd6de1974f60a9c4f1e84aad4e78369b5fb085fba0d953fc39d97a776be191cc2a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dbc68acf265427a1b973bb010c9b3b5ec20da93e9b8e321efd4a7592930e3bb2d8fe4dc3775e99c2be28e7d4c04ed1ff72f5a7983eca281b6c36e70199bcd36"} 03:51:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:50 INFO - Copying logs to upload dir... 03:51:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.010163 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-23 03:51:49.874291) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 03:51:49.878448) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476 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/4aada7304b20812d1cb563e7404acbd292d682ad14851565f865f26076209dd6de1974f60a9c4f1e84aad4e78369b5fb085fba0d953fc39d97a776be191cc2a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dbc68acf265427a1b973bb010c9b3b5ec20da93e9b8e321efd4a7592930e3bb2d8fe4dc3775e99c2be28e7d4c04ed1ff72f5a7983eca281b6c36e70199bcd36"} build_url:https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/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/4aada7304b20812d1cb563e7404acbd292d682ad14851565f865f26076209dd6de1974f60a9c4f1e84aad4e78369b5fb085fba0d953fc39d97a776be191cc2a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dbc68acf265427a1b973bb010c9b3b5ec20da93e9b8e321efd4a7592930e3bb2d8fe4dc3775e99c2be28e7d4c04ed1ff72f5a7983eca281b6c36e70199bcd36"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 03:51:49.907070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:51:49.907400) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461406879.16081-1002006476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:51:49.991566) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 03:51:49.991902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 03:51:49.992189) ========= ========= Total master_lag: 0.18 =========