builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1463546060.8 results: success (0) buildid: 20160517191151 builduid: a9f4d94576764abebe8a43ec4301b587 revision: b4e6080db0238862dfb893ea6ab564fcd4375da1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:20.804674) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:20.805218) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:20.805578) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:20.820574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:20.821199) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 21:34:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-17 21:34:20 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091188 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:20.925811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:20.926185) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020782 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:20.979589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:20.980138) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b4e6080db0238862dfb893ea6ab564fcd4375da1 --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 b4e6080db0238862dfb893ea6ab564fcd4375da1 --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=82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 21:34:21,088 truncating revision to first 12 chars 2016-05-17 21:34:21,088 Setting DEBUG logging. 2016-05-17 21:34:21,088 attempt 1/10 2016-05-17 21:34:21,088 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b4e6080db023?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 21:34:21,361 unpacking tar archive at: mozilla-aurora-b4e6080db023/testing/mozharness/ program finished with exit code 0 elapsedTime=0.864403 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:21.857945) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:21.858318) ========= script_repo_revision: b4e6080db0238862dfb893ea6ab564fcd4375da1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:21.858794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:21.859111) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 21:34:21.869133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-17 21:34:21.869472) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:34:22 INFO - MultiFileLogger online at 20160517 21:34:22 in /builds/slave/test 21:34:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:34:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:34:22 INFO - {'append_to_log': False, 21:34:22 INFO - 'base_work_dir': '/builds/slave/test', 21:34:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:34:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:34:22 INFO - 'branch': 'Mozilla-Aurora', 21:34:22 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:22 INFO - 'config_files': ('talos/linux_config.py',), 21:34:22 INFO - 'default_actions': ('clobber', 21:34:22 INFO - 'read-buildbot-config', 21:34:22 INFO - 'download-and-extract', 21:34:22 INFO - 'populate-webroot', 21:34:22 INFO - 'create-virtualenv', 21:34:22 INFO - 'install', 21:34:22 INFO - 'run-tests'), 21:34:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:22 INFO - 'download_minidump_stackwalk': True, 21:34:22 INFO - 'download_symbols': 'ondemand', 21:34:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:34:22 INFO - 'tooltool.py': '/tools/tooltool.py', 21:34:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:34:22 INFO - '/tools/misc-python/virtualenv.py')}, 21:34:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:22 INFO - 'installer_path': 'installer.exe', 21:34:22 INFO - 'log_level': 'info', 21:34:22 INFO - 'log_name': 'talos', 21:34:22 INFO - 'log_to_console': True, 21:34:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:34:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:34:22 INFO - 'opt_config_files': (), 21:34:22 INFO - 'pip_index': False, 21:34:22 INFO - 'sps_profile': False, 21:34:22 INFO - 'sps_profile_interval': 0, 21:34:22 INFO - 'suite': 'dromaeojs', 21:34:22 INFO - 'system_bits': '32', 21:34:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:22 INFO - 'title': 'talos-linux64-ix-066', 21:34:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:22 INFO - 'use_talos_json': True, 21:34:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:34:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:22 INFO - 'work_dir': 'build'} 21:34:22 INFO - ##### 21:34:22 INFO - ##### Running clobber step. 21:34:22 INFO - ##### 21:34:22 INFO - Running pre-action listener: _resource_record_pre_action 21:34:22 INFO - Running main action method: clobber 21:34:22 INFO - rmtree: /builds/slave/test/build 21:34:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:34:22 INFO - Running post-action listener: _resource_record_post_action 21:34:22 INFO - ##### 21:34:22 INFO - ##### Running read-buildbot-config step. 21:34:22 INFO - ##### 21:34:22 INFO - Running pre-action listener: _resource_record_pre_action 21:34:22 INFO - Running main action method: read_buildbot_config 21:34:22 INFO - Using buildbot properties: 21:34:22 INFO - { 21:34:22 INFO - "project": "", 21:34:22 INFO - "product": "firefox", 21:34:22 INFO - "script_repo_revision": "production", 21:34:22 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:34:22 INFO - "repository": "", 21:34:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:34:22 INFO - "buildid": "20160517191151", 21:34:22 INFO - "pgo_build": "True", 21:34:22 INFO - "basedir": "/builds/slave/test", 21:34:22 INFO - "buildnumber": 237, 21:34:22 INFO - "slavename": "talos-linux64-ix-066", 21:34:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:34:22 INFO - "platform": "ubuntu64_hw", 21:34:22 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:34:22 INFO - "branch": "mozilla-aurora", 21:34:22 INFO - "repo_path": "releases/mozilla-aurora", 21:34:22 INFO - "revision": "b4e6080db0238862dfb893ea6ab564fcd4375da1", 21:34:22 INFO - "stage_platform": "linux64-pgo", 21:34:22 INFO - "builduid": "a9f4d94576764abebe8a43ec4301b587", 21:34:22 INFO - "slavebuilddir": "test" 21:34:22 INFO - } 21:34:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 21:34:22 INFO - Running post-action listener: _resource_record_post_action 21:34:22 INFO - ##### 21:34:22 INFO - ##### Running download-and-extract step. 21:34:22 INFO - ##### 21:34:22 INFO - Running pre-action listener: _resource_record_pre_action 21:34:22 INFO - Running main action method: download_and_extract 21:34:22 INFO - mkdir: /builds/slave/test/build/tests 21:34: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')]} 21:34:22 INFO - https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:34:23 INFO - Downloaded 1361 bytes. 21:34:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:34:23 INFO - Using the following test package requirements: 21:34:23 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:34:23 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:34:23 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:34:23 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:23 INFO - u'jsshell-linux-x86_64.zip'], 21:34:23 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:34:23 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:34:23 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:34:23 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:34:23 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:34:23 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:34:23 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:23 INFO - https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:34:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:34:25 INFO - Downloaded 23812452 bytes. 21:34:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:34:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:34:27 INFO - Return code: 0 21:34:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:27 INFO - https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:34:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:34:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:34:28 INFO - Downloaded 23812452 bytes. 21:34:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:34:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:34:29 INFO - Return code: 0 21:34:29 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')]} 21:34:29 INFO - https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:34:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:34:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:34:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:34:30 INFO - Downloaded 10840145 bytes. 21:34:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:34:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:34:30 INFO - Return code: 0 21:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:30 INFO - https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:34:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:34:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:34:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:34:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:34:35 INFO - Downloaded 62698292 bytes. 21:34:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:34:35 INFO - mkdir: /builds/slave/test/properties 21:34:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:34:35 INFO - Writing to file /builds/slave/test/properties/build_url 21:34:35 INFO - Contents: 21:34:35 INFO - build_url:https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:34:35 INFO - Running post-action listener: _resource_record_post_action 21:34:35 INFO - Running post-action listener: set_extra_try_arguments 21:34:35 INFO - ##### 21:34:35 INFO - ##### Running populate-webroot step. 21:34:35 INFO - ##### 21:34:35 INFO - Running pre-action listener: _resource_record_pre_action 21:34:35 INFO - Running main action method: populate_webroot 21:34:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:34:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:34:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:34:35 INFO - '--tppagecycles', 21:34:35 INFO - '7'], 21:34:35 INFO - 'tests': ['tsvgm']}}, 21:34:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:34:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:34:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:34:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:34:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:34:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:34:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:35 INFO - 'talos_options': ['--disable-e10s'], 21:34:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:35 INFO - 'talos_options': ['--disable-e10s'], 21:34:35 INFO - 'tests': ['damp', 'tps']}, 21:34:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:35 INFO - 'tests': ['damp', 'tps']}, 21:34:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:34:35 INFO - 'tests': ['dromaeo_dom']}, 21:34:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:34:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:34:35 INFO - 'tests': ['a11yr', 21:34:35 INFO - 'ts_paint', 21:34:35 INFO - 'tpaint', 21:34:35 INFO - 'sessionrestore', 21:34:35 INFO - 'sessionrestore_no_auto_restore', 21:34:35 INFO - 'tabpaint']}, 21:34:35 INFO - 'other-e10s': {'tests': ['a11yr', 21:34:35 INFO - 'ts_paint', 21:34:35 INFO - 'tpaint', 21:34:35 INFO - 'sessionrestore', 21:34:35 INFO - 'sessionrestore_no_auto_restore', 21:34:35 INFO - 'tabpaint']}, 21:34:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:34:35 INFO - 'ts_paint', 21:34:35 INFO - 'tpaint', 21:34:35 INFO - 'sessionrestore', 21:34:35 INFO - 'sessionrestore_no_auto_restore', 21:34:35 INFO - 'tabpaint']}, 21:34:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:34:35 INFO - 'ts_paint', 21:34:35 INFO - 'tpaint', 21:34:35 INFO - 'sessionrestore', 21:34:35 INFO - 'sessionrestore_no_auto_restore', 21:34:35 INFO - 'tabpaint']}, 21:34:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:34:35 INFO - 'tests': ['a11yr', 21:34:35 INFO - 'ts_paint', 21:34:35 INFO - 'tpaint', 21:34:35 INFO - 'sessionrestore', 21:34:35 INFO - 'sessionrestore_no_auto_restore', 21:34:35 INFO - 'tabpaint']}, 21:34:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:34:35 INFO - 'tests': ['a11yr', 21:34:35 INFO - 'ts_paint', 21:34:35 INFO - 'tpaint', 21:34:35 INFO - 'sessionrestore', 21:34:35 INFO - 'sessionrestore_no_auto_restore', 21:34:35 INFO - 'tabpaint']}, 21:34:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:34:35 INFO - 'tests': ['tsvgx', 21:34:35 INFO - 'tsvgr_opacity', 21:34:35 INFO - 'tart', 21:34:35 INFO - 'tscrollx', 21:34:35 INFO - 'cart']}, 21:34:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:34:35 INFO - 'tsvgr_opacity', 21:34:35 INFO - 'tart', 21:34:35 INFO - 'tscrollx', 21:34:35 INFO - 'cart']}, 21:34:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:35 INFO - 'talos_options': ['--disable-e10s'], 21:34:35 INFO - 'tests': ['tp5o']}, 21:34:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:35 INFO - 'tests': ['tp5o']}, 21:34:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:35 INFO - 'talos_options': ['--disable-e10s', 21:34:35 INFO - '--xperf_path', 21:34:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:35 INFO - 'tests': ['tp5n']}, 21:34:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:35 INFO - 'talos_options': ['--xperf_path', 21:34:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:35 INFO - 'tests': ['tp5n']}}, 21:34:35 INFO - 'talos.zip': {'path': '', 21:34:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:34:35 INFO - Running post-action listener: _resource_record_post_action 21:34:35 INFO - ##### 21:34:35 INFO - ##### Running create-virtualenv step. 21:34:35 INFO - ##### 21:34:35 INFO - Running pre-action listener: _resource_record_pre_action 21:34:35 INFO - Running main action method: create_virtualenv 21:34:35 INFO - Creating virtualenv /builds/slave/test/build/venv 21:34:35 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 21:34:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:34:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:34:35 INFO - Using real prefix '/usr' 21:34:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:34:36 INFO - Installing distribute.............................................................................................................................................................................................done. 21:34:38 INFO - Installing pip.................done. 21:34:38 INFO - Return code: 0 21:34:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ee132f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b4640>, '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 0x20b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b59d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', '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 21:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:34:38 INFO - Using env: {'DISPLAY': ':0', 21:34:38 INFO - 'HOME': '/home/cltbld', 21:34:38 INFO - 'LANG': 'en_US.UTF-8', 21:34:38 INFO - 'LANGUAGE': 'en_US:en', 21:34:38 INFO - 'LOGNAME': 'cltbld', 21:34:38 INFO - 'MAIL': '/var/mail/cltbld', 21:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:38 INFO - 'MOZ_NO_REMOTE': '1', 21:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:38 INFO - 'NO_EM_RESTART': '1', 21:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:38 INFO - 'PWD': '/builds/slave/test', 21:34:38 INFO - 'SHELL': '/bin/bash', 21:34:38 INFO - 'SHLVL': '1', 21:34:38 INFO - 'TERM': 'linux', 21:34:38 INFO - 'TMOUT': '86400', 21:34:38 INFO - 'USER': 'cltbld', 21:34:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', 21:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:38 INFO - '_': '/tools/buildbot/bin/python'} 21:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:38 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 21:34:38 INFO - Cleaning up... 21:34:38 INFO - Return code: 0 21:34:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1ee132f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b4640>, '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 0x20b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b59d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', '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 21:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:34:38 INFO - Using env: {'DISPLAY': ':0', 21:34:38 INFO - 'HOME': '/home/cltbld', 21:34:38 INFO - 'LANG': 'en_US.UTF-8', 21:34:38 INFO - 'LANGUAGE': 'en_US:en', 21:34:38 INFO - 'LOGNAME': 'cltbld', 21:34:38 INFO - 'MAIL': '/var/mail/cltbld', 21:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:38 INFO - 'MOZ_NO_REMOTE': '1', 21:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:38 INFO - 'NO_EM_RESTART': '1', 21:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:38 INFO - 'PWD': '/builds/slave/test', 21:34:38 INFO - 'SHELL': '/bin/bash', 21:34:38 INFO - 'SHLVL': '1', 21:34:38 INFO - 'TERM': 'linux', 21:34:38 INFO - 'TMOUT': '86400', 21:34:38 INFO - 'USER': 'cltbld', 21:34:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', 21:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:38 INFO - '_': '/tools/buildbot/bin/python'} 21:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:38 INFO - Downloading/unpacking psutil>=0.7.1 21:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:34:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:40 INFO - Installing collected packages: psutil 21:34:40 INFO - Running setup.py install for psutil 21:34:40 INFO - building 'psutil._psutil_linux' extension 21:34:40 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 21:34:41 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 21:34:41 INFO - building 'psutil._psutil_posix' extension 21:34:41 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 21:34:41 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 21:34:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:41 INFO - Successfully installed psutil 21:34:41 INFO - Cleaning up... 21:34:41 INFO - Return code: 0 21:34:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1ee132f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b4640>, '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 0x20b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b59d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', '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 21:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:34:41 INFO - Using env: {'DISPLAY': ':0', 21:34:41 INFO - 'HOME': '/home/cltbld', 21:34:41 INFO - 'LANG': 'en_US.UTF-8', 21:34:41 INFO - 'LANGUAGE': 'en_US:en', 21:34:41 INFO - 'LOGNAME': 'cltbld', 21:34:41 INFO - 'MAIL': '/var/mail/cltbld', 21:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:41 INFO - 'MOZ_NO_REMOTE': '1', 21:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:41 INFO - 'NO_EM_RESTART': '1', 21:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:41 INFO - 'PWD': '/builds/slave/test', 21:34:41 INFO - 'SHELL': '/bin/bash', 21:34:41 INFO - 'SHLVL': '1', 21:34:41 INFO - 'TERM': 'linux', 21:34:41 INFO - 'TMOUT': '86400', 21:34:41 INFO - 'USER': 'cltbld', 21:34:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', 21:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:41 INFO - '_': '/tools/buildbot/bin/python'} 21:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:34:43 INFO - Installing collected packages: mozsystemmonitor 21:34:43 INFO - Running setup.py install for mozsystemmonitor 21:34:43 INFO - Successfully installed mozsystemmonitor 21:34:43 INFO - Cleaning up... 21:34:43 INFO - Return code: 0 21:34:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1ee132f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b4640>, '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 0x20b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b59d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', '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 21:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:34:43 INFO - Using env: {'DISPLAY': ':0', 21:34:43 INFO - 'HOME': '/home/cltbld', 21:34:43 INFO - 'LANG': 'en_US.UTF-8', 21:34:43 INFO - 'LANGUAGE': 'en_US:en', 21:34:43 INFO - 'LOGNAME': 'cltbld', 21:34:43 INFO - 'MAIL': '/var/mail/cltbld', 21:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:43 INFO - 'MOZ_NO_REMOTE': '1', 21:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:43 INFO - 'NO_EM_RESTART': '1', 21:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:43 INFO - 'PWD': '/builds/slave/test', 21:34:43 INFO - 'SHELL': '/bin/bash', 21:34:43 INFO - 'SHLVL': '1', 21:34:43 INFO - 'TERM': 'linux', 21:34:43 INFO - 'TMOUT': '86400', 21:34:43 INFO - 'USER': 'cltbld', 21:34:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', 21:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:43 INFO - '_': '/tools/buildbot/bin/python'} 21:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:43 INFO - Downloading/unpacking blobuploader==1.2.4 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34:45 INFO - Downloading blobuploader-1.2.4.tar.gz 21:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:34:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:34:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:46 INFO - Downloading docopt-0.6.1.tar.gz 21:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:34:46 INFO - Installing collected packages: blobuploader, requests, docopt 21:34:46 INFO - Running setup.py install for blobuploader 21:34:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:34:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:34:46 INFO - Running setup.py install for requests 21:34:47 INFO - Running setup.py install for docopt 21:34:47 INFO - Successfully installed blobuploader requests docopt 21:34:47 INFO - Cleaning up... 21:34:47 INFO - Return code: 0 21:34:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:47 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')]} 21:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:47 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')]} 21:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:47 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 0x7fc1ee132f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b4640>, '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 0x20b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b59d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', '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 21:34:47 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 21:34:47 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 21:34:47 INFO - Using env: {'DISPLAY': ':0', 21:34:47 INFO - 'HOME': '/home/cltbld', 21:34:47 INFO - 'LANG': 'en_US.UTF-8', 21:34:47 INFO - 'LANGUAGE': 'en_US:en', 21:34:47 INFO - 'LOGNAME': 'cltbld', 21:34:47 INFO - 'MAIL': '/var/mail/cltbld', 21:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:47 INFO - 'MOZ_NO_REMOTE': '1', 21:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:47 INFO - 'NO_EM_RESTART': '1', 21:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:47 INFO - 'PWD': '/builds/slave/test', 21:34:47 INFO - 'SHELL': '/bin/bash', 21:34:47 INFO - 'SHLVL': '1', 21:34:47 INFO - 'TERM': 'linux', 21:34:47 INFO - 'TMOUT': '86400', 21:34:47 INFO - 'USER': 'cltbld', 21:34:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', 21:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:47 INFO - '_': '/tools/buildbot/bin/python'} 21:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:34:47 INFO - Running setup.py (path:/tmp/pip-ytWMio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:34:47 INFO - Running setup.py (path:/tmp/pip-jiSJ8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:34:47 INFO - Running setup.py (path:/tmp/pip-G4FBNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:34:47 INFO - Running setup.py (path:/tmp/pip-KeBeHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:34:47 INFO - Running setup.py (path:/tmp/pip-x7xgSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:34:47 INFO - Running setup.py (path:/tmp/pip-P7wjNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:34:47 INFO - Running setup.py (path:/tmp/pip-EJBYLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:34:47 INFO - Running setup.py (path:/tmp/pip-1UUW6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:34:47 INFO - Running setup.py (path:/tmp/pip-ufpWxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:34:48 INFO - Running setup.py (path:/tmp/pip-OqNjpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:34:48 INFO - Running setup.py (path:/tmp/pip-iHriym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:34:48 INFO - Running setup.py (path:/tmp/pip-rzvIol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:34:48 INFO - Running setup.py (path:/tmp/pip-fmwefU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:34:48 INFO - Running setup.py (path:/tmp/pip-xLBbgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:48 INFO - Running setup.py (path:/tmp/pip-eqCHDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:34:48 INFO - Running setup.py (path:/tmp/pip-Yu3k6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:34:48 INFO - Running setup.py (path:/tmp/pip-RNiGaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:34:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:34:48 INFO - Running setup.py install for manifestparser 21:34:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:34:48 INFO - Running setup.py install for mozcrash 21:34:48 INFO - Running setup.py install for mozdebug 21:34:48 INFO - Running setup.py install for mozdevice 21:34:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Running setup.py install for mozfile 21:34:49 INFO - Running setup.py install for mozhttpd 21:34:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Running setup.py install for mozinfo 21:34:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Running setup.py install for mozInstall 21:34:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Running setup.py install for mozleak 21:34:49 INFO - Running setup.py install for mozlog 21:34:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Running setup.py install for moznetwork 21:34:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Running setup.py install for mozprocess 21:34:49 INFO - Running setup.py install for mozprofile 21:34:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:34:49 INFO - Running setup.py install for mozrunner 21:34:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:34:50 INFO - Running setup.py install for mozscreenshot 21:34:50 INFO - Running setup.py install for moztest 21:34:50 INFO - Running setup.py install for mozversion 21:34:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:34:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:34:50 INFO - Cleaning up... 21:34:50 INFO - Return code: 0 21:34:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:50 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')]} 21:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:50 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')]} 21:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:50 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 0x7fc1ee132f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b4640>, '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 0x20b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b59d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', '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 21:34:50 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 21:34:50 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 21:34:50 INFO - Using env: {'DISPLAY': ':0', 21:34:50 INFO - 'HOME': '/home/cltbld', 21:34:50 INFO - 'LANG': 'en_US.UTF-8', 21:34:50 INFO - 'LANGUAGE': 'en_US:en', 21:34:50 INFO - 'LOGNAME': 'cltbld', 21:34:50 INFO - 'MAIL': '/var/mail/cltbld', 21:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:50 INFO - 'MOZ_NO_REMOTE': '1', 21:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:50 INFO - 'NO_EM_RESTART': '1', 21:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:50 INFO - 'PWD': '/builds/slave/test', 21:34:50 INFO - 'SHELL': '/bin/bash', 21:34:50 INFO - 'SHLVL': '1', 21:34:50 INFO - 'TERM': 'linux', 21:34:50 INFO - 'TMOUT': '86400', 21:34:50 INFO - 'USER': 'cltbld', 21:34:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', 21:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:50 INFO - '_': '/tools/buildbot/bin/python'} 21:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:34:50 INFO - Running setup.py (path:/tmp/pip-H0qOku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:34:50 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)) 21:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:34:50 INFO - Running setup.py (path:/tmp/pip-iEw3UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:34:50 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)) 21:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:34:50 INFO - Running setup.py (path:/tmp/pip-khXKNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:34:50 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)) 21:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:34:50 INFO - Running setup.py (path:/tmp/pip-vRBFZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:34:50 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)) 21:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:34:50 INFO - Running setup.py (path:/tmp/pip-q6tRUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:34:50 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)) 21:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:34:50 INFO - Running setup.py (path:/tmp/pip-dueSjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:34:51 INFO - Running setup.py (path:/tmp/pip-D1f9zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:34:51 INFO - Running setup.py (path:/tmp/pip-5XLp6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:34:51 INFO - Running setup.py (path:/tmp/pip-Xt2Y2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:34:51 INFO - Running setup.py (path:/tmp/pip-m1GQsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:34:51 INFO - Running setup.py (path:/tmp/pip-0guQ0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:34:51 INFO - Running setup.py (path:/tmp/pip-MaCqJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:34:51 INFO - Running setup.py (path:/tmp/pip-af0eld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:34:51 INFO - Running setup.py (path:/tmp/pip-3dapDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:51 INFO - Running setup.py (path:/tmp/pip-zG6BMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:34:51 INFO - Running setup.py (path:/tmp/pip-gK2FZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:34:51 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)) 21:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:34:51 INFO - Running setup.py (path:/tmp/pip-XpxdON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:53 INFO - Downloading blessings-1.6.tar.gz 21:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:34:53 INFO - Installing collected packages: blessings 21:34:53 INFO - Running setup.py install for blessings 21:34:53 INFO - Successfully installed blessings 21:34:53 INFO - Cleaning up... 21:34:54 INFO - Return code: 0 21:34:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:34:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:34:54 INFO - Reading from file tmpfile_stdout 21:34:54 INFO - Current package versions: 21:34:54 INFO - argparse == 1.2.1 21:34:54 INFO - blessings == 1.6 21:34:54 INFO - blobuploader == 1.2.4 21:34:54 INFO - docopt == 0.6.1 21:34:54 INFO - manifestparser == 1.1 21:34:54 INFO - mozInstall == 1.12 21:34:54 INFO - mozcrash == 0.17 21:34:54 INFO - mozdebug == 0.1 21:34:54 INFO - mozdevice == 0.48 21:34:54 INFO - mozfile == 1.2 21:34:54 INFO - mozhttpd == 0.7 21:34:54 INFO - mozinfo == 0.9 21:34:54 INFO - mozleak == 0.1 21:34:54 INFO - mozlog == 3.1 21:34:54 INFO - moznetwork == 0.27 21:34:54 INFO - mozprocess == 0.22 21:34:54 INFO - mozprofile == 0.28 21:34:54 INFO - mozrunner == 6.11 21:34:54 INFO - mozscreenshot == 0.1 21:34:54 INFO - mozsystemmonitor == 0.0 21:34:54 INFO - moztest == 0.7 21:34:54 INFO - mozversion == 1.4 21:34:54 INFO - psutil == 3.1.1 21:34:54 INFO - requests == 1.2.3 21:34:54 INFO - wsgiref == 0.1.2 21:34:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:54 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 0x7fc1ee132f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b4640>, '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 0x20b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b59d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', '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 21:34:54 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 21:34:54 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 21:34:54 INFO - Using env: {'DISPLAY': ':0', 21:34:54 INFO - 'HOME': '/home/cltbld', 21:34:54 INFO - 'LANG': 'en_US.UTF-8', 21:34:54 INFO - 'LANGUAGE': 'en_US:en', 21:34:54 INFO - 'LOGNAME': 'cltbld', 21:34:54 INFO - 'MAIL': '/var/mail/cltbld', 21:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:54 INFO - 'MOZ_NO_REMOTE': '1', 21:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:54 INFO - 'NO_EM_RESTART': '1', 21:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:54 INFO - 'PWD': '/builds/slave/test', 21:34:54 INFO - 'SHELL': '/bin/bash', 21:34:54 INFO - 'SHLVL': '1', 21:34:54 INFO - 'TERM': 'linux', 21:34:54 INFO - 'TMOUT': '86400', 21:34:54 INFO - 'USER': 'cltbld', 21:34:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', 21:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:54 INFO - '_': '/tools/buildbot/bin/python'} 21:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:54 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)) 21:34:54 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)) 21:34:54 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)) 21:34:54 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)) 21:34:54 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)) 21:34:54 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)) 21:34:54 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)) 21:34:54 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)) 21:34:54 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)) 21:34:54 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)) 21:34:54 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)) 21:34:54 INFO - Cleaning up... 21:34:54 INFO - Return code: 0 21:34:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:54 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 0x7fc1ee132f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b4640>, '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 0x20b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b59d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', '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 21:34:54 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 21:34:54 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 21:34:54 INFO - Using env: {'DISPLAY': ':0', 21:34:54 INFO - 'HOME': '/home/cltbld', 21:34:54 INFO - 'LANG': 'en_US.UTF-8', 21:34:54 INFO - 'LANGUAGE': 'en_US:en', 21:34:54 INFO - 'LOGNAME': 'cltbld', 21:34:54 INFO - 'MAIL': '/var/mail/cltbld', 21:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:54 INFO - 'MOZ_NO_REMOTE': '1', 21:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:54 INFO - 'NO_EM_RESTART': '1', 21:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:54 INFO - 'PWD': '/builds/slave/test', 21:34:54 INFO - 'SHELL': '/bin/bash', 21:34:54 INFO - 'SHLVL': '1', 21:34:54 INFO - 'TERM': 'linux', 21:34:54 INFO - 'TMOUT': '86400', 21:34:54 INFO - 'USER': 'cltbld', 21:34:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', 21:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:54 INFO - '_': '/tools/buildbot/bin/python'} 21:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:54 INFO - Downloading/unpacking jsonschema 21:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:34:56 INFO - Downloading/unpacking functools32 (from jsonschema) 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34:56 INFO - Downloading functools32-3.2.3-2.tar.gz 21:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:34:56 INFO - warning: no files found matching '*.txt' 21:34:56 INFO - no previously-included directories found matching 'build' 21:34:56 INFO - no previously-included directories found matching 'dist' 21:34:56 INFO - no previously-included directories found matching '.git*' 21:34:56 INFO - Installing collected packages: jsonschema, functools32 21:34:56 INFO - Running setup.py install for functools32 21:34:56 INFO - warning: no files found matching '*.txt' 21:34:56 INFO - no previously-included directories found matching 'build' 21:34:56 INFO - no previously-included directories found matching 'dist' 21:34:56 INFO - no previously-included directories found matching '.git*' 21:34:56 INFO - Successfully installed jsonschema functools32 21:34:56 INFO - Cleaning up... 21:34:57 INFO - Return code: 0 21:34:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:34:57 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')]} 21:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:57 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')]} 21:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:57 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 0x7fc1ee132f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b4640>, '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 0x20b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b59d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', '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 21:34:57 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 21:34:57 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 21:34:57 INFO - Using env: {'DISPLAY': ':0', 21:34:57 INFO - 'HOME': '/home/cltbld', 21:34:57 INFO - 'LANG': 'en_US.UTF-8', 21:34:57 INFO - 'LANGUAGE': 'en_US:en', 21:34:57 INFO - 'LOGNAME': 'cltbld', 21:34:57 INFO - 'MAIL': '/var/mail/cltbld', 21:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:57 INFO - 'MOZ_NO_REMOTE': '1', 21:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:57 INFO - 'NO_EM_RESTART': '1', 21:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:57 INFO - 'PWD': '/builds/slave/test', 21:34:57 INFO - 'SHELL': '/bin/bash', 21:34:57 INFO - 'SHLVL': '1', 21:34:57 INFO - 'TERM': 'linux', 21:34:57 INFO - 'TMOUT': '86400', 21:34:57 INFO - 'USER': 'cltbld', 21:34:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', 21:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:57 INFO - '_': '/tools/buildbot/bin/python'} 21:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:57 INFO - Downloading/unpacking flake8 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:34:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:34:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:34:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:34:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:34:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:34:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:34:59 INFO - no previously-included directories found matching 'docs/_build' 21:34:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:34:59 INFO - Running setup.py install for pep8 21:34:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:34:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:34:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:34:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:34:59 INFO - no previously-included directories found matching 'docs/_build' 21:34:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:34:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:34:59 INFO - Cleaning up... 21:35:00 INFO - Return code: 0 21:35:00 INFO - Running post-action listener: _resource_record_post_action 21:35:00 INFO - Running post-action listener: _start_resource_monitoring 21:35:00 INFO - Starting resource monitoring. 21:35:00 INFO - ##### 21:35:00 INFO - ##### Running install step. 21:35:00 INFO - ##### 21:35:00 INFO - Running pre-action listener: _resource_record_pre_action 21:35:00 INFO - Running main action method: install 21:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:00 INFO - Reading from file tmpfile_stdout 21:35:00 INFO - Detecting whether we're running mozinstall >=1.0... 21:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:35:00 INFO - Reading from file tmpfile_stdout 21:35:00 INFO - Output received: 21:35:00 INFO - Usage: mozinstall [options] installer 21:35:00 INFO - Options: 21:35:00 INFO - -h, --help show this help message and exit 21:35:00 INFO - -d DEST, --destination=DEST 21:35:00 INFO - Directory to install application into. [default: 21:35:00 INFO - "/builds/slave/test"] 21:35:00 INFO - --app=APP Application being installed. [default: firefox] 21:35:00 INFO - mkdir: /builds/slave/test/build/application 21:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:35:15 INFO - Reading from file tmpfile_stdout 21:35:15 INFO - Output received: 21:35:15 INFO - /builds/slave/test/build/application/firefox/firefox 21:35:15 INFO - Running post-action listener: _resource_record_post_action 21:35:15 INFO - ##### 21:35:15 INFO - ##### Running run-tests step. 21:35:15 INFO - ##### 21:35:15 INFO - Running pre-action listener: _resource_record_pre_action 21:35:15 INFO - Running main action method: run_tests 21:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:35:15 INFO - Python 2.7.3 21:35:15 INFO - Return code: 0 21:35:15 INFO - grabbing minidump binary from tooltool 21:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:35:15 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 0x20b4640>, '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 0x20b5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b59d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:35:15 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 21:35:15 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 21:35:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:35:16 INFO - Return code: 0 21:35:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:35:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:35:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:35:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:35:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:35:16 INFO - Return code: 0 21:35:16 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:35:16 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:35:16 INFO - Using env: {'DISPLAY': ':0', 21:35:16 INFO - 'HOME': '/home/cltbld', 21:35:16 INFO - 'LANG': 'en_US.UTF-8', 21:35:16 INFO - 'LANGUAGE': 'en_US:en', 21:35:16 INFO - 'LOGNAME': 'cltbld', 21:35:16 INFO - 'MAIL': '/var/mail/cltbld', 21:35:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:35:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:16 INFO - 'MOZ_NO_REMOTE': '1', 21:35:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:16 INFO - 'NO_EM_RESTART': '1', 21:35:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:16 INFO - 'PWD': '/builds/slave/test', 21:35:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:35:16 INFO - 'SHELL': '/bin/bash', 21:35:16 INFO - 'SHLVL': '1', 21:35:16 INFO - 'TERM': 'linux', 21:35:16 INFO - 'TMOUT': '86400', 21:35:16 INFO - 'USER': 'cltbld', 21:35:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080', 21:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:16 INFO - '_': '/tools/buildbot/bin/python'} 21:35:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:35:17 INFO - mozversion application_buildid: 20160517191151 21:35:17 INFO - mozversion application_changeset: b4e6080db0238862dfb893ea6ab564fcd4375da1 21:35:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:35:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:35:17 INFO - mozversion application_name: Firefox 21:35:17 INFO - mozversion application_remotingname: firefox-dev 21:35:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:35:17 INFO - mozversion application_vendor: Mozilla 21:35:17 INFO - mozversion application_version: 48.0a2 21:35:17 INFO - mozversion platform_buildid: 20160517191151 21:35:17 INFO - mozversion platform_changeset: b4e6080db0238862dfb893ea6ab564fcd4375da1 21:35:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:35:17 INFO - mozversion platform_version: 48.0a2 21:35:17 INFO - using testdate: 1463546117 21:35:17 INFO - actual date: 1463546117 21:35:17 INFO - starting webserver on 'localhost:35777' 21:35:17 INFO - SUITE-START | Running 2 tests 21:35:17 INFO - TEST-START | dromaeo_css 21:35:17 INFO - operating with platform_type : linux_ 21:35:17 INFO - Initialising browser for dromaeo_css test... 21:35:17 INFO - TEST-INFO | started process 12876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwgTwSP/profile http://localhost:35777/getInfo.html) 21:35:21 INFO - PROCESS | 12876 | __metrics Screen width/height:1600/1200 21:35:21 INFO - PROCESS | 12876 | colorDepth:24 21:35:21 INFO - PROCESS | 12876 | Browser inner width/height: 1024/697 21:35:21 INFO - PROCESS | 12876 | __metrics 21:35:22 ERROR - PROCESS | 12876 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:35:23 INFO - TEST-INFO | 12876: exit 0 21:35:23 INFO - Browser initialized. 21:35:23 INFO - Running cycle 1/1 for dromaeo_css test... 21:35:23 INFO - TEST-INFO | started process 12969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwgTwSP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:35 INFO - PROCESS | 12969 | RSS: Main: 141815808 21:35:35 INFO - PROCESS | 12969 | 21:36:26 INFO - PROCESS | 12969 | 1463546186955 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] 21:38:33 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35777/tests/dromaeo/cssquery-ext.html) 21:38:34 INFO - PROCESS | 12969 | RSS: Main: 258453504 21:38:34 INFO - PROCESS | 12969 | 21:41:36 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-ext.html (next: http://localhost:35777/tests/dromaeo/cssquery-jquery.html) 21:41:37 INFO - PROCESS | 12969 | RSS: Main: 221401088 21:41:37 INFO - PROCESS | 12969 | 21:44:38 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35777/tests/dromaeo/cssquery-mootools.html) 21:44:39 INFO - PROCESS | 12969 | RSS: Main: 216776704 21:44:39 INFO - PROCESS | 12969 | 21:47:41 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35777/tests/dromaeo/cssquery-prototype.html) 21:47:41 INFO - PROCESS | 12969 | RSS: Main: 220233728 21:47:41 INFO - PROCESS | 12969 | 21:50:44 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35777/tests/dromaeo/cssquery-yui.html) 21:50:45 INFO - PROCESS | 12969 | RSS: Main: 211247104 21:50:45 INFO - PROCESS | 12969 | 21:53:47 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-yui.html (next: http://localhost:35777/tests/dromaeo/cssquery-dojo.html) 21:53:47 INFO - PROCESS | 12969 | RSS: Main: 248053760 21:53:47 INFO - PROCESS | 12969 | 21:53:47 INFO - PROCESS | 12969 | __start_tp_report 21:53:47 INFO - PROCESS | 12969 | _x_x_mozilla_page_load 21:53:47 INFO - PROCESS | 12969 | _x_x_mozilla_page_load_details 21:53:47 INFO - PROCESS | 12969 | |i|pagename|runs| 21:53:47 INFO - PROCESS | 12969 | |0;dojo.html;3207.3745619604174;3268.4770436730128;3296.5549650797134;3302.1249368917256;3316.718078963288;5332;5340.412554618989;5355.598330125246;5364.651297665649;5371.033214021474;5363.758630861611;5373.489518495747;5381.300430943981;5383.327084114486;5389.380221274555;4725.243960966246;4935.531124543163;4950.826721064764;5026.095302845486;5028.4971502849785;4839.298301746245;4848.975755121237;4890.266460030988;4927.162382394984;4997.0505603935135;4899.853004409873;4920.950790492103;4921.434035085975;4923.950760492385;4957.553820156185;4729;4869.975650121727;4905.852824415273;4918.434380046305;4921.163402221631;4848.490908454597;4904.754762261909;4921.286413470062;4926.3842019747535;4947.158982972904;5168.069747445458;5216.66091704038;5222.895542089175;5240.68555886648;5262.500062494057;5532.7786888524815;5634.239377684001;5647.152927060933;5719.571032172604;5805.941940580582;5610.074337734269;5626.634268772516;5631.465010823965;5639.379668236491;5652.943470565324;5267.894642107175;5274.393444753864;5277.102892508245;5278.445763194886;5278.5249327560705;5599.1041433370465;5719.799807006735;5724.026915424388;5793.913091303634;5835.854103647443;5597.944020559742;5611.410801865827;5612.382637909826;5613.7193140342815;5614.410486898817;5623.184638227434;5662.85842853932;5666.376698563155;5669.688167150764;5672.149177623307;5518.751656175482;5630.831075067755;5696.231008813757;5723.713814309268;5732.598718089777;5682.516986056232;5700.087985922232;5703.17303990919;5707.143928410688;5709.8287051388525;4277.786110694453;4412.624926881187;4422.557744225552;4435.778211089432;4438.866833994985;3943.881683549498;3990.68074554035;3997.8600748973645;4015.819288132041;4024.5170579530645;5401.891962160735;5423.566114710814;5424.213489044067;5434.83695489136;5436.537894278951;5564.916526252109;5691.260136182353;5701.800436984686;5738.913916291175;5751.712414379264;5450;5473.7263136843;5478.808241711601;5481.314835645544;5483.725813709379;4922.138625740481;4933.87665308363;4934.777934992934;4941.308216849644;4947.480514545993;5748.367679555246;5929.73316200772;5984.790532331347;5989.700514974234;6015.969920150459;5714.0571805652435;5727.455891690282;5728.198052272768;5735.025045742151;5738;5932.555058370725;5935.139404786368;5938.435848594377;5939.406059394026;5958.493528050164;5350.384705758732;5577.52591029767;5623.297087864017;5630.5777066720975;5676.545876329967;5619.550435965031;5632.971835140962;5646;5653.067243904874;5657.038303488334;5421.566274697936;5527.668339899619;5533.00405926937;5534.833954981357;5538.169274608841;5445.50990410849;5458.344998600193;5506.944930550803;5535.723213839373;5558.333000040021;5384.326959130109;5388.164834450667;5413.350397952271;5413.918791218056;5420.972895135499;5430.619856609999;5512.834614961557;5520.337559492887;5548.9722551386985;5563.8887222256135;5339.252504649275;5404.0272750905215;5415.377231618257;5421;5516.310461192351 21:53:47 INFO - PROCESS | 12969 | |1;ext.html;615.9907601385977;656.3961155736722;667.1893649216203;674.419998801031;738.9433110651772;38566.42150367743;39555.80222098885;39582.80208598953;39583.60416395835;39610.207795844064;41280.79359603198;41974.37038444426;42026.369604455955;42041.369379459255;42062;8239.752807415787;8385.413021088527;8782.692605758784;8957.238634716057;10282.434466104361;10442.58229670816;10565.630202942899;10575;10576.365418074902;10586.629467968623;10528.894711052906;10587.576496940113;10602.840957385606;10613.73465663357;10620.681379558626;8471.322294216448;10492.475376231196;10680.412577308245;10965.725856853642;10975.780484390347;10333.483325833678;10448.425336606484;10452.37285762849;10458.424786636731;10460.26778125524;38545.80727096375;39117.217655647015;39199.41200881989;39233.41149882754;39285.41071883895;3842.269968705965;4003.2393845169618;4289.463817022872;4369.2353838078525;4519.141363141026;32695.346093078006;33214.335713285844;33349.833250833835;33446.665533344596;33519.66480335214;4587.9082418351445;4642.048380082108;4664.160451118797;4675.509071547473;4699.436067671867;327187;329507;330075;330422;331636;39078.6092139075;61920.69039654863;63441.365586344466;63641.36358636447;63828.36171638317;37424.81287593599;37443.251134977145;37457.62542374596;37492.25015499675;37618.811905940296;17298.82701172972;17384.391546295818;17439.82560174382;17493.475195744148;17501.562460938578;13562.254076025716;15226.314815833313;15633.921830390775;15652.37390504367;15668.68662626764;9049.683261085831;9110.726678199664;9156.221721153777;9162.083791620784;9197.310201734897;3450.0857272822723;3505.754597178173;3533.169705119295;3548.929021419557;3586.7309951753723;1069.1019543583427;1116.4640972333325;1124.707576030238;1171.705265681427;1201.5013769285824;28254.576181357297;29102.417951640848;29296.707032929397;29589.85205074004;30445;1184.8637406698167;1202.4949521201117;1207.1730864357944;1329.0962145740796;1377.8484366719654;16134.193290335435;16240.918795406184;16265.268062936959;16278.918605407134;16394.918025410036;370673;541734;542316;542464;542484;60209.69895150584;60697.39302606917;60949.69525152435;60985;61075;1422.3528294625921;1429.2425014742203;1446.8119144511147;1486.873615742674;1526.145358599188;30648.693513064583;32320.35359292848;32579.02262932116;32970;33597.99206023823;52745.47254527559;53575.732121340705;53851.461485386215;53893.73053134709;53905.46094539004;372595;375981;376403;377678;377911;29930.551041734827;30698;30811.691883080883;31082.222944425666;31090.53364199584;49197.50802491929;50080.499195007586;50823.745881270355;50830.49169508258;51427.228591570405;40648.39027414532;41586.59842158344;41984.58015419929;42526.362104569074;42746.35880461733;40821;41119.38320925129;41376.77487306352;41666;41726.79136604298;42404;42954.57045429631;43043.56956430521;43171.56828431801;43496;35249.94250172499;36714.265714685025;36936.26127477489;37119.628803712694;37609.247815044095;28830.473226709193;29412.852935735184;29959.101226963227;30051.549226762054;30102.698973010865 21:53:47 INFO - PROCESS | 12969 | |2;jquery.html;394.221412709898;395.0972028913931;429.17598211434046;432.2450849550822;436.5481726413161;18036.729449058243;18475.26098956042;19002.429927102174;19018.334358297463;19296.614067718638;18984.905075474602;19068.5232869178;19423.708644370345;20669.586608267862;20675.379738607866;5834.270716160469;5930.406959304057;5973.940260597404;6013.128096426016;6040;5784.132380142991;5897.4102589741115;5907.940920590782;5919.55603329752;5933.821985340447;5837.649741015532;5853.707314634273;5869.8826023479505;5880.617759845596;5912.733926973297;5720.370759216483;5845.7369418376275;5882.088276317135;5889.02831032879;5903.0260007099;5278.6041046921255;5321.600879934021;5326.733663316819;5327.147656375;5353.116735738598;22692.54614907709;23042.308730738103;23251.3024609262;23330.066797328087;23353.299401017997;2454.828162028659;2578.2523068310165;2639.736026397345;2759.8344099354103;2949.631296087989;13918.234497102656;14714.632134196623;14749.115053096848;14761.483348082766;15307.693846123015;1971.763388393402;1981.9009049547465;1984.8610597258198;2032.9085191166432;2076.252549082329;53691;76113.61943190303;84811.57594212051;85511.57244213801;85849.14150858474;11460.312381257152;11538;11590.536378544764;11596.826047609293;11630.127740419503;15864.127472989096;15987.280572374271;16096.67806643884;16101.114438705983;16110;8932.330075244383;8934.463932164092;8971.968223654363;9025.729228123168;9121.498317592595;8873.778155546162;8895.911040889509;8979.191872731486;9078.273738100936;9125.361224714206;4882.6826256293225;4941;4967;5023.120953833065;5041.445441001487;2041.3161590866928;2057.1257215683277;2065.10168076884;2084.6768750843644;2147.9248226312316;1000.9349392289478;1088.6570730219955;1090.4820210399996;1158.9130815188894;1174.7591743692522;18452.89282643019;19153.521161970784;19499.8050019498;19606.313779017666;19644.803551964298;1063.1016790811907;1066.8346406307035;1083.6965649618119;1098.214776434837;1112.5772206561455;10789.24475286738;10872;11158.163137764537;11203.607873724544;11296.152788540892;379205;383338;386816;500152;500967;84206;87629;89363;89660.10339896518;101955;1061.5594528270835;1100.9284396514201;1113.0761467981556;1117.921745477825;1122.7586068995206;16607.66784664276;16712.582185445463;16787.076710781024;17215.225314861113;17635.735463968307;37569;38099;40941.38587921243;41357.79321103375;42513.149737005704;56498.15252771294;59659.70170149121;59685;59969.40030599638;59996.700016499635;8586.484810911365;8650.567471626267;8716.38985271025;8896.77758056028;8970.955145224232;11836.644900652995;12693.8095928563;12772.042096842959;12905.483780648668;13236.272005039815;11337.773244535229;11436.027937625395;11625.476853541442;11670.88329116732;11789.351585662871;10851.131909447384;11179.60871369498;11321.660350189508;11581.768364632828;11626.76746465083;11916.344601047025;12117.575884843987;12384.380780961095;12511.436985335864;12579.87420125787;8566.229039386486;8599.183077607617;8752.956235218782;8810.603522841358;8896.86654700193;11514.481848316678;11917.702057448632;12100.394980250776;12115.091368147248;12128.939355303168 21:53:47 INFO - PROCESS | 12969 | |3;mootools.html;1422.5447856685864;1556.8988015778975;1563.288703639844;1777.7422273770303;1865.0767869904407;7716.189800070996;7918.7624371268885;7929.444938854283;7930.801729956739;7936.285734283913;7577.772666820004;7718.343940765042;7719.228077192292;7719.961400192991;7725.845483090349;2051.476873397289;2247.2359397804744;2251.909923603058;2277.7038984931937;2291.140822191678;2310.9653355199684;2324.8140148788057;2329.487512747193;2330.6853574767442;2334.2997100869757;2230.7546169921297;2295.380247333219;2295.6097463431174;2295.8392912496133;2299.5975704251773;2041.9897900510477;2273.386185729852;2323.779240972105;2324.3027091872373;2326.4532834783813;2256.537409830981;2285.2344464604375;2296.437372843647;2297.793198612133;2316.791488766019;7761.650725717356;7827.3346765525;7835.921640783577;7838.216178382173;7838.804029899241;4841.273808928689;4984.451710311862;4985.227289770091;4985.277134815431;5020.824271150529;3280.5243239730107;3293.3413317336626;3318.502224666295;3337.716294115003;3365.528825964367;1143.2340331977596;1166.2419427372276;1184.6090790039266;1185.9110566707532;1197.7903866823272;11272.66182014541;11310.773784524346;11320.377379244139;11326.20716549842;11327.037201837853;4217.936730949038;4240.681948853849;4293.549177336335;4295.78521073945;4349.804258808361;9698.321117521706;9719;9722.513874306256;9730.562124704406;9731.124198821999;4540.500544940054;5038.496150385005;5039.118154322979;5039.344885164978;5041.092603331363;4160.479940007499;4160.646345060703;4164.875053748392;4482.843100491533;4535.886602834889;3743.344914639927;3784.0539865033743;3830.540335159743;3863.478430411915;3864.71014673895;1195.4560674892903;1200.771853347861;1202.8797120287902;1210.4250481021445;1222.2849632964637;952.2905435450633;1028.717102796737;1029.3206483720708;1044.8955104489642;1051.348164138239;5786.71066446676;5831.737571809279;5852.824415267549;5876.030454974882;5927.2590926134235;965.478641533564;993.1905497019906;1025.4565080507193;1030.3611760708259;1047.7171163785888;3980.601939805996;3981.144054028398;3983.3029219886403;4025.939610905839;4033.213523362916;9770.755731106638;9963.601455941825;10075.294729368874;10132.138768204637;10159.034891685278;9766.46284454362;9791.755206119762;9929.950350248202;9948.552315145836;9958.651447199314;7593.810154746065;7670.463067585327;7767.067951845815;7770.378369730408;7772.106207786064;5601.60788744784;5606.103023516218;5623.578231632562;5681.431856814285;5757.6545407274025;8840.513771742359;8946.37375383717;9103.089691030844;9106.863397049183;9122.498262595622;8714.520701361233;8936.195742383217;8942.418742781698;9208.861867071866;9218.677346292847;6566.80299591013;6753.088333074972;6754.8649027020165;7252.782416527512;7380.335769780745;7621.31408173267;7772.378209743094;7782.105057918412;7792.532448053135;7824.452288339761;7019.333163349474;7265.055542779405;7269.3094156055095;7303.890441643273;7370.705171793068;6717.05961165447;6737.9326206737305;6964.477664175106;6964.582125072512;7046.471514636525;6327.810165695037;6347.206599175103;6431.742730290736;6448.871022579616;6454.322296159024;5010.8246211383885;5013.298138260573;5035.395752509722;5068.163752980717;5101.9489805101475;5000.199968005102;5010.674306170087;5190.636655434083;5204.609654275869;5213.061648903082 21:53:47 INFO - PROCESS | 12969 | |4;prototype.html;327.0613339715018;332.57264415226433;333.96326404095544;334.9581302337208;336.670063337929;6128.908066379002;6184.907226391602;6217.689115544216;6222.066689996497;6268.310485846553;6141.447269745722;6141.508679305656;6144.139820425144;6145.324014358417;6153.50771938245;4455.598996090352;4557.498675145731;4622.907541849161;4680.438347398317;4685.109829132471;4646.930296045562;4670.719756814585;4671.953280467186;4672.299155126741;4676.321933319684;4436.157130145279;4614.400127983375;4643.628509719231;4644.558766917155;4645.9303110453375;4529.750863702495;4623.8150473981;4626.144163329761;4629.166749985001;4632.305154226876;4022.45696830927;4032.717709760318;4035.3341698619693;4037.192561487714;4040.7979601019833;5893.705314734246;5898.056310990221;5906.173135760997;5916.319623243339;5928.140419639129;5376.8118115865755;5382.327209098863;5386.084365657808;5388.407275199725;5390.1375779875425;6462.579932304432;6465;6466.870662586769;6467.223933128008;6471.482281417522;4198.6431153352005;4268.829246830123;4292.420523229386;4305.461817272841;4314;6660.2340730816095;6754.3921047106;6763.391294783493;6763.763268285636;6770.356816102511;4336.76147811867;4447.155040542287;4454.064646424287;4474.597286244189;4486.371907932892;4512.390827238347;4523.638108951276;4526.094781043805;4530.70550414222;4536.047430039663;5287.550558202596;5295;5300.787968481295;5303.28405665238;5312.495312945264;6521.771737989147;6524.445422139172;6526.706298216497;6527.771527996498;6535.640539770358;1543.5986643472777;1566.937322507087;1569.8901076924733;1571.5442521668817;1572.7798108264851;970.7961328121032;1000.939004655068;1026.1431704526653;1047.7223535763028;1050.6795427394566;6249.781257656051;6291.150694656163;6303.810885673437;6312.400321969406;6320.399562041599;6687.665616719145;6689.3611065289315;6696.363845434676;6701.5308928375525;6703.966480167568;6301.558890877686;6309.905351419732;6314.62112273265;6321.55749097568;6324.3991820776955;3562.1628917204434;3595.0832537702718;3601.0097223263288;3604.6395360463744;3606.783592984377;6871.759488417882;7001;7014.754483593049;7017.193022802443;7027.824304392431;6747;6778.762743303961;6781.355771201728;6787.185537735503;6804.625745583941;6989.0564773754895;6993.510454268152;6997.370236678723;7001.684924178424;7009.193942696553;6597.373249541286;6666.866662666816;6692.665366731547;6697.0958920547055;6699.430548403246;6409.807705768834;6554.967225163844;6556.3443655634055;6568.14614100183;6577.3422657733845;6953.443724502129;6959.234484206834;6978.685959131953;6988.231294557696;6988.301169882971;4446.82212711488;4469.195544801837;4477.1493416250805;4478.0148367359125;4486.75322857246;6613.768518101843;6638.302978187221;6643.202815662152;6643.701033453603;6644.7009884554345;6309.810705678837;6435.388638079375;6473.805785826433;6478.125453063776;6482.384173503509;6395;6421.967890160519;6428.839279018062;6429.807105786834;6431.938730109667;6333.778317758856;6344.746210151542;6360.713767880364;6365.726854629;6366.808995730135;6489.707963141575;6499.0901273820755;6504.707288172138;6506.512011599244;6507.739690412331;6143.969280153749;6190.226221722285;6251.249850018027;6319.873602527831;6341.334159913327 21:53:47 INFO - PROCESS | 12969 | |5;yui.html;795.4829360915404;885.375810053912;902.9954850225748;905.7961958559325;908.3913777768894;14727.779083313759;14832.110073395605;14833.629159271024;14886.77669834952;14924.403023879046;13623.659408514768;13917.164970101776;14024.859751402482;14040.227787471686;14065.296735163252;752.10875112991;888.6489836514573;891.2602539891874;901.0673952459206;911.7811725185941;907.6505545365048;909.4452384045727;909.7134402663173;911.0752586125055;911.3028533172095;944.1455482788087;948.9667861624845;950.7385468996013;950.7385468996047;950.8716323296336;792.63142638673;809.5952023988006;810.7000409848393;937.4328531238639;939.3424602778049;696.2445746365199;697.4420463629076;697.4734075772759;697.9581225126509;698.1343134513218;13412.12821166621;13450.529231476949;13460.461581536727;13464.798028029587;13464.932675336659;13852.168869867739;14476;14827.110373377633;14873.181974991372;14909.70180596382;11804.763904721944;11854.3480108594;11864.347460889647;11890.108241881808;12175.45210465531;3986.2426139033782;3997.9205614484217;4005.319095753729;4012.779297138656;4089.591040895916;56124.719376402856;56229.43770562324;56229.71885140589;56271.718641406944;56742;10714.946425267824;11049.889501105046;11084.501197446134;11100.44497775108;11381.487833047533;18424.447266582025;18436.539086522946;18462.35381761632;18529.258829646933;20354.491137721674;8502.957485212659;8570.957145214234;8702.95648521766;8803.867941980876;8841.027486976427;4626.791794369195;4652;4662.790174442158;4748.7863046163;4823.782929768169;3508.6315936826777;3529.8941031769086;3573.1781690211396;3575.0883524701553;3577.713782897362;653.0726368556661;663.4393937123124;686.0669489494284;697.8081027717418;708.7838209346199;675.3719041291646;818.8403261364095;821.4167940762006;836.4019725896013;860.2773670117132;10160.745981350377;10327.32872363294;10341.121004714532;10505.737356566147;10549.894501055045;621.0135970333745;692.9757458488929;727.9963600182072;733.5048842031714;741.6069483173926;4701.1537923174155;4800.711957282574;4855.393075865517;4872.6832755870755;4887.877803054952;68690;72932.27067729254;73169.6341518289;73204;73319.63340183265;59943.40056599378;61272.080918786254;62646.68676656587;63441.68279158575;63547.682261588394;53873.1919021215;54444;54775.615567910405;54812;55047.174292385644;9293.767655808659;9327.347085703936;9486;9497.287703422133;9510.619575216913;38042.42936356012;39918.40122398108;40793.38809917913;41764.3735343964;41973;48596.514034859196;52064.739676301375;52782.736086319324;52931.470685292654;54071.45928540664;12697.682557936125;12699.111062225555;12855.614331570068;12879.613611591667;12890.162139460905;13712.108712933627;14142.084513738817;14315.284235788376;14505.274736263356;14560.927195363955;12578;12602.432890519765;12656.240625562496;12700.491980320683;12870.22778633285;12783.296918669563;12797.232166070065;12854.164479308814;12990.090693651353;12995.545155919497;13564.253966031964;13667.658308542366;13709;13769.173849568657;13782.310884455937;10974.670759877217;11064.28082174656;11115.83326250123;11200.719982000515;11365.715857103638;10641.414722190353;10940.343579384944;10946.45267736594;11094.667159985212;11163.776724465628 21:53:47 INFO - PROCESS | 12969 | __end_tp_report 21:53:47 INFO - PROCESS | 12969 | __start_cc_report 21:53:47 INFO - PROCESS | 12969 | _x_x_mozilla_cycle_collect,946 21:53:47 INFO - PROCESS | 12969 | __end_cc_report 21:53:47 INFO - PROCESS | 12969 | __startTimestamp1463547227576__endTimestamp 21:53:47 INFO - PROCESS | 12969 | 21:53:47 INFO - PROCESS | 12969 | ------- Summary: start ------- 21:53:47 INFO - PROCESS | 12969 | Number of tests: 6 21:53:47 INFO - PROCESS | 12969 | 21:53:47 INFO - PROCESS | 12969 | [#0] dojo.html Cycles:165 Average:5296.69 Median:5445.51 stddev:555.06 (10.2%) stddev-sans-first:532.01 21:53:47 INFO - PROCESS | 12969 | Values: 3207.4 3268.5 3296.6 3302.1 3316.7 5332.0 5340.4 5355.6 5364.7 5371.0 5363.8 5373.5 5381.3 5383.3 5389.4 4725.2 4935.5 4950.8 5026.1 5028.5 4839.3 4849.0 4890.3 4927.2 4997.1 4899.9 4921.0 4921.4 4924.0 4957.6 4729.0 4870.0 4905.9 4918.4 4921.2 4848.5 4904.8 4921.3 4926.4 4947.2 5168.1 5216.7 5222.9 5240.7 5262.5 5532.8 5634.2 5647.2 5719.6 5805.9 5610.1 5626.6 5631.5 5639.4 5652.9 5267.9 5274.4 5277.1 5278.4 5278.5 5599.1 5719.8 5724.0 5793.9 5835.9 5597.9 5611.4 5612.4 5613.7 5614.4 5623.2 5662.9 5666.4 5669.7 5672.1 5518.8 5630.8 5696.2 5723.7 5732.6 5682.5 5700.1 5703.2 5707.1 5709.8 4277.8 4412.6 4422.6 4435.8 4438.9 3943.9 3990.7 3997.9 4015.8 4024.5 5401.9 5423.6 5424.2 5434.8 5436.5 5564.9 5691.3 5701.8 5738.9 5751.7 5450.0 5473.7 5478.8 5481.3 5483.7 4922.1 4933.9 4934.8 4941.3 4947.5 5748.4 5929.7 5984.8 5989.7 6016.0 5714.1 5727.5 5728.2 5735.0 5738.0 5932.6 5935.1 5938.4 5939.4 5958.5 5350.4 5577.5 5623.3 5630.6 5676.5 5619.6 5633.0 5646.0 5653.1 5657.0 5421.6 5527.7 5533.0 5534.8 5538.2 5445.5 5458.3 5506.9 5535.7 5558.3 5384.3 5388.2 5413.4 5413.9 5421.0 5430.6 5512.8 5520.3 5549.0 5563.9 5339.3 5404.0 5415.4 5421.0 5516.3 21:53:47 INFO - PROCESS | 12969 | 21:53:47 INFO - PROCESS | 12969 | [#1] ext.html Cycles:180 Average:56637.40 Median:205009.91 stddev:109501.27 (53.4%) stddev-sans-first:109727.67 21:53:47 INFO - PROCESS | 12969 | Values: 616.0 656.4 667.2 674.4 738.9 38566.4 39555.8 39582.8 39583.6 39610.2 41280.8 41974.4 42026.4 42041.4 42062.0 8239.8 8385.4 8782.7 8957.2 10282.4 10442.6 10565.6 10575.0 10576.4 10586.6 10528.9 10587.6 10602.8 10613.7 10620.7 8471.3 10492.5 10680.4 10965.7 10975.8 10333.5 10448.4 10452.4 10458.4 10460.3 38545.8 39117.2 39199.4 39233.4 39285.4 3842.3 4003.2 4289.5 4369.2 4519.1 32695.3 33214.3 33349.8 33446.7 33519.7 4587.9 4642.0 4664.2 4675.5 4699.4 327187.0 329507.0 330075.0 330422.0 331636.0 39078.6 61920.7 63441.4 63641.4 63828.4 37424.8 37443.3 37457.6 37492.3 37618.8 17298.8 17384.4 17439.8 17493.5 17501.6 13562.3 15226.3 15633.9 15652.4 15668.7 9049.7 9110.7 9156.2 9162.1 9197.3 3450.1 3505.8 3533.2 3548.9 3586.7 1069.1 1116.5 1124.7 1171.7 1201.5 28254.6 29102.4 29296.7 29589.9 30445.0 1184.9 1202.5 1207.2 1329.1 1377.8 16134.2 16240.9 16265.3 16278.9 16394.9 370673.0 541734.0 542316.0 542464.0 542484.0 60209.7 60697.4 60949.7 60985.0 61075.0 1422.4 1429.2 1446.8 1486.9 1526.1 30648.7 32320.4 32579.0 32970.0 33598.0 52745.5 53575.7 53851.5 53893.7 53905.5 372595.0 375981.0 376403.0 377678.0 377911.0 29930.6 30698.0 30811.7 31082.2 31090.5 49197.5 50080.5 50823.7 50830.5 51427.2 40648.4 41586.6 41984.6 42526.4 42746.4 40821.0 41119.4 41376.8 41666.0 41726.8 42404.0 42954.6 43043.6 43171.6 43496.0 35249.9 36714.3 36936.3 37119.6 37609.2 28830.5 29412.9 29959.1 30051.5 30102.7 21:53:47 INFO - PROCESS | 12969 | 21:53:47 INFO - PROCESS | 12969 | [#2] jquery.html Cycles:180 Average:27445.20 Median:12420.24 stddev:71799.50 (578.1%) stddev-sans-first:71972.19 21:53:47 INFO - PROCESS | 12969 | Values: 394.2 395.1 429.2 432.2 436.5 18036.7 18475.3 19002.4 19018.3 19296.6 18984.9 19068.5 19423.7 20669.6 20675.4 5834.3 5930.4 5973.9 6013.1 6040.0 5784.1 5897.4 5907.9 5919.6 5933.8 5837.6 5853.7 5869.9 5880.6 5912.7 5720.4 5845.7 5882.1 5889.0 5903.0 5278.6 5321.6 5326.7 5327.1 5353.1 22692.5 23042.3 23251.3 23330.1 23353.3 2454.8 2578.3 2639.7 2759.8 2949.6 13918.2 14714.6 14749.1 14761.5 15307.7 1971.8 1981.9 1984.9 2032.9 2076.3 53691.0 76113.6 84811.6 85511.6 85849.1 11460.3 11538.0 11590.5 11596.8 11630.1 15864.1 15987.3 16096.7 16101.1 16110.0 8932.3 8934.5 8972.0 9025.7 9121.5 8873.8 8895.9 8979.2 9078.3 9125.4 4882.7 4941.0 4967.0 5023.1 5041.4 2041.3 2057.1 2065.1 2084.7 2147.9 1000.9 1088.7 1090.5 1158.9 1174.8 18452.9 19153.5 19499.8 19606.3 19644.8 1063.1 1066.8 1083.7 1098.2 1112.6 10789.2 10872.0 11158.2 11203.6 11296.2 379205.0 383338.0 386816.0 500152.0 500967.0 84206.0 87629.0 89363.0 89660.1 101955.0 1061.6 1100.9 1113.1 1117.9 1122.8 16607.7 16712.6 16787.1 17215.2 17635.7 37569.0 38099.0 40941.4 41357.8 42513.1 56498.2 59659.7 59685.0 59969.4 59996.7 8586.5 8650.6 8716.4 8896.8 8971.0 11836.6 12693.8 12772.0 12905.5 13236.3 11337.8 11436.0 11625.5 11670.9 11789.4 10851.1 11179.6 11321.7 11581.8 11626.8 11916.3 12117.6 12384.4 12511.4 12579.9 8566.2 8599.2 8753.0 8810.6 8896.9 11514.5 11917.7 12100.4 12115.1 12128.9 21:53:47 INFO - PROCESS | 12969 | 21:53:47 INFO - PROCESS | 12969 | [#3] mootools.html Cycles:180 Average:5390.02 Median:5036.95 stddev:2931.54 (58.2%) stddev-sans-first:2924.60 21:53:47 INFO - PROCESS | 12969 | Values: 1422.5 1556.9 1563.3 1777.7 1865.1 7716.2 7918.8 7929.4 7930.8 7936.3 7577.8 7718.3 7719.2 7720.0 7725.8 2051.5 2247.2 2251.9 2277.7 2291.1 2311.0 2324.8 2329.5 2330.7 2334.3 2230.8 2295.4 2295.6 2295.8 2299.6 2042.0 2273.4 2323.8 2324.3 2326.5 2256.5 2285.2 2296.4 2297.8 2316.8 7761.7 7827.3 7835.9 7838.2 7838.8 4841.3 4984.5 4985.2 4985.3 5020.8 3280.5 3293.3 3318.5 3337.7 3365.5 1143.2 1166.2 1184.6 1185.9 1197.8 11272.7 11310.8 11320.4 11326.2 11327.0 4217.9 4240.7 4293.5 4295.8 4349.8 9698.3 9719.0 9722.5 9730.6 9731.1 4540.5 5038.5 5039.1 5039.3 5041.1 4160.5 4160.6 4164.9 4482.8 4535.9 3743.3 3784.1 3830.5 3863.5 3864.7 1195.5 1200.8 1202.9 1210.4 1222.3 952.3 1028.7 1029.3 1044.9 1051.3 5786.7 5831.7 5852.8 5876.0 5927.3 965.5 993.2 1025.5 1030.4 1047.7 3980.6 3981.1 3983.3 4025.9 4033.2 9770.8 9963.6 10075.3 10132.1 10159.0 9766.5 9791.8 9930.0 9948.6 9958.7 7593.8 7670.5 7767.1 7770.4 7772.1 5601.6 5606.1 5623.6 5681.4 5757.7 8840.5 8946.4 9103.1 9106.9 9122.5 8714.5 8936.2 8942.4 9208.9 9218.7 6566.8 6753.1 6754.9 7252.8 7380.3 7621.3 7772.4 7782.1 7792.5 7824.5 7019.3 7265.1 7269.3 7303.9 7370.7 6717.1 6737.9 6964.5 6964.6 7046.5 6327.8 6347.2 6431.7 6448.9 6454.3 5010.8 5013.3 5035.4 5068.2 5101.9 5000.2 5010.7 5190.6 5204.6 5213.1 21:53:47 INFO - PROCESS | 12969 | 21:53:47 INFO - PROCESS | 12969 | [#4] prototype.html Cycles:180 Average:5396.03 Median:6250.52 stddev:1661.65 (26.6%) stddev-sans-first:1622.17 21:53:47 INFO - PROCESS | 12969 | Values: 327.1 332.6 334.0 335.0 336.7 6128.9 6184.9 6217.7 6222.1 6268.3 6141.4 6141.5 6144.1 6145.3 6153.5 4455.6 4557.5 4622.9 4680.4 4685.1 4646.9 4670.7 4672.0 4672.3 4676.3 4436.2 4614.4 4643.6 4644.6 4645.9 4529.8 4623.8 4626.1 4629.2 4632.3 4022.5 4032.7 4035.3 4037.2 4040.8 5893.7 5898.1 5906.2 5916.3 5928.1 5376.8 5382.3 5386.1 5388.4 5390.1 6462.6 6465.0 6466.9 6467.2 6471.5 4198.6 4268.8 4292.4 4305.5 4314.0 6660.2 6754.4 6763.4 6763.8 6770.4 4336.8 4447.2 4454.1 4474.6 4486.4 4512.4 4523.6 4526.1 4530.7 4536.0 5287.6 5295.0 5300.8 5303.3 5312.5 6521.8 6524.4 6526.7 6527.8 6535.6 1543.6 1566.9 1569.9 1571.5 1572.8 970.8 1000.9 1026.1 1047.7 1050.7 6249.8 6291.2 6303.8 6312.4 6320.4 6687.7 6689.4 6696.4 6701.5 6704.0 6301.6 6309.9 6314.6 6321.6 6324.4 3562.2 3595.1 3601.0 3604.6 3606.8 6871.8 7001.0 7014.8 7017.2 7027.8 6747.0 6778.8 6781.4 6787.2 6804.6 6989.1 6993.5 6997.4 7001.7 7009.2 6597.4 6666.9 6692.7 6697.1 6699.4 6409.8 6555.0 6556.3 6568.1 6577.3 6953.4 6959.2 6978.7 6988.2 6988.3 4446.8 4469.2 4477.1 4478.0 4486.8 6613.8 6638.3 6643.2 6643.7 6644.7 6309.8 6435.4 6473.8 6478.1 6482.4 6395.0 6422.0 6428.8 6429.8 6431.9 6333.8 6344.7 6360.7 6365.7 6366.8 6489.7 6499.1 6504.7 6506.5 6507.7 6144.0 6190.2 6251.2 6319.9 6341.3 21:53:47 INFO - PROCESS | 12969 | 21:53:47 INFO - PROCESS | 12969 | [#5] yui.html Cycles:180 Average:16053.32 Median:4639.40 stddev:19225.44 (414.4%) stddev-sans-first:19245.23 21:53:47 INFO - PROCESS | 12969 | Values: 795.5 885.4 903.0 905.8 908.4 14727.8 14832.1 14833.6 14886.8 14924.4 13623.7 13917.2 14024.9 14040.2 14065.3 752.1 888.6 891.3 901.1 911.8 907.7 909.4 909.7 911.1 911.3 944.1 949.0 950.7 950.7 950.9 792.6 809.6 810.7 937.4 939.3 696.2 697.4 697.5 698.0 698.1 13412.1 13450.5 13460.5 13464.8 13464.9 13852.2 14476.0 14827.1 14873.2 14909.7 11804.8 11854.3 11864.3 11890.1 12175.5 3986.2 3997.9 4005.3 4012.8 4089.6 56124.7 56229.4 56229.7 56271.7 56742.0 10714.9 11049.9 11084.5 11100.4 11381.5 18424.4 18436.5 18462.4 18529.3 20354.5 8503.0 8571.0 8703.0 8803.9 8841.0 4626.8 4652.0 4662.8 4748.8 4823.8 3508.6 3529.9 3573.2 3575.1 3577.7 653.1 663.4 686.1 697.8 708.8 675.4 818.8 821.4 836.4 860.3 10160.7 10327.3 10341.1 10505.7 10549.9 621.0 693.0 728.0 733.5 741.6 4701.2 4800.7 4855.4 4872.7 4887.9 68690.0 72932.3 73169.6 73204.0 73319.6 59943.4 61272.1 62646.7 63441.7 63547.7 53873.2 54444.0 54775.6 54812.0 55047.2 9293.8 9327.3 9486.0 9497.3 9510.6 38042.4 39918.4 40793.4 41764.4 41973.0 48596.5 52064.7 52782.7 52931.5 54071.5 12697.7 12699.1 12855.6 12879.6 12890.2 13712.1 14142.1 14315.3 14505.3 14560.9 12578.0 12602.4 12656.2 12700.5 12870.2 12783.3 12797.2 12854.2 12990.1 12995.5 13564.3 13667.7 13709.0 13769.2 13782.3 10974.7 11064.3 11115.8 11200.7 11365.7 10641.4 10940.3 10946.5 11094.7 11163.8 21:53:47 INFO - PROCESS | 12969 | -------- Summary: end -------- 21:53:47 INFO - PROCESS | 12969 | 21:53:48 INFO - TEST-INFO | 12969: exit 0 21:53:48 INFO - TEST-OK | dromaeo_css | took 1111129ms 21:53:48 INFO - TEST-START | kraken 21:53:48 INFO - operating with platform_type : linux_ 21:53:48 INFO - Initialising browser for kraken test... 21:53:48 INFO - TEST-INFO | started process 13154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhLSkG/profile http://localhost:35777/getInfo.html) 21:53:52 INFO - PROCESS | 13154 | __metrics Screen width/height:1600/1200 21:53:52 INFO - PROCESS | 13154 | colorDepth:24 21:53:52 INFO - PROCESS | 13154 | Browser inner width/height: 1024/697 21:53:52 INFO - PROCESS | 13154 | __metrics 21:53:53 ERROR - PROCESS | 13154 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:53:54 INFO - TEST-INFO | 13154: exit 0 21:53:54 INFO - Browser initialized. 21:53:54 INFO - Running cycle 1/1 for kraken test... 21:53:54 INFO - TEST-INFO | started process 13242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhLSkG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:06 INFO - PROCESS | 13242 | RSS: Main: 142336000 21:54:06 INFO - PROCESS | 13242 | 21:54:08 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35777/tests/kraken/driver.html?testName=audio-beat-detection) 21:54:09 INFO - PROCESS | 13242 | RSS: Main: 197107712 21:54:09 INFO - PROCESS | 13242 | 21:54:12 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35777/tests/kraken/driver.html?testName=audio-dft) 21:54:12 INFO - PROCESS | 13242 | RSS: Main: 182046720 21:54:12 INFO - PROCESS | 13242 | 21:54:15 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35777/tests/kraken/driver.html?testName=audio-fft) 21:54:16 INFO - PROCESS | 13242 | RSS: Main: 272728064 21:54:16 INFO - PROCESS | 13242 | 21:54:18 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35777/tests/kraken/driver.html?testName=audio-oscillator) 21:54:18 INFO - PROCESS | 13242 | RSS: Main: 178954240 21:54:18 INFO - PROCESS | 13242 | 21:54:20 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35777/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:54:21 INFO - PROCESS | 13242 | RSS: Main: 177405952 21:54:21 INFO - PROCESS | 13242 | 21:54:24 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35777/tests/kraken/driver.html?testName=imaging-darkroom) 21:54:25 INFO - PROCESS | 13242 | RSS: Main: 212697088 21:54:25 INFO - PROCESS | 13242 | 21:54:28 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35777/tests/kraken/driver.html?testName=imaging-desaturate) 21:54:29 INFO - PROCESS | 13242 | RSS: Main: 213241856 21:54:29 INFO - PROCESS | 13242 | 21:54:31 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35777/tests/kraken/driver.html?testName=json-parse-financial) 21:54:32 INFO - PROCESS | 13242 | RSS: Main: 212381696 21:54:32 INFO - PROCESS | 13242 | 21:54:33 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35777/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:54:34 INFO - PROCESS | 13242 | RSS: Main: 192684032 21:54:34 INFO - PROCESS | 13242 | 21:54:36 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:54:36 INFO - PROCESS | 13242 | RSS: Main: 197521408 21:54:36 INFO - PROCESS | 13242 | 21:54:38 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:54:39 INFO - PROCESS | 13242 | RSS: Main: 209678336 21:54:39 INFO - PROCESS | 13242 | 21:54:41 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:54:42 INFO - PROCESS | 13242 | RSS: Main: 213950464 21:54:42 INFO - PROCESS | 13242 | 21:54:45 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:54:45 INFO - PROCESS | 13242 | RSS: Main: 210087936 21:54:45 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35777/tests/kraken/driver.html?testName=ai-astar) 21:54:47 INFO - PROCESS | 13242 | RSS: Main: 273768448 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | __start_tp_report 21:54:47 INFO - PROCESS | 13242 | _x_x_mozilla_page_load 21:54:47 INFO - PROCESS | 13242 | _x_x_mozilla_page_load_details 21:54:47 INFO - PROCESS | 13242 | |i|pagename|runs| 21:54:47 INFO - PROCESS | 13242 | |0;ai-astar;111;110;111;110;118;111;106;110;110;109 21:54:47 INFO - PROCESS | 13242 | |1;audio-beat-detection;150;125;156;176;134;155;147;128;175;133 21:54:47 INFO - PROCESS | 13242 | |2;audio-dft;160;160;159;162;160;161;162;159;160;159 21:54:47 INFO - PROCESS | 13242 | |3;audio-fft;77;76;76;176;72;77;74;73;158;76 21:54:47 INFO - PROCESS | 13242 | |4;audio-oscillator;97;92;151;91;90;91;144;92;92;160 21:54:47 INFO - PROCESS | 13242 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;116;117;117 21:54:47 INFO - PROCESS | 13242 | |6;imaging-darkroom;146;145;145;146;146;145;145;146;145;145 21:54:47 INFO - PROCESS | 13242 | |7;imaging-desaturate;96;94;95;94;95;95;95;94;95;95 21:54:47 INFO - PROCESS | 13242 | |8;json-parse-financial;53;53;54;55;54;55;54;67;55;51 21:54:47 INFO - PROCESS | 13242 | |9;json-stringify-tinderbox;59;58;57;58;59;58;58;58;59;58 21:54:47 INFO - PROCESS | 13242 | |10;stanford-crypto-aes;74;74;80;72;73;73;73;74;74;80 21:54:47 INFO - PROCESS | 13242 | |11;stanford-crypto-ccm;122;116;114;113;111;117;114;113;127;117 21:54:47 INFO - PROCESS | 13242 | |12;stanford-crypto-pbkdf2;157;160;155;156;163;161;164;161;159;159 21:54:47 INFO - PROCESS | 13242 | |13;stanford-crypto-sha256-iterative;64;64;66;67;65;66;65;65;67;63 21:54:47 INFO - PROCESS | 13242 | __end_tp_report 21:54:47 INFO - PROCESS | 13242 | __start_cc_report 21:54:47 INFO - PROCESS | 13242 | _x_x_mozilla_cycle_collect,1613 21:54:47 INFO - PROCESS | 13242 | __end_cc_report 21:54:47 INFO - PROCESS | 13242 | __startTimestamp1463547287598__endTimestamp 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | ------- Summary: start ------- 21:54:47 INFO - PROCESS | 13242 | Number of tests: 14 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#0] ai-astar Cycles:10 Average:110.60 Median:110.50 stddev:2.99 (2.7%) stddev-sans-first:3.17 21:54:47 INFO - PROCESS | 13242 | Values: 111.0 110.0 111.0 110.0 118.0 111.0 106.0 110.0 110.0 109.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:152.50 stddev:18.20 (11.9%) stddev-sans-first:19.29 21:54:47 INFO - PROCESS | 13242 | Values: 150.0 125.0 156.0 176.0 134.0 155.0 147.0 128.0 175.0 133.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 21:54:47 INFO - PROCESS | 13242 | Values: 160.0 160.0 159.0 162.0 160.0 161.0 162.0 159.0 160.0 159.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:39.00 (51.3%) stddev-sans-first:40.91 21:54:47 INFO - PROCESS | 13242 | Values: 77.0 76.0 76.0 176.0 72.0 77.0 74.0 73.0 158.0 76.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:91.50 stddev:29.06 (31.8%) stddev-sans-first:30.44 21:54:47 INFO - PROCESS | 13242 | Values: 97.0 92.0 151.0 91.0 90.0 91.0 144.0 92.0 92.0 160.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 21:54:47 INFO - PROCESS | 13242 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 21:54:47 INFO - PROCESS | 13242 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 21:54:47 INFO - PROCESS | 13242 | Values: 96.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:4.36 (8.0%) stddev-sans-first:4.56 21:54:47 INFO - PROCESS | 13242 | Values: 53.0 53.0 54.0 55.0 54.0 55.0 54.0 67.0 55.0 51.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 21:54:47 INFO - PROCESS | 13242 | Values: 59.0 58.0 57.0 58.0 59.0 58.0 58.0 58.0 59.0 58.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.00 stddev:2.87 (3.9%) stddev-sans-first:3.03 21:54:47 INFO - PROCESS | 13242 | Values: 74.0 74.0 80.0 72.0 73.0 73.0 73.0 74.0 74.0 80.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#11] stanford-crypto-ccm Cycles:10 Average:116.40 Median:116.50 stddev:4.81 (4.1%) stddev-sans-first:4.66 21:54:47 INFO - PROCESS | 13242 | Values: 122.0 116.0 114.0 113.0 111.0 117.0 114.0 113.0 127.0 117.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:160.50 stddev:2.92 (1.8%) stddev-sans-first:2.95 21:54:47 INFO - PROCESS | 13242 | Values: 157.0 160.0 155.0 156.0 163.0 161.0 164.0 161.0 159.0 159.0 21:54:47 INFO - PROCESS | 13242 | 21:54:47 INFO - PROCESS | 13242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.32 (2.0%) stddev-sans-first:1.32 21:54:47 INFO - PROCESS | 13242 | Values: 64.0 64.0 66.0 67.0 65.0 66.0 65.0 65.0 67.0 63.0 21:54:47 INFO - PROCESS | 13242 | -------- Summary: end -------- 21:54:47 INFO - PROCESS | 13242 | 21:54:48 INFO - TEST-INFO | 13242: exit 0 21:54:48 INFO - TEST-OK | kraken | took 60275ms 21:54:48 INFO - SUITE-END | took 1171s 21:54:48 INFO - Completed test suite (00:19:31) 21:54:48 INFO - javascript benchmark 21:54:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3207.3745619604174, 3268.4770436730128, 3296.5549650797134, 3302.1249368917256, 3316.718078963288, 5332.0, 5340.412554618989, 5355.598330125246, 5364.651297665649, 5371.033214021474, 5363.758630861611, 5373.489518495747, 5381.300430943981, 5383.327084114486, 5389.380221274555, 4725.243960966246, 4935.531124543163, 4950.826721064764, 5026.095302845486, 5028.4971502849785, 4839.298301746245, 4848.975755121237, 4890.266460030988, 4927.162382394984, 4997.0505603935135, 4899.853004409873, 4920.950790492103, 4921.434035085975, 4923.950760492385, 4957.553820156185, 4729.0, 4869.975650121727, 4905.852824415273, 4918.434380046305, 4921.163402221631, 4848.490908454597, 4904.754762261909, 4921.286413470062, 4926.3842019747535, 4947.158982972904, 5168.069747445458, 5216.66091704038, 5222.895542089175, 5240.68555886648, 5262.500062494057, 5532.7786888524815, 5634.239377684001, 5647.152927060933, 5719.571032172604, 5805.941940580582, 5610.074337734269, 5626.634268772516, 5631.465010823965, 5639.379668236491, 5652.943470565324, 5267.894642107175, 5274.393444753864, 5277.102892508245, 5278.445763194886, 5278.5249327560705, 5599.1041433370465, 5719.799807006735, 5724.026915424388, 5793.913091303634, 5835.854103647443, 5597.944020559742, 5611.410801865827, 5612.382637909826, 5613.7193140342815, 5614.410486898817, 5623.184638227434, 5662.85842853932, 5666.376698563155, 5669.688167150764, 5672.149177623307, 5518.751656175482, 5630.831075067755, 5696.231008813757, 5723.713814309268, 5732.598718089777, 5682.516986056232, 5700.087985922232, 5703.17303990919, 5707.143928410688, 5709.8287051388525, 4277.786110694453, 4412.624926881187, 4422.557744225552, 4435.778211089432, 4438.866833994985, 3943.881683549498, 3990.68074554035, 3997.8600748973645, 4015.819288132041, 4024.5170579530645, 5401.891962160735, 5423.566114710814, 5424.213489044067, 5434.83695489136, 5436.537894278951, 5564.916526252109, 5691.260136182353, 5701.800436984686, 5738.913916291175, 5751.712414379264, 5450.0, 5473.7263136843, 5478.808241711601, 5481.314835645544, 5483.725813709379, 4922.138625740481, 4933.87665308363, 4934.777934992934, 4941.308216849644, 4947.480514545993, 5748.367679555246, 5929.73316200772, 5984.790532331347, 5989.700514974234, 6015.969920150459, 5714.0571805652435, 5727.455891690282, 5728.198052272768, 5735.025045742151, 5738.0, 5932.555058370725, 5935.139404786368, 5938.435848594377, 5939.406059394026, 5958.493528050164, 5350.384705758732, 5577.52591029767, 5623.297087864017, 5630.5777066720975, 5676.545876329967, 5619.550435965031, 5632.971835140962, 5646.0, 5653.067243904874, 5657.038303488334, 5421.566274697936, 5527.668339899619, 5533.00405926937, 5534.833954981357, 5538.169274608841, 5445.50990410849, 5458.344998600193, 5506.944930550803, 5535.723213839373, 5558.333000040021, 5384.326959130109, 5388.164834450667, 5413.350397952271, 5413.918791218056, 5420.972895135499, 5430.619856609999, 5512.834614961557, 5520.337559492887, 5548.9722551386985, 5563.8887222256135, 5339.252504649275, 5404.0272750905215, 5415.377231618257, 5421.0, 5516.310461192351], "value": 5262.933562654449, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.9907601385977, 656.3961155736722, 667.1893649216203, 674.419998801031, 738.9433110651772, 38566.42150367743, 39555.80222098885, 39582.80208598953, 39583.60416395835, 39610.207795844064, 41280.79359603198, 41974.37038444426, 42026.369604455955, 42041.369379459255, 42062.0, 8239.752807415787, 8385.413021088527, 8782.692605758784, 8957.238634716057, 10282.434466104361, 10442.58229670816, 10565.630202942899, 10575.0, 10576.365418074902, 10586.629467968623, 10528.894711052906, 10587.576496940113, 10602.840957385606, 10613.73465663357, 10620.681379558626, 8471.322294216448, 10492.475376231196, 10680.412577308245, 10965.725856853642, 10975.780484390347, 10333.483325833678, 10448.425336606484, 10452.37285762849, 10458.424786636731, 10460.26778125524, 38545.80727096375, 39117.217655647015, 39199.41200881989, 39233.41149882754, 39285.41071883895, 3842.269968705965, 4003.2393845169618, 4289.463817022872, 4369.2353838078525, 4519.141363141026, 32695.346093078006, 33214.335713285844, 33349.833250833835, 33446.665533344596, 33519.66480335214, 4587.9082418351445, 4642.048380082108, 4664.160451118797, 4675.509071547473, 4699.436067671867, 327187.0, 329507.0, 330075.0, 330422.0, 331636.0, 39078.6092139075, 61920.69039654863, 63441.365586344466, 63641.36358636447, 63828.36171638317, 37424.81287593599, 37443.251134977145, 37457.62542374596, 37492.25015499675, 37618.811905940296, 17298.82701172972, 17384.391546295818, 17439.82560174382, 17493.475195744148, 17501.562460938578, 13562.254076025716, 15226.314815833313, 15633.921830390775, 15652.37390504367, 15668.68662626764, 9049.683261085831, 9110.726678199664, 9156.221721153777, 9162.083791620784, 9197.310201734897, 3450.0857272822723, 3505.754597178173, 3533.169705119295, 3548.929021419557, 3586.7309951753723, 1069.1019543583427, 1116.4640972333325, 1124.707576030238, 1171.705265681427, 1201.5013769285824, 28254.576181357297, 29102.417951640848, 29296.707032929397, 29589.85205074004, 30445.0, 1184.8637406698167, 1202.4949521201117, 1207.1730864357944, 1329.0962145740796, 1377.8484366719654, 16134.193290335435, 16240.918795406184, 16265.268062936959, 16278.918605407134, 16394.918025410036, 370673.0, 541734.0, 542316.0, 542464.0, 542484.0, 60209.69895150584, 60697.39302606917, 60949.69525152435, 60985.0, 61075.0, 1422.3528294625921, 1429.2425014742203, 1446.8119144511147, 1486.873615742674, 1526.145358599188, 30648.693513064583, 32320.35359292848, 32579.02262932116, 32970.0, 33597.99206023823, 52745.47254527559, 53575.732121340705, 53851.461485386215, 53893.73053134709, 53905.46094539004, 372595.0, 375981.0, 376403.0, 377678.0, 377911.0, 29930.551041734827, 30698.0, 30811.691883080883, 31082.222944425666, 31090.53364199584, 49197.50802491929, 50080.499195007586, 50823.745881270355, 50830.49169508258, 51427.228591570405, 40648.39027414532, 41586.59842158344, 41984.58015419929, 42526.362104569074, 42746.35880461733, 40821.0, 41119.38320925129, 41376.77487306352, 41666.0, 41726.79136604298, 42404.0, 42954.57045429631, 43043.56956430521, 43171.56828431801, 43496.0, 35249.94250172499, 36714.265714685025, 36936.26127477489, 37119.628803712694, 37609.247815044095, 28830.473226709193, 29412.852935735184, 29959.101226963227, 30051.549226762054, 30102.698973010865], "value": 19792.33133807924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.221412709898, 395.0972028913931, 429.17598211434046, 432.2450849550822, 436.5481726413161, 18036.729449058243, 18475.26098956042, 19002.429927102174, 19018.334358297463, 19296.614067718638, 18984.905075474602, 19068.5232869178, 19423.708644370345, 20669.586608267862, 20675.379738607866, 5834.270716160469, 5930.406959304057, 5973.940260597404, 6013.128096426016, 6040.0, 5784.132380142991, 5897.4102589741115, 5907.940920590782, 5919.55603329752, 5933.821985340447, 5837.649741015532, 5853.707314634273, 5869.8826023479505, 5880.617759845596, 5912.733926973297, 5720.370759216483, 5845.7369418376275, 5882.088276317135, 5889.02831032879, 5903.0260007099, 5278.6041046921255, 5321.600879934021, 5326.733663316819, 5327.147656375, 5353.116735738598, 22692.54614907709, 23042.308730738103, 23251.3024609262, 23330.066797328087, 23353.299401017997, 2454.828162028659, 2578.2523068310165, 2639.736026397345, 2759.8344099354103, 2949.631296087989, 13918.234497102656, 14714.632134196623, 14749.115053096848, 14761.483348082766, 15307.693846123015, 1971.763388393402, 1981.9009049547465, 1984.8610597258198, 2032.9085191166432, 2076.252549082329, 53691.0, 76113.61943190303, 84811.57594212051, 85511.57244213801, 85849.14150858474, 11460.312381257152, 11538.0, 11590.536378544764, 11596.826047609293, 11630.127740419503, 15864.127472989096, 15987.280572374271, 16096.67806643884, 16101.114438705983, 16110.0, 8932.330075244383, 8934.463932164092, 8971.968223654363, 9025.729228123168, 9121.498317592595, 8873.778155546162, 8895.911040889509, 8979.191872731486, 9078.273738100936, 9125.361224714206, 4882.6826256293225, 4941.0, 4967.0, 5023.120953833065, 5041.445441001487, 2041.3161590866928, 2057.1257215683277, 2065.10168076884, 2084.6768750843644, 2147.9248226312316, 1000.9349392289478, 1088.6570730219955, 1090.4820210399996, 1158.9130815188894, 1174.7591743692522, 18452.89282643019, 19153.521161970784, 19499.8050019498, 19606.313779017666, 19644.803551964298, 1063.1016790811907, 1066.8346406307035, 1083.6965649618119, 1098.214776434837, 1112.5772206561455, 10789.24475286738, 10872.0, 11158.163137764537, 11203.607873724544, 11296.152788540892, 379205.0, 383338.0, 386816.0, 500152.0, 500967.0, 84206.0, 87629.0, 89363.0, 89660.10339896518, 101955.0, 1061.5594528270835, 1100.9284396514201, 1113.0761467981556, 1117.921745477825, 1122.7586068995206, 16607.66784664276, 16712.582185445463, 16787.076710781024, 17215.225314861113, 17635.735463968307, 37569.0, 38099.0, 40941.38587921243, 41357.79321103375, 42513.149737005704, 56498.15252771294, 59659.70170149121, 59685.0, 59969.40030599638, 59996.700016499635, 8586.484810911365, 8650.567471626267, 8716.38985271025, 8896.77758056028, 8970.955145224232, 11836.644900652995, 12693.8095928563, 12772.042096842959, 12905.483780648668, 13236.272005039815, 11337.773244535229, 11436.027937625395, 11625.476853541442, 11670.88329116732, 11789.351585662871, 10851.131909447384, 11179.60871369498, 11321.660350189508, 11581.768364632828, 11626.76746465083, 11916.344601047025, 12117.575884843987, 12384.380780961095, 12511.436985335864, 12579.87420125787, 8566.229039386486, 8599.183077607617, 8752.956235218782, 8810.603522841358, 8896.86654700193, 11514.481848316678, 11917.702057448632, 12100.394980250776, 12115.091368147248, 12128.939355303168], "value": 9534.977106994544, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.5447856685864, 1556.8988015778975, 1563.288703639844, 1777.7422273770303, 1865.0767869904407, 7716.189800070996, 7918.7624371268885, 7929.444938854283, 7930.801729956739, 7936.285734283913, 7577.772666820004, 7718.343940765042, 7719.228077192292, 7719.961400192991, 7725.845483090349, 2051.476873397289, 2247.2359397804744, 2251.909923603058, 2277.7038984931937, 2291.140822191678, 2310.9653355199684, 2324.8140148788057, 2329.487512747193, 2330.6853574767442, 2334.2997100869757, 2230.7546169921297, 2295.380247333219, 2295.6097463431174, 2295.8392912496133, 2299.5975704251773, 2041.9897900510477, 2273.386185729852, 2323.779240972105, 2324.3027091872373, 2326.4532834783813, 2256.537409830981, 2285.2344464604375, 2296.437372843647, 2297.793198612133, 2316.791488766019, 7761.650725717356, 7827.3346765525, 7835.921640783577, 7838.216178382173, 7838.804029899241, 4841.273808928689, 4984.451710311862, 4985.227289770091, 4985.277134815431, 5020.824271150529, 3280.5243239730107, 3293.3413317336626, 3318.502224666295, 3337.716294115003, 3365.528825964367, 1143.2340331977596, 1166.2419427372276, 1184.6090790039266, 1185.9110566707532, 1197.7903866823272, 11272.66182014541, 11310.773784524346, 11320.377379244139, 11326.20716549842, 11327.037201837853, 4217.936730949038, 4240.681948853849, 4293.549177336335, 4295.78521073945, 4349.804258808361, 9698.321117521706, 9719.0, 9722.513874306256, 9730.562124704406, 9731.124198821999, 4540.500544940054, 5038.496150385005, 5039.118154322979, 5039.344885164978, 5041.092603331363, 4160.479940007499, 4160.646345060703, 4164.875053748392, 4482.843100491533, 4535.886602834889, 3743.344914639927, 3784.0539865033743, 3830.540335159743, 3863.478430411915, 3864.71014673895, 1195.4560674892903, 1200.771853347861, 1202.8797120287902, 1210.4250481021445, 1222.2849632964637, 952.2905435450633, 1028.717102796737, 1029.3206483720708, 1044.8955104489642, 1051.348164138239, 5786.71066446676, 5831.737571809279, 5852.824415267549, 5876.030454974882, 5927.2590926134235, 965.478641533564, 993.1905497019906, 1025.4565080507193, 1030.3611760708259, 1047.7171163785888, 3980.601939805996, 3981.144054028398, 3983.3029219886403, 4025.939610905839, 4033.213523362916, 9770.755731106638, 9963.601455941825, 10075.294729368874, 10132.138768204637, 10159.034891685278, 9766.46284454362, 9791.755206119762, 9929.950350248202, 9948.552315145836, 9958.651447199314, 7593.810154746065, 7670.463067585327, 7767.067951845815, 7770.378369730408, 7772.106207786064, 5601.60788744784, 5606.103023516218, 5623.578231632562, 5681.431856814285, 5757.6545407274025, 8840.513771742359, 8946.37375383717, 9103.089691030844, 9106.863397049183, 9122.498262595622, 8714.520701361233, 8936.195742383217, 8942.418742781698, 9208.861867071866, 9218.677346292847, 6566.80299591013, 6753.088333074972, 6754.8649027020165, 7252.782416527512, 7380.335769780745, 7621.31408173267, 7772.378209743094, 7782.105057918412, 7792.532448053135, 7824.452288339761, 7019.333163349474, 7265.055542779405, 7269.3094156055095, 7303.890441643273, 7370.705171793068, 6717.05961165447, 6737.9326206737305, 6964.477664175106, 6964.582125072512, 7046.471514636525, 6327.810165695037, 6347.206599175103, 6431.742730290736, 6448.871022579616, 6454.322296159024, 5010.8246211383885, 5013.298138260573, 5035.395752509722, 5068.163752980717, 5101.9489805101475, 5000.199968005102, 5010.674306170087, 5190.636655434083, 5204.609654275869, 5213.061648903082], "value": 4411.4452557762015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.0613339715018, 332.57264415226433, 333.96326404095544, 334.9581302337208, 336.670063337929, 6128.908066379002, 6184.907226391602, 6217.689115544216, 6222.066689996497, 6268.310485846553, 6141.447269745722, 6141.508679305656, 6144.139820425144, 6145.324014358417, 6153.50771938245, 4455.598996090352, 4557.498675145731, 4622.907541849161, 4680.438347398317, 4685.109829132471, 4646.930296045562, 4670.719756814585, 4671.953280467186, 4672.299155126741, 4676.321933319684, 4436.157130145279, 4614.400127983375, 4643.628509719231, 4644.558766917155, 4645.9303110453375, 4529.750863702495, 4623.8150473981, 4626.144163329761, 4629.166749985001, 4632.305154226876, 4022.45696830927, 4032.717709760318, 4035.3341698619693, 4037.192561487714, 4040.7979601019833, 5893.705314734246, 5898.056310990221, 5906.173135760997, 5916.319623243339, 5928.140419639129, 5376.8118115865755, 5382.327209098863, 5386.084365657808, 5388.407275199725, 5390.1375779875425, 6462.579932304432, 6465.0, 6466.870662586769, 6467.223933128008, 6471.482281417522, 4198.6431153352005, 4268.829246830123, 4292.420523229386, 4305.461817272841, 4314.0, 6660.2340730816095, 6754.3921047106, 6763.391294783493, 6763.763268285636, 6770.356816102511, 4336.76147811867, 4447.155040542287, 4454.064646424287, 4474.597286244189, 4486.371907932892, 4512.390827238347, 4523.638108951276, 4526.094781043805, 4530.70550414222, 4536.047430039663, 5287.550558202596, 5295.0, 5300.787968481295, 5303.28405665238, 5312.495312945264, 6521.771737989147, 6524.445422139172, 6526.706298216497, 6527.771527996498, 6535.640539770358, 1543.5986643472777, 1566.937322507087, 1569.8901076924733, 1571.5442521668817, 1572.7798108264851, 970.7961328121032, 1000.939004655068, 1026.1431704526653, 1047.7223535763028, 1050.6795427394566, 6249.781257656051, 6291.150694656163, 6303.810885673437, 6312.400321969406, 6320.399562041599, 6687.665616719145, 6689.3611065289315, 6696.363845434676, 6701.5308928375525, 6703.966480167568, 6301.558890877686, 6309.905351419732, 6314.62112273265, 6321.55749097568, 6324.3991820776955, 3562.1628917204434, 3595.0832537702718, 3601.0097223263288, 3604.6395360463744, 3606.783592984377, 6871.759488417882, 7001.0, 7014.754483593049, 7017.193022802443, 7027.824304392431, 6747.0, 6778.762743303961, 6781.355771201728, 6787.185537735503, 6804.625745583941, 6989.0564773754895, 6993.510454268152, 6997.370236678723, 7001.684924178424, 7009.193942696553, 6597.373249541286, 6666.866662666816, 6692.665366731547, 6697.0958920547055, 6699.430548403246, 6409.807705768834, 6554.967225163844, 6556.3443655634055, 6568.14614100183, 6577.3422657733845, 6953.443724502129, 6959.234484206834, 6978.685959131953, 6988.231294557696, 6988.301169882971, 4446.82212711488, 4469.195544801837, 4477.1493416250805, 4478.0148367359125, 4486.75322857246, 6613.768518101843, 6638.302978187221, 6643.202815662152, 6643.701033453603, 6644.7009884554345, 6309.810705678837, 6435.388638079375, 6473.805785826433, 6478.125453063776, 6482.384173503509, 6395.0, 6421.967890160519, 6428.839279018062, 6429.807105786834, 6431.938730109667, 6333.778317758856, 6344.746210151542, 6360.713767880364, 6365.726854629, 6366.808995730135, 6489.707963141575, 6499.0901273820755, 6504.707288172138, 6506.512011599244, 6507.739690412331, 6143.969280153749, 6190.226221722285, 6251.249850018027, 6319.873602527831, 6341.334159913327], "value": 4845.193639538665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.4829360915404, 885.375810053912, 902.9954850225748, 905.7961958559325, 908.3913777768894, 14727.779083313759, 14832.110073395605, 14833.629159271024, 14886.77669834952, 14924.403023879046, 13623.659408514768, 13917.164970101776, 14024.859751402482, 14040.227787471686, 14065.296735163252, 752.10875112991, 888.6489836514573, 891.2602539891874, 901.0673952459206, 911.7811725185941, 907.6505545365048, 909.4452384045727, 909.7134402663173, 911.0752586125055, 911.3028533172095, 944.1455482788087, 948.9667861624845, 950.7385468996013, 950.7385468996047, 950.8716323296336, 792.63142638673, 809.5952023988006, 810.7000409848393, 937.4328531238639, 939.3424602778049, 696.2445746365199, 697.4420463629076, 697.4734075772759, 697.9581225126509, 698.1343134513218, 13412.12821166621, 13450.529231476949, 13460.461581536727, 13464.798028029587, 13464.932675336659, 13852.168869867739, 14476.0, 14827.110373377633, 14873.181974991372, 14909.70180596382, 11804.763904721944, 11854.3480108594, 11864.347460889647, 11890.108241881808, 12175.45210465531, 3986.2426139033782, 3997.9205614484217, 4005.319095753729, 4012.779297138656, 4089.591040895916, 56124.719376402856, 56229.43770562324, 56229.71885140589, 56271.718641406944, 56742.0, 10714.946425267824, 11049.889501105046, 11084.501197446134, 11100.44497775108, 11381.487833047533, 18424.447266582025, 18436.539086522946, 18462.35381761632, 18529.258829646933, 20354.491137721674, 8502.957485212659, 8570.957145214234, 8702.95648521766, 8803.867941980876, 8841.027486976427, 4626.791794369195, 4652.0, 4662.790174442158, 4748.7863046163, 4823.782929768169, 3508.6315936826777, 3529.8941031769086, 3573.1781690211396, 3575.0883524701553, 3577.713782897362, 653.0726368556661, 663.4393937123124, 686.0669489494284, 697.8081027717418, 708.7838209346199, 675.3719041291646, 818.8403261364095, 821.4167940762006, 836.4019725896013, 860.2773670117132, 10160.745981350377, 10327.32872363294, 10341.121004714532, 10505.737356566147, 10549.894501055045, 621.0135970333745, 692.9757458488929, 727.9963600182072, 733.5048842031714, 741.6069483173926, 4701.1537923174155, 4800.711957282574, 4855.393075865517, 4872.6832755870755, 4887.877803054952, 68690.0, 72932.27067729254, 73169.6341518289, 73204.0, 73319.63340183265, 59943.40056599378, 61272.080918786254, 62646.68676656587, 63441.68279158575, 63547.682261588394, 53873.1919021215, 54444.0, 54775.615567910405, 54812.0, 55047.174292385644, 9293.767655808659, 9327.347085703936, 9486.0, 9497.287703422133, 9510.619575216913, 38042.42936356012, 39918.40122398108, 40793.38809917913, 41764.3735343964, 41973.0, 48596.514034859196, 52064.739676301375, 52782.736086319324, 52931.470685292654, 54071.45928540664, 12697.682557936125, 12699.111062225555, 12855.614331570068, 12879.613611591667, 12890.162139460905, 13712.108712933627, 14142.084513738817, 14315.284235788376, 14505.274736263356, 14560.927195363955, 12578.0, 12602.432890519765, 12656.240625562496, 12700.491980320683, 12870.22778633285, 12783.296918669563, 12797.232166070065, 12854.164479308814, 12990.090693651353, 12995.545155919497, 13564.253966031964, 13667.658308542366, 13709.0, 13769.173849568657, 13782.310884455937, 10974.670759877217, 11064.28082174656, 11115.83326250123, 11200.719982000515, 11365.715857103638, 10641.414722190353, 10940.343579384944, 10946.45267736594, 11094.667159985212, 11163.776724465628], "value": 7166.348182840124, "unit": "score"}], "name": "dromaeo_css", "value": 7306.5564961468845, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 111.0, 110.0, 118.0, 111.0, 106.0, 110.0, 110.0, 109.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 156.0, 176.0, 134.0, 155.0, 147.0, 128.0, 175.0, 133.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 162.0, 160.0, 161.0, 162.0, 159.0, 160.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 176.0, 72.0, 77.0, 74.0, 73.0, 158.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 92.0, 151.0, 91.0, 90.0, 91.0, 144.0, 92.0, 92.0, 160.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 55.0, 54.0, 55.0, 54.0, 67.0, 55.0, 51.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 57.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 80.0, 72.0, 73.0, 73.0, 73.0, 74.0, 74.0, 80.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 116.0, 114.0, 113.0, 111.0, 117.0, 114.0, 113.0, 127.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 155.0, 156.0, 163.0, 161.0, 164.0, 161.0, 159.0, 159.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 67.0, 65.0, 66.0, 65.0, 65.0, 67.0, 63.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1508.6000000000001, "alertThreshold": 2.0}]} 21:54:48 INFO - Return code: 0 21:54:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:54:48 ERROR - # TBPL SUCCESS # 21:54:48 INFO - Running post-action listener: _resource_record_post_action 21:54:48 INFO - Running post-run listener: _resource_record_post_run 21:54:49 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 270336; Write bytes: 504008704; Read time: 36; Write time: 559584 21:54:49 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 255373312; Read time: 0; Write time: 406524 21:54:49 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 270336; Write bytes: 248635392; Read time: 36; Write time: 153060 21:54:49 INFO - Running post-run listener: _upload_blobber_files 21:54:49 INFO - Blob upload gear active. 21:54:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:54:49 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 21:54:49 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'] 21:54:49 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 21:54:50 INFO - (blobuploader) - INFO - Open directory for files ... 21:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:54:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:51 INFO - (blobuploader) - INFO - Done attempting. 21:54:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:54:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:54:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:51 INFO - (blobuploader) - INFO - Done attempting. 21:54:51 INFO - (blobuploader) - INFO - Iteration through files over. 21:54:51 INFO - Return code: 0 21:54:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:54:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:54:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c42d049d81b4742fd390bd4280768fe250281c312890d815a25e478c591bfaff4db422320e7479b886e1ce7e8e8d84606449b7be60ac6fc5e5df6f8dcc84c45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/425daaf672d5e0779acf796034f1d1d00324116af1db463282713601c2dfc858a2e0cc700e802494f28493441a0c2d61a81a052c39f3083bd8bc9a7daf71d531"} 21:54:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:54:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:54:51 INFO - Contents: 21:54:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c42d049d81b4742fd390bd4280768fe250281c312890d815a25e478c591bfaff4db422320e7479b886e1ce7e8e8d84606449b7be60ac6fc5e5df6f8dcc84c45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/425daaf672d5e0779acf796034f1d1d00324116af1db463282713601c2dfc858a2e0cc700e802494f28493441a0c2d61a81a052c39f3083bd8bc9a7daf71d531"} 21:54:51 INFO - Running post-run listener: copy_logs_to_upload_dir 21:54:51 INFO - Copying logs to upload dir... 21:54:51 INFO - mkdir: /builds/slave/test/build/upload/logs 21:54:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.973997 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-17 21:54:51.840947) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 21:54:51.845057) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c42d049d81b4742fd390bd4280768fe250281c312890d815a25e478c591bfaff4db422320e7479b886e1ce7e8e8d84606449b7be60ac6fc5e5df6f8dcc84c45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/425daaf672d5e0779acf796034f1d1d00324116af1db463282713601c2dfc858a2e0cc700e802494f28493441a0c2d61a81a052c39f3083bd8bc9a7daf71d531"} build_url:https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/HGVkwyj3ShuMhJrgSG4rAg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c42d049d81b4742fd390bd4280768fe250281c312890d815a25e478c591bfaff4db422320e7479b886e1ce7e8e8d84606449b7be60ac6fc5e5df6f8dcc84c45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/425daaf672d5e0779acf796034f1d1d00324116af1db463282713601c2dfc858a2e0cc700e802494f28493441a0c2d61a81a052c39f3083bd8bc9a7daf71d531"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 21:54:51.870093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:54:51.870459) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1463546060.36896-824955080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:54:51.955906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 21:54:51.956310) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 21:54:51.956714) ========= ========= Total master_lag: 0.15 =========