builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1468476116.31 results: success (0) buildid: 20160713154642 builduid: 0219f93640ac4a39933847396c8d0f21 revision: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:56.306757) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:56.307252) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:56.307543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:56.326801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:56.327216) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 23:01:56-- 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% 113M=0s 2016-07-13 23:01:56 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:56.514834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:56.515143) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019692 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:56.570521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 23:01:56.570921) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 --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-beta --rev 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 --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=78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 23:01:56,884 truncating revision to first 12 chars 2016-07-13 23:01:56,885 Setting DEBUG logging. 2016-07-13 23:01:56,885 attempt 1/10 2016-07-13 23:01:56,885 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/84c59d136a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 23:01:58,309 unpacking tar archive at: mozilla-beta-84c59d136a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.734692 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 23:01:58.319551) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:58.319895) ========= script_repo_revision: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:58.320324) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:58.320626) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:58.330077) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-13 23:01:58.330479) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:01:58 INFO - MultiFileLogger online at 20160713 23:01:58 in /builds/slave/test 23:01:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:01:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:01:58 INFO - {'append_to_log': False, 23:01:58 INFO - 'base_work_dir': '/builds/slave/test', 23:01:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:01:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:01:58 INFO - 'branch': 'Mozilla-Beta', 23:01:58 INFO - 'buildbot_json_path': 'buildprops.json', 23:01:58 INFO - 'config_files': ('talos/linux_config.py',), 23:01:58 INFO - 'default_actions': ('clobber', 23:01:58 INFO - 'read-buildbot-config', 23:01:58 INFO - 'download-and-extract', 23:01:58 INFO - 'populate-webroot', 23:01:58 INFO - 'create-virtualenv', 23:01:58 INFO - 'install', 23:01:58 INFO - 'run-tests'), 23:01:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:01:58 INFO - 'download_minidump_stackwalk': True, 23:01:58 INFO - 'download_symbols': 'ondemand', 23:01:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:01:58 INFO - 'tooltool.py': '/tools/tooltool.py', 23:01:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:01:58 INFO - '/tools/misc-python/virtualenv.py')}, 23:01:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:01:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:01:58 INFO - 'installer_path': 'installer.exe', 23:01:58 INFO - 'log_level': 'info', 23:01:58 INFO - 'log_name': 'talos', 23:01:58 INFO - 'log_to_console': True, 23:01:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:01:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:01:58 INFO - 'opt_config_files': (), 23:01:58 INFO - 'pip_index': False, 23:01:58 INFO - 'sps_profile': False, 23:01:58 INFO - 'sps_profile_interval': 0, 23:01:58 INFO - 'suite': 'dromaeojs-e10s', 23:01:58 INFO - 'system_bits': '32', 23:01:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:01:58 INFO - 'title': 'talos-linux64-ix-019', 23:01:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:01:58 INFO - 'use_talos_json': True, 23:01:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:01:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:01:58 INFO - 'work_dir': 'build'} 23:01:58 INFO - ##### 23:01:58 INFO - ##### Running clobber step. 23:01:58 INFO - ##### 23:01:58 INFO - Running pre-action listener: _resource_record_pre_action 23:01:58 INFO - Running main action method: clobber 23:01:58 INFO - rmtree: /builds/slave/test/build 23:01:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:01:59 INFO - Running post-action listener: _resource_record_post_action 23:01:59 INFO - ##### 23:01:59 INFO - ##### Running read-buildbot-config step. 23:01:59 INFO - ##### 23:01:59 INFO - Running pre-action listener: _resource_record_pre_action 23:01:59 INFO - Running main action method: read_buildbot_config 23:01:59 INFO - Using buildbot properties: 23:01:59 INFO - { 23:01:59 INFO - "project": "", 23:01:59 INFO - "product": "firefox", 23:01:59 INFO - "script_repo_revision": "production", 23:01:59 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:01:59 INFO - "repository": "", 23:01:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 23:01:59 INFO - "buildid": "20160713154642", 23:01:59 INFO - "pgo_build": "True", 23:01:59 INFO - "basedir": "/builds/slave/test", 23:01:59 INFO - "buildnumber": 99, 23:01:59 INFO - "slavename": "talos-linux64-ix-019", 23:01:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:01:59 INFO - "platform": "ubuntu64_hw", 23:01:59 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:01:59 INFO - "branch": "mozilla-beta", 23:01:59 INFO - "repo_path": "releases/mozilla-beta", 23:01:59 INFO - "revision": "84c59d136a9e54be69571b75a19e8a8ccff7b8a1", 23:01:59 INFO - "stage_platform": "linux64-pgo", 23:01:59 INFO - "builduid": "0219f93640ac4a39933847396c8d0f21", 23:01:59 INFO - "slavebuilddir": "test" 23:01:59 INFO - } 23:01:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 23:01:59 INFO - Running post-action listener: _resource_record_post_action 23:01:59 INFO - ##### 23:01:59 INFO - ##### Running download-and-extract step. 23:01:59 INFO - ##### 23:01:59 INFO - Running pre-action listener: _resource_record_pre_action 23:01:59 INFO - Running main action method: download_and_extract 23:01:59 INFO - mkdir: /builds/slave/test/build/tests 23:01:59 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')]} 23:01:59 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:01:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:01:59 INFO - Downloaded 1327 bytes. 23:01:59 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:59 INFO - Using the following test package requirements: 23:01:59 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:01:59 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:59 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:01:59 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:59 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 23:01:59 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:59 INFO - u'jsshell-linux-x86_64.zip'], 23:01:59 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:59 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:01:59 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:01:59 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:59 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 23:01:59 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:59 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 23:01:59 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:59 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:01:59 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:59 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:01:59 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:01:59 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')]} 23:01:59 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:01:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:02:00 INFO - Downloaded 24199658 bytes. 23:02:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:02:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:02:02 INFO - Return code: 0 23:02:02 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:02 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:02:03 INFO - Downloaded 24199658 bytes. 23:02:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:02:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:02:04 INFO - Return code: 0 23:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:04 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:02:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:02:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:02:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:02:05 INFO - Downloaded 10840145 bytes. 23:02:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:02:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:02:06 INFO - Return code: 0 23:02:06 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')]} 23:02:06 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:02:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:02:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:02:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:02:07 INFO - Downloaded 56027951 bytes. 23:02:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:02:07 INFO - mkdir: /builds/slave/test/properties 23:02:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:02:07 INFO - Writing to file /builds/slave/test/properties/build_url 23:02:07 INFO - Contents: 23:02:07 INFO - build_url:https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:02:08 INFO - Running post-action listener: _resource_record_post_action 23:02:08 INFO - Running post-action listener: set_extra_try_arguments 23:02:08 INFO - ##### 23:02:08 INFO - ##### Running populate-webroot step. 23:02:08 INFO - ##### 23:02:08 INFO - Running pre-action listener: _resource_record_pre_action 23:02:08 INFO - Running main action method: populate_webroot 23:02:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:02:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:02:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:02:08 INFO - '--tppagecycles', 23:02:08 INFO - '7'], 23:02:08 INFO - 'tests': ['tsvgm']}}, 23:02:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:02:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:02:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:02:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:02:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:02:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:02:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:08 INFO - 'talos_options': ['--disable-e10s'], 23:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:08 INFO - 'talos_options': ['--disable-e10s'], 23:02:08 INFO - 'tests': ['damp', 'tps']}, 23:02:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:08 INFO - 'tests': ['damp', 'tps']}, 23:02:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:02:08 INFO - 'tests': ['dromaeo_dom']}, 23:02:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:02:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:02:08 INFO - 'tests': ['a11yr', 23:02:08 INFO - 'ts_paint', 23:02:08 INFO - 'tpaint', 23:02:08 INFO - 'sessionrestore', 23:02:08 INFO - 'sessionrestore_no_auto_restore', 23:02:08 INFO - 'tabpaint']}, 23:02:08 INFO - 'other-e10s': {'tests': ['a11yr', 23:02:08 INFO - 'ts_paint', 23:02:08 INFO - 'tpaint', 23:02:08 INFO - 'sessionrestore', 23:02:08 INFO - 'sessionrestore_no_auto_restore', 23:02:08 INFO - 'tabpaint']}, 23:02:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:02:08 INFO - 'ts_paint', 23:02:08 INFO - 'tpaint', 23:02:08 INFO - 'sessionrestore', 23:02:08 INFO - 'sessionrestore_no_auto_restore', 23:02:08 INFO - 'tabpaint']}, 23:02:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:02:08 INFO - 'ts_paint', 23:02:08 INFO - 'tpaint', 23:02:08 INFO - 'sessionrestore', 23:02:08 INFO - 'sessionrestore_no_auto_restore', 23:02:08 INFO - 'tabpaint']}, 23:02:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:02:08 INFO - 'tests': ['a11yr', 23:02:08 INFO - 'ts_paint', 23:02:08 INFO - 'tpaint', 23:02:08 INFO - 'sessionrestore', 23:02:08 INFO - 'sessionrestore_no_auto_restore', 23:02:08 INFO - 'tabpaint']}, 23:02:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:02:08 INFO - 'tests': ['a11yr', 23:02:08 INFO - 'ts_paint', 23:02:08 INFO - 'tpaint', 23:02:08 INFO - 'sessionrestore', 23:02:08 INFO - 'sessionrestore_no_auto_restore', 23:02:08 INFO - 'tabpaint']}, 23:02:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:02:08 INFO - 'tests': ['tsvgx', 23:02:08 INFO - 'tsvgr_opacity', 23:02:08 INFO - 'tart', 23:02:08 INFO - 'tscrollx', 23:02:08 INFO - 'cart']}, 23:02:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:02:08 INFO - 'tsvgr_opacity', 23:02:08 INFO - 'tart', 23:02:08 INFO - 'tscrollx', 23:02:08 INFO - 'cart']}, 23:02:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:08 INFO - 'talos_options': ['--disable-e10s'], 23:02:08 INFO - 'tests': ['tp5o']}, 23:02:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:08 INFO - 'tests': ['tp5o']}, 23:02:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:08 INFO - 'talos_options': ['--disable-e10s', 23:02:08 INFO - '--xperf_path', 23:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:08 INFO - 'tests': ['tp5n']}, 23:02:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:08 INFO - 'talos_options': ['--xperf_path', 23:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:08 INFO - 'tests': ['tp5n']}}, 23:02:08 INFO - 'talos.zip': {'path': '', 23:02:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:02:08 INFO - Running post-action listener: _resource_record_post_action 23:02:08 INFO - ##### 23:02:08 INFO - ##### Running create-virtualenv step. 23:02:08 INFO - ##### 23:02:08 INFO - Running pre-action listener: _resource_record_pre_action 23:02:08 INFO - Running main action method: create_virtualenv 23:02:08 INFO - Creating virtualenv /builds/slave/test/build/venv 23:02:08 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 23:02:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:02:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:02:08 INFO - Using real prefix '/usr' 23:02:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:02:08 INFO - Installing distribute.............................................................................................................................................................................................done. 23:02:10 INFO - Installing pip.................done. 23:02:10 INFO - Return code: 0 23:02:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:10 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 0x7eff07d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2654410>, '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 0x2655310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26557a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', '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 23:02:10 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 23:02:10 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 23:02:10 INFO - Using env: {'DISPLAY': ':0', 23:02:10 INFO - 'HOME': '/home/cltbld', 23:02:10 INFO - 'LANG': 'en_US.UTF-8', 23:02:10 INFO - 'LANGUAGE': 'en_US:en', 23:02:10 INFO - 'LOGNAME': 'cltbld', 23:02:10 INFO - 'MAIL': '/var/mail/cltbld', 23:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:10 INFO - 'MOZ_NO_REMOTE': '1', 23:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:10 INFO - 'NO_EM_RESTART': '1', 23:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:10 INFO - 'PWD': '/builds/slave/test', 23:02:10 INFO - 'SHELL': '/bin/bash', 23:02:10 INFO - 'SHLVL': '1', 23:02:10 INFO - 'TERM': 'linux', 23:02:10 INFO - 'TMOUT': '86400', 23:02:10 INFO - 'USER': 'cltbld', 23:02:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', 23:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:10 INFO - '_': '/tools/buildbot/bin/python'} 23:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:10 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 23:02:10 INFO - Cleaning up... 23:02:10 INFO - Return code: 0 23:02:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:10 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 0x7eff07d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2654410>, '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 0x2655310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26557a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', '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 23:02:10 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 23:02:10 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 23:02:10 INFO - Using env: {'DISPLAY': ':0', 23:02:10 INFO - 'HOME': '/home/cltbld', 23:02:10 INFO - 'LANG': 'en_US.UTF-8', 23:02:10 INFO - 'LANGUAGE': 'en_US:en', 23:02:10 INFO - 'LOGNAME': 'cltbld', 23:02:10 INFO - 'MAIL': '/var/mail/cltbld', 23:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:10 INFO - 'MOZ_NO_REMOTE': '1', 23:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:10 INFO - 'NO_EM_RESTART': '1', 23:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:10 INFO - 'PWD': '/builds/slave/test', 23:02:10 INFO - 'SHELL': '/bin/bash', 23:02:10 INFO - 'SHLVL': '1', 23:02:10 INFO - 'TERM': 'linux', 23:02:10 INFO - 'TMOUT': '86400', 23:02:10 INFO - 'USER': 'cltbld', 23:02:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', 23:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:10 INFO - '_': '/tools/buildbot/bin/python'} 23:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:11 INFO - Downloading/unpacking psutil>=0.7.1 23:02:11 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 23:02:11 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 23:02:11 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 23:02:11 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 23:02:11 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 23:02:11 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 23:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:02:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:02:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:02:13 INFO - Installing collected packages: psutil 23:02:13 INFO - Running setup.py install for psutil 23:02:13 INFO - building 'psutil._psutil_linux' extension 23:02:13 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 23:02:13 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 23:02:13 INFO - building 'psutil._psutil_posix' extension 23:02:13 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 23:02:13 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 23:02:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:02:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:02:13 INFO - Successfully installed psutil 23:02:13 INFO - Cleaning up... 23:02:13 INFO - Return code: 0 23:02:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:13 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 0x7eff07d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2654410>, '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 0x2655310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26557a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', '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 23:02:13 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 23:02:13 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 23:02:13 INFO - Using env: {'DISPLAY': ':0', 23:02:13 INFO - 'HOME': '/home/cltbld', 23:02:13 INFO - 'LANG': 'en_US.UTF-8', 23:02:13 INFO - 'LANGUAGE': 'en_US:en', 23:02:13 INFO - 'LOGNAME': 'cltbld', 23:02:13 INFO - 'MAIL': '/var/mail/cltbld', 23:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:13 INFO - 'MOZ_NO_REMOTE': '1', 23:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:13 INFO - 'NO_EM_RESTART': '1', 23:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:13 INFO - 'PWD': '/builds/slave/test', 23:02:13 INFO - 'SHELL': '/bin/bash', 23:02:13 INFO - 'SHLVL': '1', 23:02:13 INFO - 'TERM': 'linux', 23:02:13 INFO - 'TMOUT': '86400', 23:02:13 INFO - 'USER': 'cltbld', 23:02:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', 23:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:13 INFO - '_': '/tools/buildbot/bin/python'} 23:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:02:13 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 23:02:13 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 23:02:13 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 23:02:13 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 23:02:13 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 23:02:13 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 23:02:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:02:15 INFO - Installing collected packages: mozsystemmonitor 23:02:15 INFO - Running setup.py install for mozsystemmonitor 23:02:15 INFO - Successfully installed mozsystemmonitor 23:02:15 INFO - Cleaning up... 23:02:16 INFO - Return code: 0 23:02:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:16 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 0x7eff07d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2654410>, '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 0x2655310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26557a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', '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 23:02:16 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 23:02:16 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 23:02:16 INFO - Using env: {'DISPLAY': ':0', 23:02:16 INFO - 'HOME': '/home/cltbld', 23:02:16 INFO - 'LANG': 'en_US.UTF-8', 23:02:16 INFO - 'LANGUAGE': 'en_US:en', 23:02:16 INFO - 'LOGNAME': 'cltbld', 23:02:16 INFO - 'MAIL': '/var/mail/cltbld', 23:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:16 INFO - 'MOZ_NO_REMOTE': '1', 23:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:16 INFO - 'NO_EM_RESTART': '1', 23:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:16 INFO - 'PWD': '/builds/slave/test', 23:02:16 INFO - 'SHELL': '/bin/bash', 23:02:16 INFO - 'SHLVL': '1', 23:02:16 INFO - 'TERM': 'linux', 23:02:16 INFO - 'TMOUT': '86400', 23:02:16 INFO - 'USER': 'cltbld', 23:02:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', 23:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:16 INFO - '_': '/tools/buildbot/bin/python'} 23:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:16 INFO - Downloading/unpacking blobuploader==1.2.4 23:02:16 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 23:02:16 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 23:02:16 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 23:02:16 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 23:02:16 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 23:02:16 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 23:02:18 INFO - Downloading blobuploader-1.2.4.tar.gz 23:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:02:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:02:18 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 23:02:18 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 23:02:18 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 23:02:18 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 23:02:18 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 23:02:18 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 23:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:02:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:02:18 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 23:02:18 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 23:02:18 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 23:02:18 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 23:02:18 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 23:02:18 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 23:02:18 INFO - Downloading docopt-0.6.1.tar.gz 23:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:02:18 INFO - Installing collected packages: blobuploader, requests, docopt 23:02:18 INFO - Running setup.py install for blobuploader 23:02:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:02:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:02:19 INFO - Running setup.py install for requests 23:02:19 INFO - Running setup.py install for docopt 23:02:19 INFO - Successfully installed blobuploader requests docopt 23:02:19 INFO - Cleaning up... 23:02:19 INFO - Return code: 0 23:02:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:02:19 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')]} 23:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:19 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')]} 23:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:19 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 0x7eff07d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2654410>, '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 0x2655310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26557a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', '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 23:02:19 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 23:02:19 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 23:02:19 INFO - Using env: {'DISPLAY': ':0', 23:02:19 INFO - 'HOME': '/home/cltbld', 23:02:19 INFO - 'LANG': 'en_US.UTF-8', 23:02:19 INFO - 'LANGUAGE': 'en_US:en', 23:02:19 INFO - 'LOGNAME': 'cltbld', 23:02:19 INFO - 'MAIL': '/var/mail/cltbld', 23:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:19 INFO - 'MOZ_NO_REMOTE': '1', 23:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:19 INFO - 'NO_EM_RESTART': '1', 23:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:19 INFO - 'PWD': '/builds/slave/test', 23:02:19 INFO - 'SHELL': '/bin/bash', 23:02:19 INFO - 'SHLVL': '1', 23:02:19 INFO - 'TERM': 'linux', 23:02:19 INFO - 'TMOUT': '86400', 23:02:19 INFO - 'USER': 'cltbld', 23:02:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', 23:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:19 INFO - '_': '/tools/buildbot/bin/python'} 23:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:02:19 INFO - Running setup.py (path:/tmp/pip-BAoHNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:02:19 INFO - Running setup.py (path:/tmp/pip-CAjcBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:02:19 INFO - Running setup.py (path:/tmp/pip-cirqG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:02:19 INFO - Running setup.py (path:/tmp/pip-DGJubb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:02:20 INFO - Running setup.py (path:/tmp/pip-GRi1mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:02:20 INFO - Running setup.py (path:/tmp/pip-YR7uaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:02:20 INFO - Running setup.py (path:/tmp/pip-5hxWJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:02:20 INFO - Running setup.py (path:/tmp/pip-XUFM9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:02:20 INFO - Running setup.py (path:/tmp/pip-ID8O3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:02:20 INFO - Running setup.py (path:/tmp/pip-M2w6gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:02:20 INFO - Running setup.py (path:/tmp/pip-Bh0QeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:02:20 INFO - Running setup.py (path:/tmp/pip-kauaTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:02:20 INFO - Running setup.py (path:/tmp/pip-svFDzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:02:20 INFO - Running setup.py (path:/tmp/pip-LmfHf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:02:20 INFO - Running setup.py (path:/tmp/pip-pLR2m_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:02:20 INFO - Running setup.py (path:/tmp/pip-27Nxu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:02:20 INFO - Running setup.py (path:/tmp/pip-17lZNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:02:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:02:20 INFO - Running setup.py install for manifestparser 23:02:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:02:21 INFO - Running setup.py install for mozcrash 23:02:21 INFO - Running setup.py install for mozdebug 23:02:21 INFO - Running setup.py install for mozdevice 23:02:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:02:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:02:21 INFO - Running setup.py install for mozfile 23:02:21 INFO - Running setup.py install for mozhttpd 23:02:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:02:21 INFO - Running setup.py install for mozinfo 23:02:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:02:21 INFO - Running setup.py install for mozInstall 23:02:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:02:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:02:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:02:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:02:21 INFO - Running setup.py install for mozleak 23:02:21 INFO - Running setup.py install for mozlog 23:02:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:02:22 INFO - Running setup.py install for moznetwork 23:02:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:02:22 INFO - Running setup.py install for mozprocess 23:02:22 INFO - Running setup.py install for mozprofile 23:02:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:02:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:02:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:02:22 INFO - Running setup.py install for mozrunner 23:02:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:02:22 INFO - Running setup.py install for mozscreenshot 23:02:22 INFO - Running setup.py install for moztest 23:02:22 INFO - Running setup.py install for mozversion 23:02:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:02:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:02:22 INFO - Cleaning up... 23:02:22 INFO - Return code: 0 23:02:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:02: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')]} 23:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:22 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 0x7eff07d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2654410>, '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 0x2655310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26557a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', '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 23:02:22 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 23:02:22 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 23:02:22 INFO - Using env: {'DISPLAY': ':0', 23:02:22 INFO - 'HOME': '/home/cltbld', 23:02:22 INFO - 'LANG': 'en_US.UTF-8', 23:02:22 INFO - 'LANGUAGE': 'en_US:en', 23:02:22 INFO - 'LOGNAME': 'cltbld', 23:02:22 INFO - 'MAIL': '/var/mail/cltbld', 23:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:22 INFO - 'MOZ_NO_REMOTE': '1', 23:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:22 INFO - 'NO_EM_RESTART': '1', 23:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:22 INFO - 'PWD': '/builds/slave/test', 23:02:22 INFO - 'SHELL': '/bin/bash', 23:02:22 INFO - 'SHLVL': '1', 23:02:22 INFO - 'TERM': 'linux', 23:02:22 INFO - 'TMOUT': '86400', 23:02:22 INFO - 'USER': 'cltbld', 23:02:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', 23:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:22 INFO - '_': '/tools/buildbot/bin/python'} 23:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:02:23 INFO - Running setup.py (path:/tmp/pip-juXI4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:02:23 INFO - Running setup.py (path:/tmp/pip-z2duGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:02:23 INFO - Running setup.py (path:/tmp/pip-rnujIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:02:23 INFO - Running setup.py (path:/tmp/pip-Xvd3V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:02:23 INFO - Running setup.py (path:/tmp/pip-ja0bdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:02:23 INFO - Running setup.py (path:/tmp/pip-MXUuww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:02:23 INFO - Running setup.py (path:/tmp/pip-KMebth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:02:23 INFO - Running setup.py (path:/tmp/pip-QrPDoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:02:23 INFO - Running setup.py (path:/tmp/pip-f4ZrWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:02:23 INFO - Running setup.py (path:/tmp/pip-7nNdJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:02:23 INFO - Running setup.py (path:/tmp/pip-jRlwf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:02:23 INFO - Running setup.py (path:/tmp/pip-ifK77h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:02:23 INFO - Running setup.py (path:/tmp/pip-kSIAi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:02:23 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)) 23:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:02:23 INFO - Running setup.py (path:/tmp/pip-9EUCna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:02:24 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)) 23:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:02:24 INFO - Running setup.py (path:/tmp/pip-mee9ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:02:24 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)) 23:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:02:24 INFO - Running setup.py (path:/tmp/pip-6yiP0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:02:24 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)) 23:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:02:24 INFO - Running setup.py (path:/tmp/pip-Ud7b0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:02:24 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)) 23:02:24 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)) 23:02:24 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)) 23:02:24 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)) 23:02:24 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)) 23:02:24 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)) 23:02:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:02:24 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 23:02:24 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 23:02:24 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 23:02:24 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 23:02:24 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 23:02:24 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 23:02:26 INFO - Downloading blessings-1.6.tar.gz 23:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:02:26 INFO - Installing collected packages: blessings 23:02:26 INFO - Running setup.py install for blessings 23:02:26 INFO - Successfully installed blessings 23:02:26 INFO - Cleaning up... 23:02:26 INFO - Return code: 0 23:02:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:02:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:02:26 INFO - Reading from file tmpfile_stdout 23:02:26 INFO - Current package versions: 23:02:26 INFO - argparse == 1.2.1 23:02:26 INFO - blessings == 1.6 23:02:26 INFO - blobuploader == 1.2.4 23:02:26 INFO - docopt == 0.6.1 23:02:26 INFO - manifestparser == 1.1 23:02:26 INFO - mozInstall == 1.12 23:02:26 INFO - mozcrash == 0.17 23:02:26 INFO - mozdebug == 0.1 23:02:26 INFO - mozdevice == 0.48 23:02:26 INFO - mozfile == 1.2 23:02:26 INFO - mozhttpd == 0.7 23:02:26 INFO - mozinfo == 0.9 23:02:26 INFO - mozleak == 0.1 23:02:26 INFO - mozlog == 3.1 23:02:26 INFO - moznetwork == 0.27 23:02:26 INFO - mozprocess == 0.22 23:02:26 INFO - mozprofile == 0.28 23:02:26 INFO - mozrunner == 6.11 23:02:26 INFO - mozscreenshot == 0.1 23:02:26 INFO - mozsystemmonitor == 0.0 23:02:26 INFO - moztest == 0.7 23:02:26 INFO - mozversion == 1.4 23:02:26 INFO - psutil == 3.1.1 23:02:26 INFO - requests == 1.2.3 23:02:26 INFO - wsgiref == 0.1.2 23:02:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:02:26 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')]} 23:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:26 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')]} 23:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:26 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 0x7eff07d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2654410>, '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 0x2655310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26557a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', '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 23:02:26 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 23:02:26 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 23:02:26 INFO - Using env: {'DISPLAY': ':0', 23:02:26 INFO - 'HOME': '/home/cltbld', 23:02:26 INFO - 'LANG': 'en_US.UTF-8', 23:02:26 INFO - 'LANGUAGE': 'en_US:en', 23:02:26 INFO - 'LOGNAME': 'cltbld', 23:02:26 INFO - 'MAIL': '/var/mail/cltbld', 23:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:26 INFO - 'MOZ_NO_REMOTE': '1', 23:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:26 INFO - 'NO_EM_RESTART': '1', 23:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:26 INFO - 'PWD': '/builds/slave/test', 23:02:26 INFO - 'SHELL': '/bin/bash', 23:02:26 INFO - 'SHLVL': '1', 23:02:26 INFO - 'TERM': 'linux', 23:02:26 INFO - 'TMOUT': '86400', 23:02:26 INFO - 'USER': 'cltbld', 23:02:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', 23:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:26 INFO - '_': '/tools/buildbot/bin/python'} 23:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 INFO - Cleaning up... 23:02:26 INFO - Return code: 0 23:02:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:02:26 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')]} 23:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:26 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')]} 23:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:26 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 0x7eff07d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2654410>, '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 0x2655310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26557a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', '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 23:02:26 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 23:02:26 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 23:02:26 INFO - Using env: {'DISPLAY': ':0', 23:02:26 INFO - 'HOME': '/home/cltbld', 23:02:26 INFO - 'LANG': 'en_US.UTF-8', 23:02:26 INFO - 'LANGUAGE': 'en_US:en', 23:02:26 INFO - 'LOGNAME': 'cltbld', 23:02:26 INFO - 'MAIL': '/var/mail/cltbld', 23:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:26 INFO - 'MOZ_NO_REMOTE': '1', 23:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:26 INFO - 'NO_EM_RESTART': '1', 23:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:26 INFO - 'PWD': '/builds/slave/test', 23:02:26 INFO - 'SHELL': '/bin/bash', 23:02:26 INFO - 'SHLVL': '1', 23:02:26 INFO - 'TERM': 'linux', 23:02:26 INFO - 'TMOUT': '86400', 23:02:26 INFO - 'USER': 'cltbld', 23:02:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', 23:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:26 INFO - '_': '/tools/buildbot/bin/python'} 23:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:27 INFO - Downloading/unpacking jsonschema 23:02:27 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 23:02:27 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 23:02:27 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 23:02:27 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 23:02:27 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 23:02:27 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 23:02:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:02:28 INFO - Downloading/unpacking functools32 (from jsonschema) 23:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:29 INFO - Downloading functools32-3.2.3-2.tar.gz 23:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:02:29 INFO - warning: no files found matching '*.txt' 23:02:29 INFO - no previously-included directories found matching 'build' 23:02:29 INFO - no previously-included directories found matching 'dist' 23:02:29 INFO - no previously-included directories found matching '.git*' 23:02:29 INFO - Installing collected packages: jsonschema, functools32 23:02:29 INFO - Running setup.py install for functools32 23:02:29 INFO - warning: no files found matching '*.txt' 23:02:29 INFO - no previously-included directories found matching 'build' 23:02:29 INFO - no previously-included directories found matching 'dist' 23:02:29 INFO - no previously-included directories found matching '.git*' 23:02:29 INFO - Successfully installed jsonschema functools32 23:02:29 INFO - Cleaning up... 23:02:29 INFO - Return code: 0 23:02:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:02: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')]} 23:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:29 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 0x7eff07d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2654410>, '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 0x2655310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26557a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', '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 23:02:29 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 23:02:29 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 23:02:29 INFO - Using env: {'DISPLAY': ':0', 23:02:29 INFO - 'HOME': '/home/cltbld', 23:02:29 INFO - 'LANG': 'en_US.UTF-8', 23:02:29 INFO - 'LANGUAGE': 'en_US:en', 23:02:29 INFO - 'LOGNAME': 'cltbld', 23:02:29 INFO - 'MAIL': '/var/mail/cltbld', 23:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:29 INFO - 'MOZ_NO_REMOTE': '1', 23:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:29 INFO - 'NO_EM_RESTART': '1', 23:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:29 INFO - 'PWD': '/builds/slave/test', 23:02:29 INFO - 'SHELL': '/bin/bash', 23:02:29 INFO - 'SHLVL': '1', 23:02:29 INFO - 'TERM': 'linux', 23:02:29 INFO - 'TMOUT': '86400', 23:02:29 INFO - 'USER': 'cltbld', 23:02:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', 23:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:29 INFO - '_': '/tools/buildbot/bin/python'} 23:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:29 INFO - Downloading/unpacking flake8 23:02:29 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 23:02:29 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 23:02:29 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 23:02:29 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 23:02:29 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 23:02:29 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 23:02:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:02:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:02:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:02:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:02:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:02:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:02:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:02:32 INFO - no previously-included directories found matching 'docs/_build' 23:02:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:02:32 INFO - Running setup.py install for pep8 23:02:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:02:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:02:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:02:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:02:32 INFO - no previously-included directories found matching 'docs/_build' 23:02:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:02:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:02:32 INFO - Cleaning up... 23:02:32 INFO - Return code: 0 23:02:32 INFO - Running post-action listener: _resource_record_post_action 23:02:32 INFO - Running post-action listener: _start_resource_monitoring 23:02:32 INFO - Starting resource monitoring. 23:02:32 INFO - ##### 23:02:32 INFO - ##### Running install step. 23:02:32 INFO - ##### 23:02:32 INFO - Running pre-action listener: _resource_record_pre_action 23:02:32 INFO - Running main action method: install 23:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:02:32 INFO - Reading from file tmpfile_stdout 23:02:32 INFO - Detecting whether we're running mozinstall >=1.0... 23:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:02:32 INFO - Reading from file tmpfile_stdout 23:02:32 INFO - Output received: 23:02:32 INFO - Usage: mozinstall [options] installer 23:02:32 INFO - Options: 23:02:32 INFO - -h, --help show this help message and exit 23:02:32 INFO - -d DEST, --destination=DEST 23:02:32 INFO - Directory to install application into. [default: 23:02:32 INFO - "/builds/slave/test"] 23:02:32 INFO - --app=APP Application being installed. [default: firefox] 23:02:32 INFO - mkdir: /builds/slave/test/build/application 23:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:02:46 INFO - Reading from file tmpfile_stdout 23:02:46 INFO - Output received: 23:02:46 INFO - /builds/slave/test/build/application/firefox/firefox 23:02:46 INFO - Running post-action listener: _resource_record_post_action 23:02:46 INFO - ##### 23:02:46 INFO - ##### Running run-tests step. 23:02:46 INFO - ##### 23:02:46 INFO - Running pre-action listener: _resource_record_pre_action 23:02:46 INFO - Running main action method: run_tests 23:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:02:46 INFO - Python 2.7.3 23:02:46 INFO - Return code: 0 23:02:46 INFO - grabbing minidump binary from tooltool 23:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:46 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 0x2654410>, '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 0x2655310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26557a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:02:46 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 23:02:46 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 23:02:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:02:46 INFO - Return code: 0 23:02:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:02:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:02:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:02:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:02:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:02:47 INFO - Return code: 0 23:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:02:47 INFO - Using env: {'DISPLAY': ':0', 23:02:47 INFO - 'HOME': '/home/cltbld', 23:02:47 INFO - 'LANG': 'en_US.UTF-8', 23:02:47 INFO - 'LANGUAGE': 'en_US:en', 23:02:47 INFO - 'LOGNAME': 'cltbld', 23:02:47 INFO - 'MAIL': '/var/mail/cltbld', 23:02:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:02:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:47 INFO - 'MOZ_NO_REMOTE': '1', 23:02:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:47 INFO - 'NO_EM_RESTART': '1', 23:02:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:47 INFO - 'PWD': '/builds/slave/test', 23:02:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:02:47 INFO - 'SHELL': '/bin/bash', 23:02:47 INFO - 'SHLVL': '1', 23:02:47 INFO - 'TERM': 'linux', 23:02:47 INFO - 'TMOUT': '86400', 23:02:47 INFO - 'USER': 'cltbld', 23:02:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145', 23:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:47 INFO - '_': '/tools/buildbot/bin/python'} 23:02:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:02:47 INFO - mozversion application_buildid: 20160713154642 23:02:47 INFO - mozversion application_changeset: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 23:02:47 INFO - mozversion application_display_name: Firefox 23:02:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:02:47 INFO - mozversion application_name: Firefox 23:02:47 INFO - mozversion application_remotingname: firefox 23:02:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:02:47 INFO - mozversion application_vendor: Mozilla 23:02:47 INFO - mozversion application_version: 48.0 23:02:47 INFO - mozversion platform_buildid: 20160713154642 23:02:47 INFO - mozversion platform_changeset: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 23:02:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:02:47 INFO - mozversion platform_version: 48.0 23:02:47 INFO - using testdate: 1468476167 23:02:47 INFO - actual date: 1468476167 23:02:47 INFO - starting webserver on 'localhost:50858' 23:02:47 INFO - SUITE-START | Running 2 tests 23:02:47 INFO - TEST-START | dromaeo_css 23:02:47 INFO - operating with platform_type : linux_ 23:02:47 INFO - Initialising browser for dromaeo_css test... 23:02:47 INFO - TEST-INFO | started process 30048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAXCUZn/profile http://localhost:50858/getInfo.html) 23:02:51 INFO - PROCESS | 30048 | 23:02:51 INFO - PROCESS | 30048 | (process:30124): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:02:51 INFO - PROCESS | 30048 | __metrics Screen width/height:1600/1200 23:02:51 INFO - PROCESS | 30048 | colorDepth:24 23:02:51 INFO - PROCESS | 30048 | Browser inner width/height: 1024/697 23:02:51 INFO - PROCESS | 30048 | __metrics 23:02:52 ERROR - PROCESS | 30048 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:02:53 INFO - TEST-INFO | 30048: exit 0 23:02:53 INFO - Browser initialized. 23:02:53 INFO - Running cycle 1/1 for dromaeo_css test... 23:02:53 INFO - TEST-INFO | started process 30174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAXCUZn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:02:55 INFO - PROCESS | 30174 | 23:02:55 INFO - PROCESS | 30174 | (process:30241): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:03:05 INFO - PROCESS | 30174 | RSS: Main: 150241280 23:03:05 INFO - PROCESS | 30174 | 23:03:54 INFO - PROCESS | 30174 | 1468476234876 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] 23:06:02 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50858/tests/dromaeo/cssquery-ext.html) 23:06:03 INFO - PROCESS | 30174 | RSS: Main: 155033600 23:06:03 INFO - PROCESS | 30174 | 23:09:05 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-ext.html (next: http://localhost:50858/tests/dromaeo/cssquery-jquery.html) 23:09:06 INFO - PROCESS | 30174 | RSS: Main: 152510464 23:09:06 INFO - PROCESS | 30174 | 23:12:08 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50858/tests/dromaeo/cssquery-mootools.html) 23:12:08 INFO - PROCESS | 30174 | RSS: Main: 151764992 23:12:08 INFO - PROCESS | 30174 | 23:15:10 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50858/tests/dromaeo/cssquery-prototype.html) 23:15:11 INFO - PROCESS | 30174 | RSS: Main: 152965120 23:15:11 INFO - PROCESS | 30174 | 23:18:13 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50858/tests/dromaeo/cssquery-yui.html) 23:18:13 INFO - PROCESS | 30174 | RSS: Main: 151453696 23:18:13 INFO - PROCESS | 30174 | 23:21:16 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-yui.html (next: http://localhost:50858/tests/dromaeo/cssquery-dojo.html) 23:21:16 INFO - PROCESS | 30174 | RSS: Main: 155197440 23:21:16 INFO - PROCESS | 30174 | 23:21:16 INFO - PROCESS | 30174 | __start_tp_report 23:21:16 INFO - PROCESS | 30174 | _x_x_mozilla_page_load 23:21:16 INFO - PROCESS | 30174 | _x_x_mozilla_page_load_details 23:21:16 INFO - PROCESS | 30174 | |i|pagename|runs| 23:21:16 INFO - PROCESS | 30174 | |0;dojo.html;3338.4658454647256;3369.0903456066853;3378.847951842167;3403.149212696826;3404.3361544498816;5502.394736578978;5523.696196709185;5526.143447765593;5549.833504994856;5557.944420555793;5494.2857428534335;5569.582281328896;5571.498565129148;5574;5590.357108932464;5021.472745361748;5023.824166154185;5076.695398276097;5081.923771143436;5095;5027.748612569375;5073.898522029557;5145.871353216181;5193.246979188016;5199.064168449678;5061.063703214899;5092.032513822381;5100.566451851579;5144.331236939192;5152.124138896396;5087.058894104584;5105.668131571455;5108.4125325587665;5115.590752739772;5137.897242055138;4883.4628190898975;5008.474110218411;5023.547880690719;5061.139606266944;5085.059264036166;5396.91904621431;5423.511883930465;5427.050266203399;5450.4549545045575;5457.263269458612;5857.355690874;5892.057270836688;5894.646321220741;5900.380460051676;5905.6751878646655;5772.249607550992;5923.881522369572;5947.316058653267;5954.791582294599;5986.5210783137245;5567.49892509672;5604.943950560524;5607.355154157283;5608.635438696471;5670;5984.581079324405;6039.275286965592;6055.364186760415;6061.4544690977145;6077.787277445268;5815.709214539256;5823.679697616672;5828.883422331614;5881.823545293648;5901.3213480450295;5941.881162376728;5955.76176952917;5988.730507127189;6001.609895356788;6011.3086994995265;5966.403359663999;5970.820875373745;5976.432238937294;5978.402159784074;5987.251593550806;5743.0811070228565;5798.1302804579655;5873.676947767828;5899.970500147472;5914.645121292736;4416.514183439819;4446.599806017474;4449.510553839075;4449.510553839075;4456.242438785414;3998.7800670962793;4037.051292946155;4040.5353384361174;4060.898477538085;4086.0193553546933;5626;5650.26546548946;5668.716564171775;5714.514266287412;5744.741486633112;5907.852303692442;5967.731452084667;5969.761209551656;5973.37279585646;6013.308469525973;5526.447355264441;5636.1827535008015;5697.4302569742695;5703.74333155009;5732.77068917247;5015.04714104319;5029.27075574047;5035.370578677665;5049.065922804293;5061.924071138936;6132.662703551258;6158.661273629993;6186.566940314135;6202.81391558254;6217.564770466114;5788.710564471844;5886.793962211302;5908.822735317947;5916.6154199976;5930.140129681258;6221.502279817513;6243.125962365363;6243.875122497616;6244.094606282155;6245.781397651061;5857.502112320501;5860.94139058621;5862.472377486047;5874.089516125007;5883.352831188651;5861.589688721749;5934.43622855828;5948.315943666534;6034.758609655564;6056.212692349966;5754.539636829128;5761.48146666802;5765.365809761007;5767.826965191051;5771.624844385269;5708.714564271687;5770.307563092456;5775.422457754359;5780.0173970424285;5787.392323806108;5492.5331346835965;5765.164051212467;5779;5828.358880523224;5855.8536036597725;5806.76772929095;5816.9127463088935;5819.5344372450945;5861.296644402699;5863;5507.862303442446;5706.115552089433;5724.484796368347;5736.168255602997;5753.71231438418 23:21:16 INFO - PROCESS | 30174 | |1;ext.html;605.3825098399633;663.7909058646526;668.1814776898303;674.5716470041524;676.4824908944655;40294;41284;41287.79356103215;41369.75890723279;41558.16883662325;43646.56353436465;44091.55908440923;44383.33424998628;44441.33337999933;44479.33281000787;8752.256058235042;8974.192322690957;8990.730278091667;8993.865092023625;9015.278777697802;8615.913840861605;8782.824343513126;8795.472271663688;8804.251638610694;8814.603342849556;9031.006589275174;9106.86339704905;9148.817023659523;9152.405093668924;9165.404248723846;9080.818383632324;9134.08659134088;9136.588853501575;9142.954285228532;9164.633414663405;8926.196642302224;9080.228180604656;9085.227755640779;9096.408733432372;9097.590608422637;44223.77888110571;44542.33186502205;44649;44707;44775.32837007447;3492.1618811485314;3599.190182209008;3688.5204923359793;3695.2055308108884;3770.4344348347695;33164.50253246203;33526.32947341064;33785.6621433785;33826.32347353039;34006;4538.909221815578;4660.743659098748;4685.648576356787;4692.929606055912;4696.342512048316;314042;314696;314890;316280;316800.41599792085;41061;64654.67672661607;65470.67264663742;65612.67193664097;65826.34173658202;38956.80521597374;39007;39102.41346379807;39147.21705565873;39257.80371098183;16988.405405810736;17370.739438908426;17388;17404.39084632032;17464.30142794274;13720.65698357549;13965.301734913213;13998.510052148125;14005.369758360694;14015.159090454605;9429.434233945985;9493.477858717837;9543.141117299476;9608.423494590346;9625.422474651543;3611.94582081269;3654.6477803212983;3696.796676182782;3707.1288247261873;3747.081964918558;1077.0414331245197;1109.57836022311;1133.4785998440645;1164.1850704506878;1243.6890777305673;33012.50481242783;33084.834575826964;33310.66689333124;33551.664483354856;33923.32153356968;1232.5316379775807;1285.2673975833873;1295.5400832704443;1302.8892544133664;1308.6205000549735;17122.315107395563;17207.483775486755;17219.741703874453;17280.913595431943;17466.737998930028;510644;544073;544510;874347;879105;63167;63714.36285637084;64188;64191;64450.355496444434;1567.2790516362602;1575.4485929924435;1576.8186658534187;1577.83432739563;1646.703593353208;33468.49797252994;33899.15252118717;34169.82915085508;34455.827720861234;34722.479162813084;54979;60865.391346087745;62941.68529157508;63020.36979630145;63342.36657633365;455202;458704;460606;461722;461891;46903;47407.28889066598;47608.2858757112;48051;48591;52383;53159.73420132875;53432.73283633557;53876.73061634667;53944.73027634837;43863;44159;44808;45009;45230.32154517751;42396;44385.77807110944;44394.556054440334;44983.55016449794;45038;44169.11661766683;44302.11395772002;44431.77784111188;44823.55176448194;44860.77569612131;33566.328673426884;34250;34289;34452;34626.307473849876;27281.59077613877;28916.132516024554;29023.854880725463;29122.854385727936;29298.853505732335 23:21:16 INFO - PROCESS | 30174 | |2;jquery.html;428.73632715879734;431.3400497239225;436.30191693290726;438.5745826548249;442.60165850734336;18785.62428751426;18947.62104757904;19401.805981940175;19447.61104777907;19665.803341966577;18759;19105.80894191061;19279.421617351465;19392.22431102754;19397.418077457663;5838.9124163137485;5868.178455016301;5980.5813593048615;6035.758569657209;6045.123457098718;4108.157827645326;5900.586958912878;5991.910121348184;6324;6604.636744979024;6533.836654083639;6536.248331441898;6545.116409284757;6561.704723287439;6568.7372505099975;5652.802151924683;5843.29880414353;5897.970510147465;5899.174115623816;6459.9354006460035;5563.860903477405;5707.571932105108;5743.856403589902;5753.338366087912;5779.711014449303;13869.583912482642;13913.58259252224;18063.638727225512;21732;22236.666450003264;2444.877756112205;2445.8532488050773;2473.2209354053416;2547.9108231212003;2977.3003344214094;10212.438315892623;10292.588296468133;10437.321574097736;10601.734956626146;10708;2007.688808234726;2033.542452948075;2037.1749441476227;2044.7852975437663;2070.472029632449;78645.21354786436;79467;80128;80410;81795.5910220451;11199.440027998568;11381.089512838953;11450;11604.30374177552;11611.6516504505;16152.192390380435;16160.919195403947;16213.513594592181;16274;16276.348946042026;8974.37179397449;9063.728088157366;9076.727698169065;9108.726738197865;9149.176574108229;8923.464592124494;9020.188183063556;9022.188003079755;9037.277017838556;9054.185123338932;4836.46798852126;4906.705597664151;4910.8281210157475;4929.704217746947;4932.876678083005;2010.1657812008145;2087.4781304673834;2088.958220835605;2093.842961777873;2130.9041093150845;1000.2248257600418;1075.419273592267;1127.6278827986744;1182.5624518928053;1196.2224554039944;17080.743788843178;18066;19805.900970495342;20381.184752610025;20583.485412864797;1060.6446840308429;1080.8270676691848;1130.3556972525746;1139.800534906388;1147.0536807134147;10625.84061239082;10723.14214862809;10770.192235582363;10789.19081068923;10860.402677852793;502941;503343;504081;505240;510479;89194;95838.04161958292;96426;97541;98591.50704246576;1180.079537960375;1185.0282768130223;1185.8161984892183;1189.1378750406059;1211.0190745496;16276.348946042026;16524.75212871832;16663.50009499717;16895.155242237593;16967.66064678724;39697.40453893252;39738.801305993285;40060.79969600133;40556.3916541258;40823.79588102041;59152.11271831012;59258;59303;59358.406415935286;59364;9099.090090990849;9123.589438475417;9206.987231404673;9334.25325973907;9406.764830879009;13000.934995324962;13497.32513374347;13609.659758506117;13813.585592432242;13878;11342.773144537228;11415.942920285346;11539.653810385702;11773.76452470963;12009;11855.881441185478;11923.344216067853;12024.278543287432;12275.140740148105;12309.44607492683;11695.941520292345;11794.528218871492;11896.881031189578;12080.39598020078;12194.268343899039;9082.863757043782;12117.575884843987;12675.619731408073;12960.805587916;13021.739565208833;12335.3832308386;12691.175073620185;12708.237505749685;12845.293508856728;12864.807027894776 23:21:16 INFO - PROCESS | 30174 | |3;mootools.html;1578.5658943790456;1586.3258115300998;1757.762702035225;1880.6332765110808;1911.2737159879252;7528.661210245538;8298.91701082989;8310.376721745879;8546.91453085469;8612.827743445136;8031.357491400689;8044.235797599234;8108.554029528374;8109.594520273978;8112.22933821286;2350.776676215761;2374.6556749271344;2375.869327187004;2376.2039716694926;2376.7504412036747;2366.0890557135453;2377.9881100594557;2424.5029768897334;2430.635404689293;2434.8904299306487;2314.826388020897;2327.6392159215347;2332.3352844439337;2416.4804567018177;2417.9516409671796;2369.656399822025;2374.323317854412;2392.3181893160368;2392.8444651097625;2449.8775061247043;2402.447437089479;2427.8543287402813;2434.525267572824;2435.512897420523;2444.4133407982135;8618.439801412887;8636.136386361377;8644.178803013703;8645.783855403603;8664.39349245553;5187.351581052369;5308.964751873386;5337.11937530307;5338.199270109476;5339.9733001335135;3411.942297887638;3418.1454636340914;3437.3812713711523;3503.019154636706;3518.8240587970754;1116.0736588631416;1144.2676686920377;1171.2152857585438;1181.7695549367877;1182.6629410617932;11532.884671153264;11543.88456115445;11558.768824623461;11560.248583842023;11579;4543.886402839956;4615.169269531517;4655.278431843002;4671.27595222741;4690.507496712796;9816.920138784728;9853.458059806637;9882.11061004513;9912.653057142965;9926.156276716416;5237.895242095136;5287.23335116406;5304.443033481506;5321.042212401805;5323.707196104251;4760.666753327234;4827.879303017453;4965.280034394992;4980.6513544052295;4989.750512474435;3944.723869329119;3984.163325701635;4008;4017.1764788218347;4083.224187404384;1196.3360335013977;1205.596125298035;1207.0524638159004;1213.878612138779;1244.6390546741343;825.3479750996765;986.5018165826211;1063.6011495689118;1067.3809190669392;1070.3684825952569;5662.094064949588;5828.679422631796;5837.94162058374;5886.941130588725;5927.792527261611;499.9700017998859;503.5216544282946;507.33032397235297;1119.7480566872553;1178.5933852820763;3841.4814000110186;3882.6699730523223;3924.843006279717;3942.9605703943166;4040.777757223381;10252.23108266883;10479.790404191874;10655.627053053106;10677.57289708403;10685.626003089854;10692.091172250446;10730.034296913314;10829.133669306437;10847.837282440769;10872.510737016695;8340.666373344999;8345.207205315486;8361.540115293717;8430.409871309072;8515.48907065578;5819.883602328015;5822.592418530662;5837.270341207349;5850.678212698343;5937.139114828239;9649.493979022418;9676.225901927688;9686.07982241686;9819.214462842812;9836.754081148028;9652.951735241279;9955;9957.302988790716;9970.700878973643;9980.950095249478;7571.205023472456;7614.466987311057;7763.262490063435;7763.883541746991;7783.571903545359;8056.154103819014;8057.0734365548715;8107.959460202661;8128.9593552031865;8138.470999385021;7108.537945033556;7291.744788932574;7487.812804679927;7508.399328053633;7563.697452102075;7526.924730752841;7535.73624923125;7559.811004724926;7592.772216833504;7785.455018148676;6959.3388628082275;6973.267806880407;6999.51003429755;7008.334208250208;7027.929720702932;4854.902901942012;4950.4059512858685;5023.472535383732;5044.394672639307;5094.9490505095955;5056.342675452168;5075.695458272516;5119.769610367468;5155.226715992631;5155.922661160161 23:21:16 INFO - PROCESS | 30174 | |4;prototype.html;336.6702419258729;339.7367040543577;341.1981842669726;343.2465737705734;344.31653168460605;6361.141245931798;6434.453071488929;6501.934980650192;6579.8355041124;6613.470922326221;6524.347565243474;6527.151470308865;6529.15121034266;6547.934520654792;6556.901646475307;4916.827911023115;4917.213245880651;4931.309616653672;4936.456989731127;4945.530174633404;4946.579540739023;4947.480514545975;4952.653314268003;4953.108440480712;4956.107900577895;4898.706077635354;4903.65674402792;4908.28829819676;4908.7300198489065;4932.506749325074;4826.710397376169;4898.093852637274;4916.237983112605;4921.064997650453;4932.482089380617;4224.556421575752;4250.171216612762;4270.210011147948;4290;4290.721103128318;6262.843428914268;6263.686815659199;6269.561130720851;6270.059491076329;6274;5728.713564321767;5763.452472015152;5770.971145144247;5776.249087618583;5789.710514474259;6922.06552115463;6931.514793964425;6940.13248343957;6946.3400976907615;6950.617716025617;4460.933086003713;4766.856994290177;4795.928061079087;4798.4001999750035;4807.495213002654;7175.533590316612;7189.137303523611;7230.023946767172;7262.564246145248;7262.636868156571;4741.193997020515;4761.166795810788;4764.142454358249;4766.428028636586;4795.040991801584;4829.782659780319;4841.636877234221;4842.806287748521;4844.903101937942;4848.0788650156355;5647.463490968352;5661.518770904519;5663.8867222656145;5666.15007748841;5670.121131224667;6833.453323734089;6961.721531138799;6965.79102626922;6976.860462790716;6981.476389270723;1671.699094163038;1689.0288084351548;1697.9915100424419;1698.5498842806667;1701.0559139677598;1073.3988966178965;1082.4695899009428;1102.9669109926715;1103.85098011769;1104.1663544024211;6670.332966703388;6869.656517174121;6884.347756538495;6898.758543451056;6898.827529311808;7163.032990546314;7246.818829529198;7250.673719682627;7260.455465840083;7269.491135620456;6792.490563207681;6809.080774095532;6867.313268673092;6870.519063665495;6880.518363714592;3848.5766565677754;3899.5710471848074;3910.081130934228;3916.4516967624554;3916.7258291919293;7462.626868656545;7675.194104618935;7697.114831794303;7703.1911649277135;7713.035870516185;7389.704411823467;7390.408767298603;7407.62961851916;7417.258274172647;7447.962760186273;7578.621068946641;7622.58075805836;7642.5032372895585;7673.155952845183;7688.769336919901;7097.077379940574;7203.855922881408;7237.240089790496;7246.746363877239;7303.890441643486;7119.430445564446;7158.319959603829;7190.640467976685;7193.064901562763;7193.172785129568;7644.617769111634;7652.464327497244;7656.119546252252;7666.501677390952;7673.808154796175;4743.169945259635;4781.5935645469135;4791.808327666854;4797.232442809273;4801.18379875429;6937.82655433598;7245.963770181115;7247.601381923834;7248.927510724825;7265.636718164176;6991.615461149686;7016.859662806613;7026.789196324118;7033.753818616324;7035.296470352924;6953;6988.091548098715;7003.54476958996;7008.334208250208;7041;6878.621675807879;6899.171719494439;6905.585664860125;6906.447484201352;6928.064711263914;6904.171499420102;7021.017057611836;7059.5764254144915;7077.858442831011;7084.822879428056;6732.091167692299;6798.898016529657;6818.352256535622;6830.965845170941;6874.896876546756 23:21:16 INFO - PROCESS | 30174 | |5;yui.html;825.5253229393097;861.685484798049;875.1379890807556;878.3193025405315;879.2789912271935;14529.564113076598;14852.257387130641;14894.925525372386;14910.35986041536;14938.402463901459;14103.576892693236;14146;14150.363233654485;14268;14273.71452570948;885.477568234743;894.5437826708361;903.8553831386979;905.7916679163797;918.8346097702411;878.4948654523643;913.8035322405682;918.1461241045824;919.4437365393941;919.4758987377197;915.3821170709778;961.4808003678005;963.4556475591304;964.1756298364902;966.6906589891238;910.7723069232692;946.6828612414849;949.5062567464914;952.4095061062117;952.6760901293524;666.546748211221;702.5047341624143;702.8664553734774;710.137183322266;711.3597762014177;15478.767818482731;15548.378064877392;15556.766648500281;15574;15635.765463518057;14184.43262269508;14266.857331426656;14317.42730290787;14349.928250358682;14453.205073720941;11417.716456708691;11510.884891151065;11824.822627660593;11963.521459141624;12047.819282710767;3920.8235629396745;3924.7448915820382;3988.8205030773684;4032.6773858091283;4032.9193416131807;57816.71091644557;58014;58888.411115888724;59535.70232148811;59628.70185649087;10650.840237396445;10731.89268107309;10793.136549076055;10874.67375978722;11113;20947.581048378946;20976.265830696157;21692.783072169394;22153.778462215494;22211.222607208994;8587.656493740305;8674.6096425661;8833.64665413389;8918.331125165638;8967.551622418983;4700.7179569225955;4816.253480710496;4870.756462176877;4949.529794669501;4951.702897826142;3549.7692649978185;3625.3111908737255;3625.7461977661837;3634.9818250908575;3641.708663306929;615.5906322295623;622.9408206220402;627.9372062793684;631.0597210156833;638.317000809139;717.4977515739004;727.7416517136446;738.9482736208414;743.2381808646181;749.82753966588;8944.195022448012;9444.197243234403;9469.147776699992;9471.763205919908;9536.856947145798;659.4592434203906;680.8638272345452;715.5206011971991;748.7529115391908;761.0904968562514;3944.775129000038;4087.2029954159248;4182.979085104555;4193.706440549132;4357.9564204358185;66107;67755.32244677588;68258.31741682619;68375.65812171006;68805.31194688089;57464.712676437186;57638.13542796861;57894.710526447096;58556;59086.40913590895;50131;50462.495375046514;50545;51789.741051295256;52903.73548132235;8515.148485151436;8547.956151522061;8630.913690863012;8838.602262898314;8952.462852228888;38881.6111838878;39670.404943925285;39914;41021;41658.79170604127;50346;50841.491585085154;51309.48690513047;51480.48519514757;52146.739266303426;10790.352578845295;10814.729631759268;10981.176411768989;11023.118150548098;11241.494132764208;11325.377104259345;11437.199396042197;11492.655220343404;11493.712657183303;11710.063194944554;11021.118310534977;11051.834222486508;11120.61077862271;11156.163287753614;11208.83186752183;9027.77430564215;9209.585568649562;9330.95334523323;9492.382995105296;9701.951490242503;11071.889281107407;11171.497282622138;11365.374904380338;11366.204365694322;11486.36824974601;9265.907340926775;9436.480993545421;9496;9894.356866803922;10039.648612298535;9808.509574521388;10112.898871011195;10172.84740728875;10173.23700722434;10234.692959211236 23:21:16 INFO - PROCESS | 30174 | __end_tp_report 23:21:16 INFO - PROCESS | 30174 | __start_cc_report 23:21:16 INFO - PROCESS | 30174 | _x_x_mozilla_cycle_collect,318 23:21:16 INFO - PROCESS | 30174 | __end_cc_report 23:21:16 INFO - PROCESS | 30174 | __startTimestamp1468477276291__endTimestamp 23:21:16 INFO - PROCESS | 30174 | 23:21:16 INFO - PROCESS | 30174 | ------- Summary: start ------- 23:21:16 INFO - PROCESS | 30174 | Number of tests: 6 23:21:16 INFO - PROCESS | 30174 | 23:21:16 INFO - PROCESS | 30174 | [#0] dojo.html Cycles:165 Average:5521.28 Median:5753.71 stddev:613.70 (10.7%) stddev-sans-first:591.21 23:21:16 INFO - PROCESS | 30174 | Values: 3338.5 3369.1 3378.8 3403.1 3404.3 5502.4 5523.7 5526.1 5549.8 5557.9 5494.3 5569.6 5571.5 5574.0 5590.4 5021.5 5023.8 5076.7 5081.9 5095.0 5027.7 5073.9 5145.9 5193.2 5199.1 5061.1 5092.0 5100.6 5144.3 5152.1 5087.1 5105.7 5108.4 5115.6 5137.9 4883.5 5008.5 5023.5 5061.1 5085.1 5396.9 5423.5 5427.1 5450.5 5457.3 5857.4 5892.1 5894.6 5900.4 5905.7 5772.2 5923.9 5947.3 5954.8 5986.5 5567.5 5604.9 5607.4 5608.6 5670.0 5984.6 6039.3 6055.4 6061.5 6077.8 5815.7 5823.7 5828.9 5881.8 5901.3 5941.9 5955.8 5988.7 6001.6 6011.3 5966.4 5970.8 5976.4 5978.4 5987.3 5743.1 5798.1 5873.7 5900.0 5914.6 4416.5 4446.6 4449.5 4449.5 4456.2 3998.8 4037.1 4040.5 4060.9 4086.0 5626.0 5650.3 5668.7 5714.5 5744.7 5907.9 5967.7 5969.8 5973.4 6013.3 5526.4 5636.2 5697.4 5703.7 5732.8 5015.0 5029.3 5035.4 5049.1 5061.9 6132.7 6158.7 6186.6 6202.8 6217.6 5788.7 5886.8 5908.8 5916.6 5930.1 6221.5 6243.1 6243.9 6244.1 6245.8 5857.5 5860.9 5862.5 5874.1 5883.4 5861.6 5934.4 5948.3 6034.8 6056.2 5754.5 5761.5 5765.4 5767.8 5771.6 5708.7 5770.3 5775.4 5780.0 5787.4 5492.5 5765.2 5779.0 5828.4 5855.9 5806.8 5816.9 5819.5 5861.3 5863.0 5507.9 5706.1 5724.5 5736.2 5753.7 23:21:16 INFO - PROCESS | 30174 | 23:21:16 INFO - PROCESS | 30174 | [#1] ext.html Cycles:180 Average:64399.32 Median:44390.17 stddev:137421.49 (309.6%) stddev-sans-first:137723.52 23:21:16 INFO - PROCESS | 30174 | Values: 605.4 663.8 668.2 674.6 676.5 40294.0 41284.0 41287.8 41369.8 41558.2 43646.6 44091.6 44383.3 44441.3 44479.3 8752.3 8974.2 8990.7 8993.9 9015.3 8615.9 8782.8 8795.5 8804.3 8814.6 9031.0 9106.9 9148.8 9152.4 9165.4 9080.8 9134.1 9136.6 9143.0 9164.6 8926.2 9080.2 9085.2 9096.4 9097.6 44223.8 44542.3 44649.0 44707.0 44775.3 3492.2 3599.2 3688.5 3695.2 3770.4 33164.5 33526.3 33785.7 33826.3 34006.0 4538.9 4660.7 4685.6 4692.9 4696.3 314042.0 314696.0 314890.0 316280.0 316800.4 41061.0 64654.7 65470.7 65612.7 65826.3 38956.8 39007.0 39102.4 39147.2 39257.8 16988.4 17370.7 17388.0 17404.4 17464.3 13720.7 13965.3 13998.5 14005.4 14015.2 9429.4 9493.5 9543.1 9608.4 9625.4 3611.9 3654.6 3696.8 3707.1 3747.1 1077.0 1109.6 1133.5 1164.2 1243.7 33012.5 33084.8 33310.7 33551.7 33923.3 1232.5 1285.3 1295.5 1302.9 1308.6 17122.3 17207.5 17219.7 17280.9 17466.7 510644.0 544073.0 544510.0 874347.0 879105.0 63167.0 63714.4 64188.0 64191.0 64450.4 1567.3 1575.4 1576.8 1577.8 1646.7 33468.5 33899.2 34169.8 34455.8 34722.5 54979.0 60865.4 62941.7 63020.4 63342.4 455202.0 458704.0 460606.0 461722.0 461891.0 46903.0 47407.3 47608.3 48051.0 48591.0 52383.0 53159.7 53432.7 53876.7 53944.7 43863.0 44159.0 44808.0 45009.0 45230.3 42396.0 44385.8 44394.6 44983.6 45038.0 44169.1 44302.1 44431.8 44823.6 44860.8 33566.3 34250.0 34289.0 34452.0 34626.3 27281.6 28916.1 29023.9 29122.9 29298.9 23:21:16 INFO - PROCESS | 30174 | 23:21:16 INFO - PROCESS | 30174 | [#2] jquery.html Cycles:180 Average:29666.00 Median:11314.14 stddev:83226.85 (735.6%) stddev-sans-first:83431.37 23:21:16 INFO - PROCESS | 30174 | Values: 428.7 431.3 436.3 438.6 442.6 18785.6 18947.6 19401.8 19447.6 19665.8 18759.0 19105.8 19279.4 19392.2 19397.4 5838.9 5868.2 5980.6 6035.8 6045.1 4108.2 5900.6 5991.9 6324.0 6604.6 6533.8 6536.2 6545.1 6561.7 6568.7 5652.8 5843.3 5898.0 5899.2 6459.9 5563.9 5707.6 5743.9 5753.3 5779.7 13869.6 13913.6 18063.6 21732.0 22236.7 2444.9 2445.9 2473.2 2547.9 2977.3 10212.4 10292.6 10437.3 10601.7 10708.0 2007.7 2033.5 2037.2 2044.8 2070.5 78645.2 79467.0 80128.0 80410.0 81795.6 11199.4 11381.1 11450.0 11604.3 11611.7 16152.2 16160.9 16213.5 16274.0 16276.3 8974.4 9063.7 9076.7 9108.7 9149.2 8923.5 9020.2 9022.2 9037.3 9054.2 4836.5 4906.7 4910.8 4929.7 4932.9 2010.2 2087.5 2089.0 2093.8 2130.9 1000.2 1075.4 1127.6 1182.6 1196.2 17080.7 18066.0 19805.9 20381.2 20583.5 1060.6 1080.8 1130.4 1139.8 1147.1 10625.8 10723.1 10770.2 10789.2 10860.4 502941.0 503343.0 504081.0 505240.0 510479.0 89194.0 95838.0 96426.0 97541.0 98591.5 1180.1 1185.0 1185.8 1189.1 1211.0 16276.3 16524.8 16663.5 16895.2 16967.7 39697.4 39738.8 40060.8 40556.4 40823.8 59152.1 59258.0 59303.0 59358.4 59364.0 9099.1 9123.6 9207.0 9334.3 9406.8 13000.9 13497.3 13609.7 13813.6 13878.0 11342.8 11415.9 11539.7 11773.8 12009.0 11855.9 11923.3 12024.3 12275.1 12309.4 11695.9 11794.5 11896.9 12080.4 12194.3 9082.9 12117.6 12675.6 12960.8 13021.7 12335.4 12691.2 12708.2 12845.3 12864.8 23:21:16 INFO - PROCESS | 30174 | 23:21:16 INFO - PROCESS | 30174 | [#3] mootools.html Cycles:180 Average:5687.24 Median:5050.37 stddev:3140.96 (62.2%) stddev-sans-first:3134.59 23:21:16 INFO - PROCESS | 30174 | Values: 1578.6 1586.3 1757.8 1880.6 1911.3 7528.7 8298.9 8310.4 8546.9 8612.8 8031.4 8044.2 8108.6 8109.6 8112.2 2350.8 2374.7 2375.9 2376.2 2376.8 2366.1 2378.0 2424.5 2430.6 2434.9 2314.8 2327.6 2332.3 2416.5 2418.0 2369.7 2374.3 2392.3 2392.8 2449.9 2402.4 2427.9 2434.5 2435.5 2444.4 8618.4 8636.1 8644.2 8645.8 8664.4 5187.4 5309.0 5337.1 5338.2 5340.0 3411.9 3418.1 3437.4 3503.0 3518.8 1116.1 1144.3 1171.2 1181.8 1182.7 11532.9 11543.9 11558.8 11560.2 11579.0 4543.9 4615.2 4655.3 4671.3 4690.5 9816.9 9853.5 9882.1 9912.7 9926.2 5237.9 5287.2 5304.4 5321.0 5323.7 4760.7 4827.9 4965.3 4980.7 4989.8 3944.7 3984.2 4008.0 4017.2 4083.2 1196.3 1205.6 1207.1 1213.9 1244.6 825.3 986.5 1063.6 1067.4 1070.4 5662.1 5828.7 5837.9 5886.9 5927.8 500.0 503.5 507.3 1119.7 1178.6 3841.5 3882.7 3924.8 3943.0 4040.8 10252.2 10479.8 10655.6 10677.6 10685.6 10692.1 10730.0 10829.1 10847.8 10872.5 8340.7 8345.2 8361.5 8430.4 8515.5 5819.9 5822.6 5837.3 5850.7 5937.1 9649.5 9676.2 9686.1 9819.2 9836.8 9653.0 9955.0 9957.3 9970.7 9981.0 7571.2 7614.5 7763.3 7763.9 7783.6 8056.2 8057.1 8108.0 8129.0 8138.5 7108.5 7291.7 7487.8 7508.4 7563.7 7526.9 7535.7 7559.8 7592.8 7785.5 6959.3 6973.3 6999.5 7008.3 7027.9 4854.9 4950.4 5023.5 5044.4 5094.9 5056.3 5075.7 5119.8 5155.2 5155.9 23:21:16 INFO - PROCESS | 30174 | 23:21:16 INFO - PROCESS | 30174 | [#4] prototype.html Cycles:180 Average:5821.14 Median:6701.21 stddev:1812.77 (27.1%) stddev-sans-first:1770.49 23:21:16 INFO - PROCESS | 30174 | Values: 336.7 339.7 341.2 343.2 344.3 6361.1 6434.5 6501.9 6579.8 6613.5 6524.3 6527.2 6529.2 6547.9 6556.9 4916.8 4917.2 4931.3 4936.5 4945.5 4946.6 4947.5 4952.7 4953.1 4956.1 4898.7 4903.7 4908.3 4908.7 4932.5 4826.7 4898.1 4916.2 4921.1 4932.5 4224.6 4250.2 4270.2 4290.0 4290.7 6262.8 6263.7 6269.6 6270.1 6274.0 5728.7 5763.5 5771.0 5776.2 5789.7 6922.1 6931.5 6940.1 6946.3 6950.6 4460.9 4766.9 4795.9 4798.4 4807.5 7175.5 7189.1 7230.0 7262.6 7262.6 4741.2 4761.2 4764.1 4766.4 4795.0 4829.8 4841.6 4842.8 4844.9 4848.1 5647.5 5661.5 5663.9 5666.2 5670.1 6833.5 6961.7 6965.8 6976.9 6981.5 1671.7 1689.0 1698.0 1698.5 1701.1 1073.4 1082.5 1103.0 1103.9 1104.2 6670.3 6869.7 6884.3 6898.8 6898.8 7163.0 7246.8 7250.7 7260.5 7269.5 6792.5 6809.1 6867.3 6870.5 6880.5 3848.6 3899.6 3910.1 3916.5 3916.7 7462.6 7675.2 7697.1 7703.2 7713.0 7389.7 7390.4 7407.6 7417.3 7448.0 7578.6 7622.6 7642.5 7673.2 7688.8 7097.1 7203.9 7237.2 7246.7 7303.9 7119.4 7158.3 7190.6 7193.1 7193.2 7644.6 7652.5 7656.1 7666.5 7673.8 4743.2 4781.6 4791.8 4797.2 4801.2 6937.8 7246.0 7247.6 7248.9 7265.6 6991.6 7016.9 7026.8 7033.8 7035.3 6953.0 6988.1 7003.5 7008.3 7041.0 6878.6 6899.2 6905.6 6906.4 6928.1 6904.2 7021.0 7059.6 7077.9 7084.8 6732.1 6798.9 6818.4 6831.0 6874.9 23:21:16 INFO - PROCESS | 30174 | 23:21:16 INFO - PROCESS | 30174 | [#5] yui.html Cycles:180 Average:15422.76 Median:51394.99 stddev:18635.89 (36.3%) stddev-sans-first:18655.93 23:21:16 INFO - PROCESS | 30174 | Values: 825.5 861.7 875.1 878.3 879.3 14529.6 14852.3 14894.9 14910.4 14938.4 14103.6 14146.0 14150.4 14268.0 14273.7 885.5 894.5 903.9 905.8 918.8 878.5 913.8 918.1 919.4 919.5 915.4 961.5 963.5 964.2 966.7 910.8 946.7 949.5 952.4 952.7 666.5 702.5 702.9 710.1 711.4 15478.8 15548.4 15556.8 15574.0 15635.8 14184.4 14266.9 14317.4 14349.9 14453.2 11417.7 11510.9 11824.8 11963.5 12047.8 3920.8 3924.7 3988.8 4032.7 4032.9 57816.7 58014.0 58888.4 59535.7 59628.7 10650.8 10731.9 10793.1 10874.7 11113.0 20947.6 20976.3 21692.8 22153.8 22211.2 8587.7 8674.6 8833.6 8918.3 8967.6 4700.7 4816.3 4870.8 4949.5 4951.7 3549.8 3625.3 3625.7 3635.0 3641.7 615.6 622.9 627.9 631.1 638.3 717.5 727.7 738.9 743.2 749.8 8944.2 9444.2 9469.1 9471.8 9536.9 659.5 680.9 715.5 748.8 761.1 3944.8 4087.2 4183.0 4193.7 4358.0 66107.0 67755.3 68258.3 68375.7 68805.3 57464.7 57638.1 57894.7 58556.0 59086.4 50131.0 50462.5 50545.0 51789.7 52903.7 8515.1 8548.0 8630.9 8838.6 8952.5 38881.6 39670.4 39914.0 41021.0 41658.8 50346.0 50841.5 51309.5 51480.5 52146.7 10790.4 10814.7 10981.2 11023.1 11241.5 11325.4 11437.2 11492.7 11493.7 11710.1 11021.1 11051.8 11120.6 11156.2 11208.8 9027.8 9209.6 9331.0 9492.4 9702.0 11071.9 11171.5 11365.4 11366.2 11486.4 9265.9 9436.5 9496.0 9894.4 10039.6 9808.5 10112.9 10172.8 10173.2 10234.7 23:21:16 INFO - PROCESS | 30174 | -------- Summary: end -------- 23:21:16 INFO - PROCESS | 30174 | 23:21:16 INFO - TEST-INFO | 30174: exit 0 23:21:17 INFO - TEST-OK | dromaeo_css | took 1109708ms 23:21:17 INFO - TEST-START | kraken 23:21:17 INFO - operating with platform_type : linux_ 23:21:17 INFO - Initialising browser for kraken test... 23:21:17 INFO - TEST-INFO | started process 30415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBJnRn8/profile http://localhost:50858/getInfo.html) 23:21:20 INFO - PROCESS | 30415 | 23:21:20 INFO - PROCESS | 30415 | (process:30495): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:21:21 INFO - PROCESS | 30415 | __metrics Screen width/height:1600/1200 23:21:21 INFO - PROCESS | 30415 | colorDepth:24 23:21:21 INFO - PROCESS | 30415 | Browser inner width/height: 1024/697 23:21:21 INFO - PROCESS | 30415 | __metrics 23:21:22 ERROR - PROCESS | 30415 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:21:23 INFO - TEST-INFO | 30415: exit 0 23:21:23 INFO - Browser initialized. 23:21:23 INFO - Running cycle 1/1 for kraken test... 23:21:23 INFO - TEST-INFO | started process 30545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBJnRn8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:21:25 INFO - PROCESS | 30545 | 23:21:25 INFO - PROCESS | 30545 | (process:30614): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:21:35 INFO - PROCESS | 30545 | RSS: Main: 151199744 23:21:35 INFO - PROCESS | 30545 | 23:21:37 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50858/tests/kraken/driver.html?testName=audio-beat-detection) 23:21:38 INFO - PROCESS | 30545 | RSS: Main: 156651520 23:21:38 INFO - PROCESS | 30545 | 23:21:41 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50858/tests/kraken/driver.html?testName=audio-dft) 23:21:41 INFO - PROCESS | 30545 | RSS: Main: 156467200 23:21:41 INFO - PROCESS | 30545 | 23:21:44 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50858/tests/kraken/driver.html?testName=audio-fft) 23:21:45 INFO - PROCESS | 30545 | RSS: Main: 156704768 23:21:45 INFO - PROCESS | 30545 | 23:21:47 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50858/tests/kraken/driver.html?testName=audio-oscillator) 23:21:47 INFO - PROCESS | 30545 | RSS: Main: 156401664 23:21:47 INFO - PROCESS | 30545 | 23:21:49 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:21:50 INFO - PROCESS | 30545 | RSS: Main: 156196864 23:21:50 INFO - PROCESS | 30545 | 23:21:53 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50858/tests/kraken/driver.html?testName=imaging-darkroom) 23:21:54 INFO - PROCESS | 30545 | RSS: Main: 156655616 23:21:54 INFO - PROCESS | 30545 | 23:21:57 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50858/tests/kraken/driver.html?testName=imaging-desaturate) 23:21:58 INFO - PROCESS | 30545 | RSS: Main: 156721152 23:21:58 INFO - PROCESS | 30545 | 23:22:00 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50858/tests/kraken/driver.html?testName=json-parse-financial) 23:22:01 INFO - PROCESS | 30545 | RSS: Main: 156360704 23:22:01 INFO - PROCESS | 30545 | 23:22:03 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:22:03 INFO - PROCESS | 30545 | RSS: Main: 156225536 23:22:03 INFO - PROCESS | 30545 | 23:22:05 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:22:06 INFO - PROCESS | 30545 | RSS: Main: 156573696 23:22:06 INFO - PROCESS | 30545 | 23:22:08 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:22:08 INFO - PROCESS | 30545 | RSS: Main: 156991488 23:22:08 INFO - PROCESS | 30545 | 23:22:11 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:22:11 INFO - PROCESS | 30545 | RSS: Main: 157278208 23:22:11 INFO - PROCESS | 30545 | 23:22:14 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:22:15 INFO - PROCESS | 30545 | RSS: Main: 157257728 23:22:15 INFO - PROCESS | 30545 | 23:22:16 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50858/tests/kraken/driver.html?testName=ai-astar) 23:22:17 INFO - PROCESS | 30545 | RSS: Main: 158117888 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | __start_tp_report 23:22:17 INFO - PROCESS | 30545 | _x_x_mozilla_page_load 23:22:17 INFO - PROCESS | 30545 | _x_x_mozilla_page_load_details 23:22:17 INFO - PROCESS | 30545 | |i|pagename|runs| 23:22:17 INFO - PROCESS | 30545 | |0;ai-astar;109;114;105;111;114;113;102;109;111;111 23:22:17 INFO - PROCESS | 30545 | |1;audio-beat-detection;156;130;159;177;136;156;156;128;183;128 23:22:17 INFO - PROCESS | 30545 | |2;audio-dft;162;164;161;162;162;161;163;163;161;162 23:22:17 INFO - PROCESS | 30545 | |3;audio-fft;75;77;77;180;74;76;74;77;170;76 23:22:17 INFO - PROCESS | 30545 | |4;audio-oscillator;94;92;154;92;93;92;149;93;93;142 23:22:17 INFO - PROCESS | 30545 | |5;imaging-gaussian-blur;117;117;117;118;117;116;118;117;118;117 23:22:17 INFO - PROCESS | 30545 | |6;imaging-darkroom;146;146;146;145;147;146;148;146;148;147 23:22:17 INFO - PROCESS | 30545 | |7;imaging-desaturate;96;94;96;96;95;95;95;95;95;95 23:22:17 INFO - PROCESS | 30545 | |8;json-parse-financial;61;56;61;57;58;61;58;81;58;56 23:22:17 INFO - PROCESS | 30545 | |9;json-stringify-tinderbox;60;61;61;61;61;60;59;60;61;60 23:22:17 INFO - PROCESS | 30545 | |10;stanford-crypto-aes;72;73;73;75;75;85;75;73;75;75 23:22:17 INFO - PROCESS | 30545 | |11;stanford-crypto-ccm;117;114;122;124;115;113;114;115;135;129 23:22:17 INFO - PROCESS | 30545 | |12;stanford-crypto-pbkdf2;164;160;161;162;162;163;161;166;165;159 23:22:17 INFO - PROCESS | 30545 | |13;stanford-crypto-sha256-iterative;69;67;69;68;69;69;68;66;67;67 23:22:17 INFO - PROCESS | 30545 | __end_tp_report 23:22:17 INFO - PROCESS | 30545 | __start_cc_report 23:22:17 INFO - PROCESS | 30545 | _x_x_mozilla_cycle_collect,830 23:22:17 INFO - PROCESS | 30545 | __end_cc_report 23:22:17 INFO - PROCESS | 30545 | __startTimestamp1468477337054__endTimestamp 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | ------- Summary: start ------- 23:22:17 INFO - PROCESS | 30545 | Number of tests: 14 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.87 (3.5%) stddev-sans-first:4.09 23:22:17 INFO - PROCESS | 30545 | Values: 109.0 114.0 105.0 111.0 114.0 113.0 102.0 109.0 111.0 111.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:156.00 stddev:19.90 (12.8%) stddev-sans-first:21.02 23:22:17 INFO - PROCESS | 30545 | Values: 156.0 130.0 159.0 177.0 136.0 156.0 156.0 128.0 183.0 128.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 23:22:17 INFO - PROCESS | 30545 | Values: 162.0 164.0 161.0 162.0 162.0 161.0 163.0 163.0 161.0 162.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:41.93 (55.2%) stddev-sans-first:43.80 23:22:17 INFO - PROCESS | 30545 | Values: 75.0 77.0 77.0 180.0 74.0 76.0 74.0 77.0 170.0 76.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.50 stddev:27.02 (29.2%) stddev-sans-first:28.08 23:22:17 INFO - PROCESS | 30545 | Values: 94.0 92.0 154.0 92.0 93.0 92.0 149.0 93.0 93.0 142.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 23:22:17 INFO - PROCESS | 30545 | Values: 117.0 117.0 117.0 118.0 117.0 116.0 118.0 117.0 118.0 117.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 23:22:17 INFO - PROCESS | 30545 | Values: 146.0 146.0 146.0 145.0 147.0 146.0 148.0 146.0 148.0 147.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 23:22:17 INFO - PROCESS | 30545 | Values: 96.0 94.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:59.50 stddev:7.39 (12.4%) stddev-sans-first:7.84 23:22:17 INFO - PROCESS | 30545 | Values: 61.0 56.0 61.0 57.0 58.0 61.0 58.0 81.0 58.0 56.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 23:22:17 INFO - PROCESS | 30545 | Values: 60.0 61.0 61.0 61.0 61.0 60.0 59.0 60.0 61.0 60.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:3.67 (4.9%) stddev-sans-first:3.71 23:22:17 INFO - PROCESS | 30545 | Values: 72.0 73.0 73.0 75.0 75.0 85.0 75.0 73.0 75.0 75.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:119.50 stddev:7.50 (6.3%) stddev-sans-first:7.88 23:22:17 INFO - PROCESS | 30545 | Values: 117.0 114.0 122.0 124.0 115.0 113.0 114.0 115.0 135.0 129.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:2.21 (1.4%) stddev-sans-first:2.26 23:22:17 INFO - PROCESS | 30545 | Values: 164.0 160.0 161.0 162.0 162.0 163.0 161.0 166.0 165.0 159.0 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - PROCESS | 30545 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.10 (1.6%) stddev-sans-first:1.09 23:22:17 INFO - PROCESS | 30545 | Values: 69.0 67.0 69.0 68.0 69.0 69.0 68.0 66.0 67.0 67.0 23:22:17 INFO - PROCESS | 30545 | -------- Summary: end -------- 23:22:17 INFO - PROCESS | 30545 | 23:22:17 INFO - TEST-INFO | 30545: exit 0 23:22:17 INFO - TEST-OK | kraken | took 60980ms 23:22:17 INFO - SUITE-END | took 1170s 23:22:18 INFO - Completed test suite (00:19:30) 23:22:18 INFO - javascript benchmark 23:22:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.4658454647256, 3369.0903456066853, 3378.847951842167, 3403.149212696826, 3404.3361544498816, 5502.394736578978, 5523.696196709185, 5526.143447765593, 5549.833504994856, 5557.944420555793, 5494.2857428534335, 5569.582281328896, 5571.498565129148, 5574.0, 5590.357108932464, 5021.472745361748, 5023.824166154185, 5076.695398276097, 5081.923771143436, 5095.0, 5027.748612569375, 5073.898522029557, 5145.871353216181, 5193.246979188016, 5199.064168449678, 5061.063703214899, 5092.032513822381, 5100.566451851579, 5144.331236939192, 5152.124138896396, 5087.058894104584, 5105.668131571455, 5108.4125325587665, 5115.590752739772, 5137.897242055138, 4883.4628190898975, 5008.474110218411, 5023.547880690719, 5061.139606266944, 5085.059264036166, 5396.91904621431, 5423.511883930465, 5427.050266203399, 5450.4549545045575, 5457.263269458612, 5857.355690874, 5892.057270836688, 5894.646321220741, 5900.380460051676, 5905.6751878646655, 5772.249607550992, 5923.881522369572, 5947.316058653267, 5954.791582294599, 5986.5210783137245, 5567.49892509672, 5604.943950560524, 5607.355154157283, 5608.635438696471, 5670.0, 5984.581079324405, 6039.275286965592, 6055.364186760415, 6061.4544690977145, 6077.787277445268, 5815.709214539256, 5823.679697616672, 5828.883422331614, 5881.823545293648, 5901.3213480450295, 5941.881162376728, 5955.76176952917, 5988.730507127189, 6001.609895356788, 6011.3086994995265, 5966.403359663999, 5970.820875373745, 5976.432238937294, 5978.402159784074, 5987.251593550806, 5743.0811070228565, 5798.1302804579655, 5873.676947767828, 5899.970500147472, 5914.645121292736, 4416.514183439819, 4446.599806017474, 4449.510553839075, 4449.510553839075, 4456.242438785414, 3998.7800670962793, 4037.051292946155, 4040.5353384361174, 4060.898477538085, 4086.0193553546933, 5626.0, 5650.26546548946, 5668.716564171775, 5714.514266287412, 5744.741486633112, 5907.852303692442, 5967.731452084667, 5969.761209551656, 5973.37279585646, 6013.308469525973, 5526.447355264441, 5636.1827535008015, 5697.4302569742695, 5703.74333155009, 5732.77068917247, 5015.04714104319, 5029.27075574047, 5035.370578677665, 5049.065922804293, 5061.924071138936, 6132.662703551258, 6158.661273629993, 6186.566940314135, 6202.81391558254, 6217.564770466114, 5788.710564471844, 5886.793962211302, 5908.822735317947, 5916.6154199976, 5930.140129681258, 6221.502279817513, 6243.125962365363, 6243.875122497616, 6244.094606282155, 6245.781397651061, 5857.502112320501, 5860.94139058621, 5862.472377486047, 5874.089516125007, 5883.352831188651, 5861.589688721749, 5934.43622855828, 5948.315943666534, 6034.758609655564, 6056.212692349966, 5754.539636829128, 5761.48146666802, 5765.365809761007, 5767.826965191051, 5771.624844385269, 5708.714564271687, 5770.307563092456, 5775.422457754359, 5780.0173970424285, 5787.392323806108, 5492.5331346835965, 5765.164051212467, 5779.0, 5828.358880523224, 5855.8536036597725, 5806.76772929095, 5816.9127463088935, 5819.5344372450945, 5861.296644402699, 5863.0, 5507.862303442446, 5706.115552089433, 5724.484796368347, 5736.168255602997, 5753.71231438418], "value": 5481.541262497087, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.3825098399633, 663.7909058646526, 668.1814776898303, 674.5716470041524, 676.4824908944655, 40294.0, 41284.0, 41287.79356103215, 41369.75890723279, 41558.16883662325, 43646.56353436465, 44091.55908440923, 44383.33424998628, 44441.33337999933, 44479.33281000787, 8752.256058235042, 8974.192322690957, 8990.730278091667, 8993.865092023625, 9015.278777697802, 8615.913840861605, 8782.824343513126, 8795.472271663688, 8804.251638610694, 8814.603342849556, 9031.006589275174, 9106.86339704905, 9148.817023659523, 9152.405093668924, 9165.404248723846, 9080.818383632324, 9134.08659134088, 9136.588853501575, 9142.954285228532, 9164.633414663405, 8926.196642302224, 9080.228180604656, 9085.227755640779, 9096.408733432372, 9097.590608422637, 44223.77888110571, 44542.33186502205, 44649.0, 44707.0, 44775.32837007447, 3492.1618811485314, 3599.190182209008, 3688.5204923359793, 3695.2055308108884, 3770.4344348347695, 33164.50253246203, 33526.32947341064, 33785.6621433785, 33826.32347353039, 34006.0, 4538.909221815578, 4660.743659098748, 4685.648576356787, 4692.929606055912, 4696.342512048316, 314042.0, 314696.0, 314890.0, 316280.0, 316800.41599792085, 41061.0, 64654.67672661607, 65470.67264663742, 65612.67193664097, 65826.34173658202, 38956.80521597374, 39007.0, 39102.41346379807, 39147.21705565873, 39257.80371098183, 16988.405405810736, 17370.739438908426, 17388.0, 17404.39084632032, 17464.30142794274, 13720.65698357549, 13965.301734913213, 13998.510052148125, 14005.369758360694, 14015.159090454605, 9429.434233945985, 9493.477858717837, 9543.141117299476, 9608.423494590346, 9625.422474651543, 3611.94582081269, 3654.6477803212983, 3696.796676182782, 3707.1288247261873, 3747.081964918558, 1077.0414331245197, 1109.57836022311, 1133.4785998440645, 1164.1850704506878, 1243.6890777305673, 33012.50481242783, 33084.834575826964, 33310.66689333124, 33551.664483354856, 33923.32153356968, 1232.5316379775807, 1285.2673975833873, 1295.5400832704443, 1302.8892544133664, 1308.6205000549735, 17122.315107395563, 17207.483775486755, 17219.741703874453, 17280.913595431943, 17466.737998930028, 510644.0, 544073.0, 544510.0, 874347.0, 879105.0, 63167.0, 63714.36285637084, 64188.0, 64191.0, 64450.355496444434, 1567.2790516362602, 1575.4485929924435, 1576.8186658534187, 1577.83432739563, 1646.703593353208, 33468.49797252994, 33899.15252118717, 34169.82915085508, 34455.827720861234, 34722.479162813084, 54979.0, 60865.391346087745, 62941.68529157508, 63020.36979630145, 63342.36657633365, 455202.0, 458704.0, 460606.0, 461722.0, 461891.0, 46903.0, 47407.28889066598, 47608.2858757112, 48051.0, 48591.0, 52383.0, 53159.73420132875, 53432.73283633557, 53876.73061634667, 53944.73027634837, 43863.0, 44159.0, 44808.0, 45009.0, 45230.32154517751, 42396.0, 44385.77807110944, 44394.556054440334, 44983.55016449794, 45038.0, 44169.11661766683, 44302.11395772002, 44431.77784111188, 44823.55176448194, 44860.77569612131, 33566.328673426884, 34250.0, 34289.0, 34452.0, 34626.307473849876, 27281.59077613877, 28916.132516024554, 29023.854880725463, 29122.854385727936, 29298.853505732335], "value": 20397.62944967896, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.73632715879734, 431.3400497239225, 436.30191693290726, 438.5745826548249, 442.60165850734336, 18785.62428751426, 18947.62104757904, 19401.805981940175, 19447.61104777907, 19665.803341966577, 18759.0, 19105.80894191061, 19279.421617351465, 19392.22431102754, 19397.418077457663, 5838.9124163137485, 5868.178455016301, 5980.5813593048615, 6035.758569657209, 6045.123457098718, 4108.157827645326, 5900.586958912878, 5991.910121348184, 6324.0, 6604.636744979024, 6533.836654083639, 6536.248331441898, 6545.116409284757, 6561.704723287439, 6568.7372505099975, 5652.802151924683, 5843.29880414353, 5897.970510147465, 5899.174115623816, 6459.9354006460035, 5563.860903477405, 5707.571932105108, 5743.856403589902, 5753.338366087912, 5779.711014449303, 13869.583912482642, 13913.58259252224, 18063.638727225512, 21732.0, 22236.666450003264, 2444.877756112205, 2445.8532488050773, 2473.2209354053416, 2547.9108231212003, 2977.3003344214094, 10212.438315892623, 10292.588296468133, 10437.321574097736, 10601.734956626146, 10708.0, 2007.688808234726, 2033.542452948075, 2037.1749441476227, 2044.7852975437663, 2070.472029632449, 78645.21354786436, 79467.0, 80128.0, 80410.0, 81795.5910220451, 11199.440027998568, 11381.089512838953, 11450.0, 11604.30374177552, 11611.6516504505, 16152.192390380435, 16160.919195403947, 16213.513594592181, 16274.0, 16276.348946042026, 8974.37179397449, 9063.728088157366, 9076.727698169065, 9108.726738197865, 9149.176574108229, 8923.464592124494, 9020.188183063556, 9022.188003079755, 9037.277017838556, 9054.185123338932, 4836.46798852126, 4906.705597664151, 4910.8281210157475, 4929.704217746947, 4932.876678083005, 2010.1657812008145, 2087.4781304673834, 2088.958220835605, 2093.842961777873, 2130.9041093150845, 1000.2248257600418, 1075.419273592267, 1127.6278827986744, 1182.5624518928053, 1196.2224554039944, 17080.743788843178, 18066.0, 19805.900970495342, 20381.184752610025, 20583.485412864797, 1060.6446840308429, 1080.8270676691848, 1130.3556972525746, 1139.800534906388, 1147.0536807134147, 10625.84061239082, 10723.14214862809, 10770.192235582363, 10789.19081068923, 10860.402677852793, 502941.0, 503343.0, 504081.0, 505240.0, 510479.0, 89194.0, 95838.04161958292, 96426.0, 97541.0, 98591.50704246576, 1180.079537960375, 1185.0282768130223, 1185.8161984892183, 1189.1378750406059, 1211.0190745496, 16276.348946042026, 16524.75212871832, 16663.50009499717, 16895.155242237593, 16967.66064678724, 39697.40453893252, 39738.801305993285, 40060.79969600133, 40556.3916541258, 40823.79588102041, 59152.11271831012, 59258.0, 59303.0, 59358.406415935286, 59364.0, 9099.090090990849, 9123.589438475417, 9206.987231404673, 9334.25325973907, 9406.764830879009, 13000.934995324962, 13497.32513374347, 13609.659758506117, 13813.585592432242, 13878.0, 11342.773144537228, 11415.942920285346, 11539.653810385702, 11773.76452470963, 12009.0, 11855.881441185478, 11923.344216067853, 12024.278543287432, 12275.140740148105, 12309.44607492683, 11695.941520292345, 11794.528218871492, 11896.881031189578, 12080.39598020078, 12194.268343899039, 9082.863757043782, 12117.575884843987, 12675.619731408073, 12960.805587916, 13021.739565208833, 12335.3832308386, 12691.175073620185, 12708.237505749685, 12845.293508856728, 12864.807027894776], "value": 9654.614860330486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1578.5658943790456, 1586.3258115300998, 1757.762702035225, 1880.6332765110808, 1911.2737159879252, 7528.661210245538, 8298.91701082989, 8310.376721745879, 8546.91453085469, 8612.827743445136, 8031.357491400689, 8044.235797599234, 8108.554029528374, 8109.594520273978, 8112.22933821286, 2350.776676215761, 2374.6556749271344, 2375.869327187004, 2376.2039716694926, 2376.7504412036747, 2366.0890557135453, 2377.9881100594557, 2424.5029768897334, 2430.635404689293, 2434.8904299306487, 2314.826388020897, 2327.6392159215347, 2332.3352844439337, 2416.4804567018177, 2417.9516409671796, 2369.656399822025, 2374.323317854412, 2392.3181893160368, 2392.8444651097625, 2449.8775061247043, 2402.447437089479, 2427.8543287402813, 2434.525267572824, 2435.512897420523, 2444.4133407982135, 8618.439801412887, 8636.136386361377, 8644.178803013703, 8645.783855403603, 8664.39349245553, 5187.351581052369, 5308.964751873386, 5337.11937530307, 5338.199270109476, 5339.9733001335135, 3411.942297887638, 3418.1454636340914, 3437.3812713711523, 3503.019154636706, 3518.8240587970754, 1116.0736588631416, 1144.2676686920377, 1171.2152857585438, 1181.7695549367877, 1182.6629410617932, 11532.884671153264, 11543.88456115445, 11558.768824623461, 11560.248583842023, 11579.0, 4543.886402839956, 4615.169269531517, 4655.278431843002, 4671.27595222741, 4690.507496712796, 9816.920138784728, 9853.458059806637, 9882.11061004513, 9912.653057142965, 9926.156276716416, 5237.895242095136, 5287.23335116406, 5304.443033481506, 5321.042212401805, 5323.707196104251, 4760.666753327234, 4827.879303017453, 4965.280034394992, 4980.6513544052295, 4989.750512474435, 3944.723869329119, 3984.163325701635, 4008.0, 4017.1764788218347, 4083.224187404384, 1196.3360335013977, 1205.596125298035, 1207.0524638159004, 1213.878612138779, 1244.6390546741343, 825.3479750996765, 986.5018165826211, 1063.6011495689118, 1067.3809190669392, 1070.3684825952569, 5662.094064949588, 5828.679422631796, 5837.94162058374, 5886.941130588725, 5927.792527261611, 499.9700017998859, 503.5216544282946, 507.33032397235297, 1119.7480566872553, 1178.5933852820763, 3841.4814000110186, 3882.6699730523223, 3924.843006279717, 3942.9605703943166, 4040.777757223381, 10252.23108266883, 10479.790404191874, 10655.627053053106, 10677.57289708403, 10685.626003089854, 10692.091172250446, 10730.034296913314, 10829.133669306437, 10847.837282440769, 10872.510737016695, 8340.666373344999, 8345.207205315486, 8361.540115293717, 8430.409871309072, 8515.48907065578, 5819.883602328015, 5822.592418530662, 5837.270341207349, 5850.678212698343, 5937.139114828239, 9649.493979022418, 9676.225901927688, 9686.07982241686, 9819.214462842812, 9836.754081148028, 9652.951735241279, 9955.0, 9957.302988790716, 9970.700878973643, 9980.950095249478, 7571.205023472456, 7614.466987311057, 7763.262490063435, 7763.883541746991, 7783.571903545359, 8056.154103819014, 8057.0734365548715, 8107.959460202661, 8128.9593552031865, 8138.470999385021, 7108.537945033556, 7291.744788932574, 7487.812804679927, 7508.399328053633, 7563.697452102075, 7526.924730752841, 7535.73624923125, 7559.811004724926, 7592.772216833504, 7785.455018148676, 6959.3388628082275, 6973.267806880407, 6999.51003429755, 7008.334208250208, 7027.929720702932, 4854.902901942012, 4950.4059512858685, 5023.472535383732, 5044.394672639307, 5094.9490505095955, 5056.342675452168, 5075.695458272516, 5119.769610367468, 5155.226715992631, 5155.922661160161], "value": 4588.823182374478, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.6702419258729, 339.7367040543577, 341.1981842669726, 343.2465737705734, 344.31653168460605, 6361.141245931798, 6434.453071488929, 6501.934980650192, 6579.8355041124, 6613.470922326221, 6524.347565243474, 6527.151470308865, 6529.15121034266, 6547.934520654792, 6556.901646475307, 4916.827911023115, 4917.213245880651, 4931.309616653672, 4936.456989731127, 4945.530174633404, 4946.579540739023, 4947.480514545975, 4952.653314268003, 4953.108440480712, 4956.107900577895, 4898.706077635354, 4903.65674402792, 4908.28829819676, 4908.7300198489065, 4932.506749325074, 4826.710397376169, 4898.093852637274, 4916.237983112605, 4921.064997650453, 4932.482089380617, 4224.556421575752, 4250.171216612762, 4270.210011147948, 4290.0, 4290.721103128318, 6262.843428914268, 6263.686815659199, 6269.561130720851, 6270.059491076329, 6274.0, 5728.713564321767, 5763.452472015152, 5770.971145144247, 5776.249087618583, 5789.710514474259, 6922.06552115463, 6931.514793964425, 6940.13248343957, 6946.3400976907615, 6950.617716025617, 4460.933086003713, 4766.856994290177, 4795.928061079087, 4798.4001999750035, 4807.495213002654, 7175.533590316612, 7189.137303523611, 7230.023946767172, 7262.564246145248, 7262.636868156571, 4741.193997020515, 4761.166795810788, 4764.142454358249, 4766.428028636586, 4795.040991801584, 4829.782659780319, 4841.636877234221, 4842.806287748521, 4844.903101937942, 4848.0788650156355, 5647.463490968352, 5661.518770904519, 5663.8867222656145, 5666.15007748841, 5670.121131224667, 6833.453323734089, 6961.721531138799, 6965.79102626922, 6976.860462790716, 6981.476389270723, 1671.699094163038, 1689.0288084351548, 1697.9915100424419, 1698.5498842806667, 1701.0559139677598, 1073.3988966178965, 1082.4695899009428, 1102.9669109926715, 1103.85098011769, 1104.1663544024211, 6670.332966703388, 6869.656517174121, 6884.347756538495, 6898.758543451056, 6898.827529311808, 7163.032990546314, 7246.818829529198, 7250.673719682627, 7260.455465840083, 7269.491135620456, 6792.490563207681, 6809.080774095532, 6867.313268673092, 6870.519063665495, 6880.518363714592, 3848.5766565677754, 3899.5710471848074, 3910.081130934228, 3916.4516967624554, 3916.7258291919293, 7462.626868656545, 7675.194104618935, 7697.114831794303, 7703.1911649277135, 7713.035870516185, 7389.704411823467, 7390.408767298603, 7407.62961851916, 7417.258274172647, 7447.962760186273, 7578.621068946641, 7622.58075805836, 7642.5032372895585, 7673.155952845183, 7688.769336919901, 7097.077379940574, 7203.855922881408, 7237.240089790496, 7246.746363877239, 7303.890441643486, 7119.430445564446, 7158.319959603829, 7190.640467976685, 7193.064901562763, 7193.172785129568, 7644.617769111634, 7652.464327497244, 7656.119546252252, 7666.501677390952, 7673.808154796175, 4743.169945259635, 4781.5935645469135, 4791.808327666854, 4797.232442809273, 4801.18379875429, 6937.82655433598, 7245.963770181115, 7247.601381923834, 7248.927510724825, 7265.636718164176, 6991.615461149686, 7016.859662806613, 7026.789196324118, 7033.753818616324, 7035.296470352924, 6953.0, 6988.091548098715, 7003.54476958996, 7008.334208250208, 7041.0, 6878.621675807879, 6899.171719494439, 6905.585664860125, 6906.447484201352, 6928.064711263914, 6904.171499420102, 7021.017057611836, 7059.5764254144915, 7077.858442831011, 7084.822879428056, 6732.091167692299, 6798.898016529657, 6818.352256535622, 6830.965845170941, 6874.896876546756], "value": 5214.991329567229, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.5253229393097, 861.685484798049, 875.1379890807556, 878.3193025405315, 879.2789912271935, 14529.564113076598, 14852.257387130641, 14894.925525372386, 14910.35986041536, 14938.402463901459, 14103.576892693236, 14146.0, 14150.363233654485, 14268.0, 14273.71452570948, 885.477568234743, 894.5437826708361, 903.8553831386979, 905.7916679163797, 918.8346097702411, 878.4948654523643, 913.8035322405682, 918.1461241045824, 919.4437365393941, 919.4758987377197, 915.3821170709778, 961.4808003678005, 963.4556475591304, 964.1756298364902, 966.6906589891238, 910.7723069232692, 946.6828612414849, 949.5062567464914, 952.4095061062117, 952.6760901293524, 666.546748211221, 702.5047341624143, 702.8664553734774, 710.137183322266, 711.3597762014177, 15478.767818482731, 15548.378064877392, 15556.766648500281, 15574.0, 15635.765463518057, 14184.43262269508, 14266.857331426656, 14317.42730290787, 14349.928250358682, 14453.205073720941, 11417.716456708691, 11510.884891151065, 11824.822627660593, 11963.521459141624, 12047.819282710767, 3920.8235629396745, 3924.7448915820382, 3988.8205030773684, 4032.6773858091283, 4032.9193416131807, 57816.71091644557, 58014.0, 58888.411115888724, 59535.70232148811, 59628.70185649087, 10650.840237396445, 10731.89268107309, 10793.136549076055, 10874.67375978722, 11113.0, 20947.581048378946, 20976.265830696157, 21692.783072169394, 22153.778462215494, 22211.222607208994, 8587.656493740305, 8674.6096425661, 8833.64665413389, 8918.331125165638, 8967.551622418983, 4700.7179569225955, 4816.253480710496, 4870.756462176877, 4949.529794669501, 4951.702897826142, 3549.7692649978185, 3625.3111908737255, 3625.7461977661837, 3634.9818250908575, 3641.708663306929, 615.5906322295623, 622.9408206220402, 627.9372062793684, 631.0597210156833, 638.317000809139, 717.4977515739004, 727.7416517136446, 738.9482736208414, 743.2381808646181, 749.82753966588, 8944.195022448012, 9444.197243234403, 9469.147776699992, 9471.763205919908, 9536.856947145798, 659.4592434203906, 680.8638272345452, 715.5206011971991, 748.7529115391908, 761.0904968562514, 3944.775129000038, 4087.2029954159248, 4182.979085104555, 4193.706440549132, 4357.9564204358185, 66107.0, 67755.32244677588, 68258.31741682619, 68375.65812171006, 68805.31194688089, 57464.712676437186, 57638.13542796861, 57894.710526447096, 58556.0, 59086.40913590895, 50131.0, 50462.495375046514, 50545.0, 51789.741051295256, 52903.73548132235, 8515.148485151436, 8547.956151522061, 8630.913690863012, 8838.602262898314, 8952.462852228888, 38881.6111838878, 39670.404943925285, 39914.0, 41021.0, 41658.79170604127, 50346.0, 50841.491585085154, 51309.48690513047, 51480.48519514757, 52146.739266303426, 10790.352578845295, 10814.729631759268, 10981.176411768989, 11023.118150548098, 11241.494132764208, 11325.377104259345, 11437.199396042197, 11492.655220343404, 11493.712657183303, 11710.063194944554, 11021.118310534977, 11051.834222486508, 11120.61077862271, 11156.163287753614, 11208.83186752183, 9027.77430564215, 9209.585568649562, 9330.95334523323, 9492.382995105296, 9701.951490242503, 11071.889281107407, 11171.497282622138, 11365.374904380338, 11366.204365694322, 11486.36824974601, 9265.907340926775, 9436.480993545421, 9496.0, 9894.356866803922, 10039.648612298535, 9808.509574521388, 10112.898871011195, 10172.84740728875, 10173.23700722434, 10234.692959211236], "value": 6875.993989267722, "unit": "score"}], "name": "dromaeo_css", "value": 7497.637893173922, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 105.0, 111.0, 114.0, 113.0, 102.0, 109.0, 111.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 159.0, 177.0, 136.0, 156.0, 156.0, 128.0, 183.0, 128.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 162.0, 162.0, 161.0, 163.0, 163.0, 161.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 180.0, 74.0, 76.0, 74.0, 77.0, 170.0, 76.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 154.0, 92.0, 93.0, 92.0, 149.0, 93.0, 93.0, 142.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 148.0, 146.0, 148.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 56.0, 61.0, 57.0, 58.0, 61.0, 58.0, 81.0, 58.0, 56.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 59.0, 60.0, 61.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 75.0, 75.0, 85.0, 75.0, 73.0, 75.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 122.0, 124.0, 115.0, 113.0, 114.0, 115.0, 135.0, 129.0], "value": 119.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 161.0, 162.0, 162.0, 163.0, 161.0, 166.0, 165.0, 159.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 68.0, 69.0, 69.0, 68.0, 66.0, 67.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1533.0, "alertThreshold": 2.0}]} 23:22:18 INFO - Return code: 0 23:22:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:22:18 ERROR - # TBPL SUCCESS # 23:22:18 INFO - Running post-action listener: _resource_record_post_action 23:22:18 INFO - Running post-run listener: _resource_record_post_run 23:22:19 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 461406208; Read time: 16; Write time: 409732 23:22:19 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242561024; Read time: 0; Write time: 265448 23:22:19 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 218845184; Read time: 16; Write time: 144284 23:22:19 INFO - Running post-run listener: _upload_blobber_files 23:22:19 INFO - Blob upload gear active. 23:22:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:22:19 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 23:22:19 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:22:19 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:22:19 INFO - (blobuploader) - INFO - Open directory for files ... 23:22:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:22:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:22:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:22:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:22:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:22:20 INFO - (blobuploader) - INFO - Done attempting. 23:22:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:22:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:22:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:22:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:22:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:22:21 INFO - (blobuploader) - INFO - Done attempting. 23:22:21 INFO - (blobuploader) - INFO - Iteration through files over. 23:22:21 INFO - Return code: 0 23:22:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:22:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:22:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ef0432bf4a300810a7b9f345b1438cca8f9097812436a8c790dbcff022cbc8d7fc7721d705d37ef29c118771c6e8bc8926cba42110895d8b7de5ac6addc48fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb7ad8b08900bf5095c682bad85aa48603f8ed3498a3674aa5940fd6cee5a5fb582d56e142f908af6c94fc7eb11f30a89dea1c2572aafd8c732ac8bacd2035f"} 23:22:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:22:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:22:21 INFO - Contents: 23:22:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ef0432bf4a300810a7b9f345b1438cca8f9097812436a8c790dbcff022cbc8d7fc7721d705d37ef29c118771c6e8bc8926cba42110895d8b7de5ac6addc48fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb7ad8b08900bf5095c682bad85aa48603f8ed3498a3674aa5940fd6cee5a5fb582d56e142f908af6c94fc7eb11f30a89dea1c2572aafd8c732ac8bacd2035f"} 23:22:21 INFO - Running post-run listener: copy_logs_to_upload_dir 23:22:21 INFO - Copying logs to upload dir... 23:22:21 INFO - mkdir: /builds/slave/test/build/upload/logs 23:22:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.803427 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-13 23:22:21.157148) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:21.160923) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ef0432bf4a300810a7b9f345b1438cca8f9097812436a8c790dbcff022cbc8d7fc7721d705d37ef29c118771c6e8bc8926cba42110895d8b7de5ac6addc48fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb7ad8b08900bf5095c682bad85aa48603f8ed3498a3674aa5940fd6cee5a5fb582d56e142f908af6c94fc7eb11f30a89dea1c2572aafd8c732ac8bacd2035f"} build_url:https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ef0432bf4a300810a7b9f345b1438cca8f9097812436a8c790dbcff022cbc8d7fc7721d705d37ef29c118771c6e8bc8926cba42110895d8b7de5ac6addc48fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb7ad8b08900bf5095c682bad85aa48603f8ed3498a3674aa5940fd6cee5a5fb582d56e142f908af6c94fc7eb11f30a89dea1c2572aafd8c732ac8bacd2035f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:21.189524) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:21.189849) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468476115.923718-748126145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:21.272795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:22:21.273143) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:22:21.273456) ========= ========= Total master_lag: 0.18 =========