builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1466502677.37 results: success (0) buildid: 20160621001202 builduid: 43bee3b121c74b5c9b27a35f1df4b48b revision: 2a762ba88494113dff67f29216fadbabd9c03097 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:17.368969) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:17.369466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:17.369859) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:17.385748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:17.386408) ========= 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=eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 02:51:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-06-21 02:51:17 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077219 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:17.477548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:17.477905) ========= 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=eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015866 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:17.526906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:17.527222) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2a762ba88494113dff67f29216fadbabd9c03097 --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 2a762ba88494113dff67f29216fadbabd9c03097 --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=eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 02:51:17,542 truncating revision to first 12 chars 2016-06-21 02:51:17,542 Setting DEBUG logging. 2016-06-21 02:51:17,542 attempt 1/10 2016-06-21 02:51:17,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2a762ba88494?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 02:51:17,842 unpacking tar archive at: mozilla-beta-2a762ba88494/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646106 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:18.189775) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:18.190412) ========= script_repo_revision: 2a762ba88494113dff67f29216fadbabd9c03097 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:18.190859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:18.191128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 02:51:18.220441) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2016-06-21 02:51:18.220783) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:51:18 INFO - MultiFileLogger online at 20160621 02:51:18 in /builds/slave/test 02:51:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:51:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:51:18 INFO - {'append_to_log': False, 02:51:18 INFO - 'base_work_dir': '/builds/slave/test', 02:51:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:51:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:51:18 INFO - 'branch': 'Mozilla-Beta', 02:51:18 INFO - 'buildbot_json_path': 'buildprops.json', 02:51:18 INFO - 'config_files': ('talos/linux_config.py',), 02:51:18 INFO - 'default_actions': ('clobber', 02:51:18 INFO - 'read-buildbot-config', 02:51:18 INFO - 'download-and-extract', 02:51:18 INFO - 'populate-webroot', 02:51:18 INFO - 'create-virtualenv', 02:51:18 INFO - 'install', 02:51:18 INFO - 'run-tests'), 02:51:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:51:18 INFO - 'download_minidump_stackwalk': True, 02:51:18 INFO - 'download_symbols': 'ondemand', 02:51:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:51:18 INFO - 'tooltool.py': '/tools/tooltool.py', 02:51:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:51:18 INFO - '/tools/misc-python/virtualenv.py')}, 02:51:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:51:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:51:18 INFO - 'installer_path': 'installer.exe', 02:51:18 INFO - 'log_level': 'info', 02:51:18 INFO - 'log_name': 'talos', 02:51:18 INFO - 'log_to_console': True, 02:51:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:51:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:51:18 INFO - 'opt_config_files': (), 02:51:18 INFO - 'pip_index': False, 02:51:18 INFO - 'sps_profile': False, 02:51:18 INFO - 'sps_profile_interval': 0, 02:51:18 INFO - 'suite': 'dromaeojs', 02:51:18 INFO - 'system_bits': '32', 02:51:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:51:18 INFO - 'title': 'talos-linux64-ix-010', 02:51:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:51:18 INFO - 'use_talos_json': True, 02:51:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:51:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:51:18 INFO - 'work_dir': 'build'} 02:51:18 INFO - ##### 02:51:18 INFO - ##### Running clobber step. 02:51:18 INFO - ##### 02:51:18 INFO - Running pre-action listener: _resource_record_pre_action 02:51:18 INFO - Running main action method: clobber 02:51:18 INFO - rmtree: /builds/slave/test/build 02:51:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:51:19 INFO - Running post-action listener: _resource_record_post_action 02:51:19 INFO - ##### 02:51:19 INFO - ##### Running read-buildbot-config step. 02:51:19 INFO - ##### 02:51:19 INFO - Running pre-action listener: _resource_record_pre_action 02:51:19 INFO - Running main action method: read_buildbot_config 02:51:19 INFO - Using buildbot properties: 02:51:19 INFO - { 02:51:19 INFO - "project": "", 02:51:19 INFO - "product": "firefox", 02:51:19 INFO - "script_repo_revision": "production", 02:51:19 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 02:51:19 INFO - "repository": "", 02:51:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 02:51:19 INFO - "buildid": "20160621001202", 02:51:19 INFO - "pgo_build": "True", 02:51:19 INFO - "basedir": "/builds/slave/test", 02:51:19 INFO - "buildnumber": 49, 02:51:19 INFO - "slavename": "talos-linux64-ix-010", 02:51:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:51:19 INFO - "platform": "ubuntu64_hw", 02:51:19 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 02:51:19 INFO - "branch": "mozilla-beta", 02:51:19 INFO - "repo_path": "releases/mozilla-beta", 02:51:19 INFO - "revision": "2a762ba88494113dff67f29216fadbabd9c03097", 02:51:19 INFO - "stage_platform": "linux64-pgo", 02:51:19 INFO - "builduid": "43bee3b121c74b5c9b27a35f1df4b48b", 02:51:19 INFO - "slavebuilddir": "test" 02:51:19 INFO - } 02:51:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 02:51:19 INFO - Running post-action listener: _resource_record_post_action 02:51:19 INFO - ##### 02:51:19 INFO - ##### Running download-and-extract step. 02:51:19 INFO - ##### 02:51:19 INFO - Running pre-action listener: _resource_record_pre_action 02:51:19 INFO - Running main action method: download_and_extract 02:51:19 INFO - mkdir: /builds/slave/test/build/tests 02:51: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')]} 02:51:19 INFO - https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:51:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:51:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:51:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 02:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 02:51:25 INFO - Downloaded 1327 bytes. 02:51:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:51:25 INFO - Using the following test package requirements: 02:51:25 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:51:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:51:25 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 02:51:25 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:51:25 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 02:51:25 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:51:25 INFO - u'jsshell-linux-x86_64.zip'], 02:51:25 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:51:25 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 02:51:25 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:51:25 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:51:25 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 02:51:25 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:51:25 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 02:51:25 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:51:25 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 02:51:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:51:25 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 02:51:25 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:25 INFO - https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 02:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 02:51:30 INFO - Downloaded 24185717 bytes. 02:51:30 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'] 02:51:30 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 02:51:31 INFO - Return code: 0 02:51:31 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 02:51:31 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')]} 02:51:31 INFO - https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:51:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:51:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:51:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 02:51:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 02:52:04 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip: The read operation timed out 02:52:04 INFO - retry: attempt #1 caught exception: The read operation timed out 02:52:04 INFO - retry: Failed, sleeping 30 seconds before retrying 02:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 #2 02:52:35 INFO - Downloaded 24185717 bytes. 02:52:35 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'] 02:52:35 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 02:52:36 INFO - Return code: 0 02:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:36 INFO - https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 02:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 02:52:37 INFO - Downloaded 10840145 bytes. 02:52:37 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'] 02:52:37 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 02:52:37 INFO - Return code: 0 02:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:37 INFO - https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 02:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffkwXNipT2aK5l1MytLaYw/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 02:52:39 INFO - Downloaded 56002786 bytes. 02:52:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:52:39 INFO - mkdir: /builds/slave/test/properties 02:52:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:39 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:39 INFO - Contents: 02:52:39 INFO - build_url:https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:52:40 INFO - Running post-action listener: _resource_record_post_action 02:52:40 INFO - Running post-action listener: set_extra_try_arguments 02:52:40 INFO - ##### 02:52:40 INFO - ##### Running populate-webroot step. 02:52:40 INFO - ##### 02:52:40 INFO - Running pre-action listener: _resource_record_pre_action 02:52:40 INFO - Running main action method: populate_webroot 02:52:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:52:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:52:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:52:40 INFO - '--tppagecycles', 02:52:40 INFO - '7'], 02:52:40 INFO - 'tests': ['tsvgm']}}, 02:52:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:52:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:52:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:52:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:52:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:40 INFO - 'talos_options': ['--disable-e10s'], 02:52:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:40 INFO - 'talos_options': ['--disable-e10s'], 02:52:40 INFO - 'tests': ['damp', 'tps']}, 02:52:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:40 INFO - 'tests': ['damp', 'tps']}, 02:52:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:52:40 INFO - 'tests': ['dromaeo_dom']}, 02:52:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:52:40 INFO - 'tests': ['a11yr', 02:52:40 INFO - 'ts_paint', 02:52:40 INFO - 'tpaint', 02:52:40 INFO - 'sessionrestore', 02:52:40 INFO - 'sessionrestore_no_auto_restore', 02:52:40 INFO - 'tabpaint']}, 02:52:40 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:40 INFO - 'ts_paint', 02:52:40 INFO - 'tpaint', 02:52:40 INFO - 'sessionrestore', 02:52:40 INFO - 'sessionrestore_no_auto_restore', 02:52:40 INFO - 'tabpaint']}, 02:52:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:52:40 INFO - 'ts_paint', 02:52:40 INFO - 'tpaint', 02:52:40 INFO - 'sessionrestore', 02:52:40 INFO - 'sessionrestore_no_auto_restore', 02:52:40 INFO - 'tabpaint']}, 02:52:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:52:40 INFO - 'ts_paint', 02:52:40 INFO - 'tpaint', 02:52:40 INFO - 'sessionrestore', 02:52:40 INFO - 'sessionrestore_no_auto_restore', 02:52:40 INFO - 'tabpaint']}, 02:52:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:52:40 INFO - 'tests': ['a11yr', 02:52:40 INFO - 'ts_paint', 02:52:40 INFO - 'tpaint', 02:52:40 INFO - 'sessionrestore', 02:52:40 INFO - 'sessionrestore_no_auto_restore', 02:52:40 INFO - 'tabpaint']}, 02:52:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:52:40 INFO - 'tests': ['a11yr', 02:52:40 INFO - 'ts_paint', 02:52:40 INFO - 'tpaint', 02:52:40 INFO - 'sessionrestore', 02:52:40 INFO - 'sessionrestore_no_auto_restore', 02:52:40 INFO - 'tabpaint']}, 02:52:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:52:40 INFO - 'tests': ['tsvgx', 02:52:40 INFO - 'tsvgr_opacity', 02:52:40 INFO - 'tart', 02:52:40 INFO - 'tscrollx', 02:52:40 INFO - 'cart']}, 02:52:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:40 INFO - 'tsvgr_opacity', 02:52:40 INFO - 'tart', 02:52:40 INFO - 'tscrollx', 02:52:40 INFO - 'cart']}, 02:52:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:40 INFO - 'talos_options': ['--disable-e10s'], 02:52:40 INFO - 'tests': ['tp5o']}, 02:52:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:40 INFO - 'tests': ['tp5o']}, 02:52:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:40 INFO - 'talos_options': ['--disable-e10s', 02:52:40 INFO - '--xperf_path', 02:52:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:40 INFO - 'tests': ['tp5n']}, 02:52:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:40 INFO - 'talos_options': ['--xperf_path', 02:52:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:40 INFO - 'tests': ['tp5n']}}, 02:52:40 INFO - 'talos.zip': {'path': '', 02:52:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:52:40 INFO - Running post-action listener: _resource_record_post_action 02:52:40 INFO - ##### 02:52:40 INFO - ##### Running create-virtualenv step. 02:52:40 INFO - ##### 02:52:40 INFO - Running pre-action listener: _resource_record_pre_action 02:52:40 INFO - Running main action method: create_virtualenv 02:52:40 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:40 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 02:52:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:40 INFO - Using real prefix '/usr' 02:52:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:41 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:43 INFO - Installing pip.................done. 02:52:43 INFO - Return code: 0 02:52:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f325b7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478410>, '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 0x2479310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24797a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', '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 02:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:52:43 INFO - Using env: {'DISPLAY': ':0', 02:52:43 INFO - 'HOME': '/home/cltbld', 02:52:43 INFO - 'LANG': 'en_US.UTF-8', 02:52:43 INFO - 'LANGUAGE': 'en_US:en', 02:52:43 INFO - 'LOGNAME': 'cltbld', 02:52:43 INFO - 'MAIL': '/var/mail/cltbld', 02:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:43 INFO - 'MOZ_NO_REMOTE': '1', 02:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:43 INFO - 'NO_EM_RESTART': '1', 02:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:43 INFO - 'PWD': '/builds/slave/test', 02:52:43 INFO - 'SHELL': '/bin/bash', 02:52:43 INFO - 'SHLVL': '1', 02:52:43 INFO - 'TERM': 'linux', 02:52:43 INFO - 'TMOUT': '86400', 02:52:43 INFO - 'USER': 'cltbld', 02:52:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', 02:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:43 INFO - '_': '/tools/buildbot/bin/python'} 02:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:43 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 02:52:43 INFO - Cleaning up... 02:52:43 INFO - Return code: 0 02:52:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f325b7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478410>, '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 0x2479310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24797a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', '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 02:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:52:43 INFO - Using env: {'DISPLAY': ':0', 02:52:43 INFO - 'HOME': '/home/cltbld', 02:52:43 INFO - 'LANG': 'en_US.UTF-8', 02:52:43 INFO - 'LANGUAGE': 'en_US:en', 02:52:43 INFO - 'LOGNAME': 'cltbld', 02:52:43 INFO - 'MAIL': '/var/mail/cltbld', 02:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:43 INFO - 'MOZ_NO_REMOTE': '1', 02:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:43 INFO - 'NO_EM_RESTART': '1', 02:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:43 INFO - 'PWD': '/builds/slave/test', 02:52:43 INFO - 'SHELL': '/bin/bash', 02:52:43 INFO - 'SHLVL': '1', 02:52:43 INFO - 'TERM': 'linux', 02:52:43 INFO - 'TMOUT': '86400', 02:52:43 INFO - 'USER': 'cltbld', 02:52:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', 02:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:43 INFO - '_': '/tools/buildbot/bin/python'} 02:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:43 INFO - Downloading/unpacking psutil>=0.7.1 02:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:52:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:45 INFO - Installing collected packages: psutil 02:52:45 INFO - Running setup.py install for psutil 02:52:45 INFO - building 'psutil._psutil_linux' extension 02:52:45 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 02:52:45 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 02:52:45 INFO - building 'psutil._psutil_posix' extension 02:52:45 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 02:52:45 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 02:52:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:45 INFO - Successfully installed psutil 02:52:45 INFO - Cleaning up... 02:52:46 INFO - Return code: 0 02:52:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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')]} 02:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f325b7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478410>, '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 0x2479310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24797a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', '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 02:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:52:46 INFO - Using env: {'DISPLAY': ':0', 02:52:46 INFO - 'HOME': '/home/cltbld', 02:52:46 INFO - 'LANG': 'en_US.UTF-8', 02:52:46 INFO - 'LANGUAGE': 'en_US:en', 02:52:46 INFO - 'LOGNAME': 'cltbld', 02:52:46 INFO - 'MAIL': '/var/mail/cltbld', 02:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:46 INFO - 'MOZ_NO_REMOTE': '1', 02:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:46 INFO - 'NO_EM_RESTART': '1', 02:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:46 INFO - 'PWD': '/builds/slave/test', 02:52:46 INFO - 'SHELL': '/bin/bash', 02:52:46 INFO - 'SHLVL': '1', 02:52:46 INFO - 'TERM': 'linux', 02:52:46 INFO - 'TMOUT': '86400', 02:52:46 INFO - 'USER': 'cltbld', 02:52:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', 02:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:46 INFO - '_': '/tools/buildbot/bin/python'} 02:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:52:48 INFO - Installing collected packages: mozsystemmonitor 02:52:48 INFO - Running setup.py install for mozsystemmonitor 02:52:48 INFO - Successfully installed mozsystemmonitor 02:52:48 INFO - Cleaning up... 02:52:48 INFO - Return code: 0 02:52:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:48 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 0x7f325b7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478410>, '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 0x2479310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24797a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', '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 02:52:48 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 02:52:48 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 02:52:48 INFO - Using env: {'DISPLAY': ':0', 02:52:48 INFO - 'HOME': '/home/cltbld', 02:52:48 INFO - 'LANG': 'en_US.UTF-8', 02:52:48 INFO - 'LANGUAGE': 'en_US:en', 02:52:48 INFO - 'LOGNAME': 'cltbld', 02:52:48 INFO - 'MAIL': '/var/mail/cltbld', 02:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:48 INFO - 'MOZ_NO_REMOTE': '1', 02:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:48 INFO - 'NO_EM_RESTART': '1', 02:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:48 INFO - 'PWD': '/builds/slave/test', 02:52:48 INFO - 'SHELL': '/bin/bash', 02:52:48 INFO - 'SHLVL': '1', 02:52:48 INFO - 'TERM': 'linux', 02:52:48 INFO - 'TMOUT': '86400', 02:52:48 INFO - 'USER': 'cltbld', 02:52:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', 02:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:48 INFO - '_': '/tools/buildbot/bin/python'} 02:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:52:48 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 02:52:48 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 02:52:48 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 02:52:48 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 02:52:48 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 02:52:48 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 02:52:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52:50 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 02:52:50 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 02:52:50 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 02:52:50 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 02:52:50 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 02:52:50 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 02:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52:50 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 02:52:50 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 02:52:50 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 02:52:50 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 02:52:50 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 02:52:50 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 02:52:51 INFO - Downloading docopt-0.6.1.tar.gz 02:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:51 INFO - Running setup.py install for blobuploader 02:52:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:51 INFO - Running setup.py install for requests 02:52:51 INFO - Running setup.py install for docopt 02:52:51 INFO - Successfully installed blobuploader requests docopt 02:52:51 INFO - Cleaning up... 02:52:51 INFO - Return code: 0 02:52:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:51 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 0x7f325b7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478410>, '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 0x2479310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24797a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', '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 02:52:51 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 02:52:51 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 02:52:51 INFO - Using env: {'DISPLAY': ':0', 02:52:51 INFO - 'HOME': '/home/cltbld', 02:52:51 INFO - 'LANG': 'en_US.UTF-8', 02:52:51 INFO - 'LANGUAGE': 'en_US:en', 02:52:51 INFO - 'LOGNAME': 'cltbld', 02:52:51 INFO - 'MAIL': '/var/mail/cltbld', 02:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:51 INFO - 'MOZ_NO_REMOTE': '1', 02:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:51 INFO - 'NO_EM_RESTART': '1', 02:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:51 INFO - 'PWD': '/builds/slave/test', 02:52:51 INFO - 'SHELL': '/bin/bash', 02:52:51 INFO - 'SHLVL': '1', 02:52:51 INFO - 'TERM': 'linux', 02:52:51 INFO - 'TMOUT': '86400', 02:52:51 INFO - 'USER': 'cltbld', 02:52:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', 02:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:51 INFO - '_': '/tools/buildbot/bin/python'} 02:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:52 INFO - Running setup.py (path:/tmp/pip-k8qIq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:52 INFO - Running setup.py (path:/tmp/pip-esqX1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:52 INFO - Running setup.py (path:/tmp/pip-bZcFcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:52 INFO - Running setup.py (path:/tmp/pip-CG91MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:52 INFO - Running setup.py (path:/tmp/pip-LDkAs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:52 INFO - Running setup.py (path:/tmp/pip-qlqyIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:52 INFO - Running setup.py (path:/tmp/pip-UsZGuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:52 INFO - Running setup.py (path:/tmp/pip-NYRUc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:52 INFO - Running setup.py (path:/tmp/pip-g9Uqxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:52 INFO - Running setup.py (path:/tmp/pip-GYsyDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:52 INFO - Running setup.py (path:/tmp/pip-MoQbiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:52 INFO - Running setup.py (path:/tmp/pip-mFvs04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:52 INFO - Running setup.py (path:/tmp/pip-W5fILR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:53 INFO - Running setup.py (path:/tmp/pip-bBg87K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:53 INFO - Running setup.py (path:/tmp/pip-sabIau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:53 INFO - Running setup.py (path:/tmp/pip-UxjsCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:53 INFO - Running setup.py (path:/tmp/pip-RN_zi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:53 INFO - Running setup.py install for manifestparser 02:52:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:53 INFO - Running setup.py install for mozcrash 02:52:53 INFO - Running setup.py install for mozdebug 02:52:53 INFO - Running setup.py install for mozdevice 02:52:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:52:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:53 INFO - Running setup.py install for mozfile 02:52:53 INFO - Running setup.py install for mozhttpd 02:52:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:53 INFO - Running setup.py install for mozinfo 02:52:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Running setup.py install for mozInstall 02:52:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Running setup.py install for mozleak 02:52:54 INFO - Running setup.py install for mozlog 02:52:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Running setup.py install for moznetwork 02:52:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Running setup.py install for mozprocess 02:52:54 INFO - Running setup.py install for mozprofile 02:52:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Running setup.py install for mozrunner 02:52:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Running setup.py install for mozscreenshot 02:52:54 INFO - Running setup.py install for moztest 02:52:54 INFO - Running setup.py install for mozversion 02:52:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:52:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:52:55 INFO - Cleaning up... 02:52:55 INFO - Return code: 0 02:52:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:55 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 0x7f325b7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478410>, '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 0x2479310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24797a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', '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 02:52:55 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 02:52:55 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 02:52:55 INFO - Using env: {'DISPLAY': ':0', 02:52:55 INFO - 'HOME': '/home/cltbld', 02:52:55 INFO - 'LANG': 'en_US.UTF-8', 02:52:55 INFO - 'LANGUAGE': 'en_US:en', 02:52:55 INFO - 'LOGNAME': 'cltbld', 02:52:55 INFO - 'MAIL': '/var/mail/cltbld', 02:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:55 INFO - 'MOZ_NO_REMOTE': '1', 02:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:55 INFO - 'NO_EM_RESTART': '1', 02:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:55 INFO - 'PWD': '/builds/slave/test', 02:52:55 INFO - 'SHELL': '/bin/bash', 02:52:55 INFO - 'SHLVL': '1', 02:52:55 INFO - 'TERM': 'linux', 02:52:55 INFO - 'TMOUT': '86400', 02:52:55 INFO - 'USER': 'cltbld', 02:52:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', 02:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:55 INFO - '_': '/tools/buildbot/bin/python'} 02:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:55 INFO - Running setup.py (path:/tmp/pip-JkD3ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:55 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)) 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:55 INFO - Running setup.py (path:/tmp/pip-399767-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:55 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)) 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:55 INFO - Running setup.py (path:/tmp/pip-T9alvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:55 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)) 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:55 INFO - Running setup.py (path:/tmp/pip-rs49Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:55 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)) 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:55 INFO - Running setup.py (path:/tmp/pip-mIVb49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:55 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)) 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:55 INFO - Running setup.py (path:/tmp/pip-WXevn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:55 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)) 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:55 INFO - Running setup.py (path:/tmp/pip-psMDNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:55 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)) 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:55 INFO - Running setup.py (path:/tmp/pip-WLAlfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:55 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)) 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:55 INFO - Running setup.py (path:/tmp/pip-gEH6Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:55 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)) 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:55 INFO - Running setup.py (path:/tmp/pip-ByRRXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:56 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)) 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:56 INFO - Running setup.py (path:/tmp/pip-mQFC3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:56 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)) 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:56 INFO - Running setup.py (path:/tmp/pip-1H9ZBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:56 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)) 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:56 INFO - Running setup.py (path:/tmp/pip-YcdNtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:56 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)) 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:56 INFO - Running setup.py (path:/tmp/pip-fgPTo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:56 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)) 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:56 INFO - Running setup.py (path:/tmp/pip-xxbG9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:56 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)) 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:56 INFO - Running setup.py (path:/tmp/pip-9DFgYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:56 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)) 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:56 INFO - Running setup.py (path:/tmp/pip-63g0qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:58 INFO - Downloading blessings-1.6.tar.gz 02:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:52:58 INFO - Installing collected packages: blessings 02:52:58 INFO - Running setup.py install for blessings 02:52:58 INFO - Successfully installed blessings 02:52:58 INFO - Cleaning up... 02:52:58 INFO - Return code: 0 02:52:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:58 INFO - Reading from file tmpfile_stdout 02:52:58 INFO - Current package versions: 02:52:58 INFO - argparse == 1.2.1 02:52:58 INFO - blessings == 1.6 02:52:58 INFO - blobuploader == 1.2.4 02:52:58 INFO - docopt == 0.6.1 02:52:58 INFO - manifestparser == 1.1 02:52:58 INFO - mozInstall == 1.12 02:52:58 INFO - mozcrash == 0.17 02:52:58 INFO - mozdebug == 0.1 02:52:58 INFO - mozdevice == 0.48 02:52:58 INFO - mozfile == 1.2 02:52:58 INFO - mozhttpd == 0.7 02:52:58 INFO - mozinfo == 0.9 02:52:58 INFO - mozleak == 0.1 02:52:58 INFO - mozlog == 3.1 02:52:58 INFO - moznetwork == 0.27 02:52:58 INFO - mozprocess == 0.22 02:52:58 INFO - mozprofile == 0.28 02:52:58 INFO - mozrunner == 6.11 02:52:58 INFO - mozscreenshot == 0.1 02:52:58 INFO - mozsystemmonitor == 0.0 02:52:58 INFO - moztest == 0.7 02:52:58 INFO - mozversion == 1.4 02:52:58 INFO - psutil == 3.1.1 02:52:58 INFO - requests == 1.2.3 02:52:58 INFO - wsgiref == 0.1.2 02:52:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:58 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 0x7f325b7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478410>, '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 0x2479310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24797a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', '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 02:52:58 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 02:52:58 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 02:52:58 INFO - Using env: {'DISPLAY': ':0', 02:52:58 INFO - 'HOME': '/home/cltbld', 02:52:58 INFO - 'LANG': 'en_US.UTF-8', 02:52:58 INFO - 'LANGUAGE': 'en_US:en', 02:52:58 INFO - 'LOGNAME': 'cltbld', 02:52:58 INFO - 'MAIL': '/var/mail/cltbld', 02:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:58 INFO - 'MOZ_NO_REMOTE': '1', 02:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:58 INFO - 'NO_EM_RESTART': '1', 02:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:58 INFO - 'PWD': '/builds/slave/test', 02:52:58 INFO - 'SHELL': '/bin/bash', 02:52:58 INFO - 'SHLVL': '1', 02:52:58 INFO - 'TERM': 'linux', 02:52:58 INFO - 'TMOUT': '86400', 02:52:58 INFO - 'USER': 'cltbld', 02:52:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', 02:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:58 INFO - '_': '/tools/buildbot/bin/python'} 02:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:59 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)) 02:52:59 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)) 02:52:59 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)) 02:52:59 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)) 02:52:59 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)) 02:52:59 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)) 02:52:59 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)) 02:52:59 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)) 02:52:59 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)) 02:52:59 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)) 02:52:59 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)) 02:52:59 INFO - Cleaning up... 02:52:59 INFO - Return code: 0 02:52:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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')]} 02:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:59 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 0x7f325b7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478410>, '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 0x2479310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24797a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', '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 02:52:59 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 02:52:59 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 02:52:59 INFO - Using env: {'DISPLAY': ':0', 02:52:59 INFO - 'HOME': '/home/cltbld', 02:52:59 INFO - 'LANG': 'en_US.UTF-8', 02:52:59 INFO - 'LANGUAGE': 'en_US:en', 02:52:59 INFO - 'LOGNAME': 'cltbld', 02:52:59 INFO - 'MAIL': '/var/mail/cltbld', 02:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:59 INFO - 'MOZ_NO_REMOTE': '1', 02:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:59 INFO - 'NO_EM_RESTART': '1', 02:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:59 INFO - 'PWD': '/builds/slave/test', 02:52:59 INFO - 'SHELL': '/bin/bash', 02:52:59 INFO - 'SHLVL': '1', 02:52:59 INFO - 'TERM': 'linux', 02:52:59 INFO - 'TMOUT': '86400', 02:52:59 INFO - 'USER': 'cltbld', 02:52:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', 02:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:59 INFO - '_': '/tools/buildbot/bin/python'} 02:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:59 INFO - Downloading/unpacking jsonschema 02:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:53:01 INFO - Downloading/unpacking functools32 (from jsonschema) 02:53:01 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 02:53:01 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 02:53:01 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 02:53:01 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 02:53:01 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 02:53:01 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 02:53:01 INFO - Downloading functools32-3.2.3-2.tar.gz 02:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:53:01 INFO - warning: no files found matching '*.txt' 02:53:01 INFO - no previously-included directories found matching 'build' 02:53:01 INFO - no previously-included directories found matching 'dist' 02:53:01 INFO - no previously-included directories found matching '.git*' 02:53:01 INFO - Installing collected packages: jsonschema, functools32 02:53:01 INFO - Running setup.py install for functools32 02:53:01 INFO - warning: no files found matching '*.txt' 02:53:01 INFO - no previously-included directories found matching 'build' 02:53:01 INFO - no previously-included directories found matching 'dist' 02:53:01 INFO - no previously-included directories found matching '.git*' 02:53:01 INFO - Successfully installed jsonschema functools32 02:53:01 INFO - Cleaning up... 02:53:01 INFO - Return code: 0 02:53:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:01 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 0x7f325b7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478410>, '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 0x2479310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24797a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', '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 02:53:01 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 02:53:01 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 02:53:01 INFO - Using env: {'DISPLAY': ':0', 02:53:01 INFO - 'HOME': '/home/cltbld', 02:53:01 INFO - 'LANG': 'en_US.UTF-8', 02:53:01 INFO - 'LANGUAGE': 'en_US:en', 02:53:01 INFO - 'LOGNAME': 'cltbld', 02:53:01 INFO - 'MAIL': '/var/mail/cltbld', 02:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:01 INFO - 'MOZ_NO_REMOTE': '1', 02:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:01 INFO - 'NO_EM_RESTART': '1', 02:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:01 INFO - 'PWD': '/builds/slave/test', 02:53:01 INFO - 'SHELL': '/bin/bash', 02:53:01 INFO - 'SHLVL': '1', 02:53:01 INFO - 'TERM': 'linux', 02:53:01 INFO - 'TMOUT': '86400', 02:53:01 INFO - 'USER': 'cltbld', 02:53:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', 02:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:01 INFO - '_': '/tools/buildbot/bin/python'} 02:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:01 INFO - Downloading/unpacking flake8 02:53:01 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 02:53:01 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 02:53:01 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 02:53:01 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 02:53:01 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 02:53:01 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 02:53:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:53:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:53:03 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 02:53:03 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 02:53:03 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 02:53:03 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 02:53:03 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 02:53:03 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 02:53:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:53:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:53:04 INFO - no previously-included directories found matching 'docs/_build' 02:53:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:53:04 INFO - Running setup.py install for pep8 02:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:53:04 INFO - no previously-included directories found matching 'docs/_build' 02:53:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:53:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:53:04 INFO - Cleaning up... 02:53:05 INFO - Return code: 0 02:53:05 INFO - Running post-action listener: _resource_record_post_action 02:53:05 INFO - Running post-action listener: _start_resource_monitoring 02:53:05 INFO - Starting resource monitoring. 02:53:05 INFO - ##### 02:53:05 INFO - ##### Running install step. 02:53:05 INFO - ##### 02:53:05 INFO - Running pre-action listener: _resource_record_pre_action 02:53:05 INFO - Running main action method: install 02:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:05 INFO - Reading from file tmpfile_stdout 02:53:05 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:05 INFO - Reading from file tmpfile_stdout 02:53:05 INFO - Output received: 02:53:05 INFO - Usage: mozinstall [options] installer 02:53:05 INFO - Options: 02:53:05 INFO - -h, --help show this help message and exit 02:53:05 INFO - -d DEST, --destination=DEST 02:53:05 INFO - Directory to install application into. [default: 02:53:05 INFO - "/builds/slave/test"] 02:53:05 INFO - --app=APP Application being installed. [default: firefox] 02:53:05 INFO - mkdir: /builds/slave/test/build/application 02:53:05 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'] 02:53:05 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 02:53:18 INFO - Reading from file tmpfile_stdout 02:53:18 INFO - Output received: 02:53:18 INFO - /builds/slave/test/build/application/firefox/firefox 02:53:18 INFO - Running post-action listener: _resource_record_post_action 02:53:18 INFO - ##### 02:53:18 INFO - ##### Running run-tests step. 02:53:18 INFO - ##### 02:53:18 INFO - Running pre-action listener: _resource_record_pre_action 02:53:18 INFO - Running main action method: run_tests 02:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:53:18 INFO - Python 2.7.3 02:53:18 INFO - Return code: 0 02:53:18 INFO - grabbing minidump binary from tooltool 02:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:18 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 0x2478410>, '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 0x2479310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24797a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:53:18 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 02:53:18 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 02:53:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:53:18 INFO - Return code: 0 02:53:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:53:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:53:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:53:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:53:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:53:19 INFO - Return code: 0 02:53:19 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:53:19 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:53:19 INFO - Using env: {'DISPLAY': ':0', 02:53:19 INFO - 'HOME': '/home/cltbld', 02:53:19 INFO - 'LANG': 'en_US.UTF-8', 02:53:19 INFO - 'LANGUAGE': 'en_US:en', 02:53:19 INFO - 'LOGNAME': 'cltbld', 02:53:19 INFO - 'MAIL': '/var/mail/cltbld', 02:53:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:19 INFO - 'MOZ_NO_REMOTE': '1', 02:53:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:19 INFO - 'NO_EM_RESTART': '1', 02:53:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:19 INFO - 'PWD': '/builds/slave/test', 02:53:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:19 INFO - 'SHELL': '/bin/bash', 02:53:19 INFO - 'SHLVL': '1', 02:53:19 INFO - 'TERM': 'linux', 02:53:19 INFO - 'TMOUT': '86400', 02:53:19 INFO - 'USER': 'cltbld', 02:53:19 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826', 02:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:19 INFO - '_': '/tools/buildbot/bin/python'} 02:53:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:53:19 INFO - mozversion application_buildid: 20160621001202 02:53:19 INFO - mozversion application_changeset: 2a762ba88494113dff67f29216fadbabd9c03097 02:53:19 INFO - mozversion application_display_name: Firefox 02:53:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:53:19 INFO - mozversion application_name: Firefox 02:53:19 INFO - mozversion application_remotingname: firefox 02:53:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:53:19 INFO - mozversion application_vendor: Mozilla 02:53:19 INFO - mozversion application_version: 48.0 02:53:19 INFO - mozversion platform_buildid: 20160621001202 02:53:19 INFO - mozversion platform_changeset: 2a762ba88494113dff67f29216fadbabd9c03097 02:53:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:53:19 INFO - mozversion platform_version: 48.0 02:53:19 INFO - using testdate: 1466502799 02:53:19 INFO - actual date: 1466502799 02:53:19 INFO - starting webserver on 'localhost:49730' 02:53:19 INFO - SUITE-START | Running 2 tests 02:53:19 INFO - TEST-START | dromaeo_css 02:53:19 INFO - operating with platform_type : linux_ 02:53:19 INFO - Initialising browser for dromaeo_css test... 02:53:19 INFO - TEST-INFO | started process 12400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi1LURK/profile http://localhost:49730/getInfo.html) 02:53:23 INFO - PROCESS | 12400 | __metrics Screen width/height:1600/1200 02:53:23 INFO - PROCESS | 12400 | colorDepth:24 02:53:23 INFO - PROCESS | 12400 | Browser inner width/height: 1024/697 02:53:23 INFO - PROCESS | 12400 | __metrics 02:53:24 ERROR - PROCESS | 12400 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:53:25 INFO - TEST-INFO | 12400: exit 0 02:53:25 INFO - Browser initialized. 02:53:25 INFO - Running cycle 1/1 for dromaeo_css test... 02:53:25 INFO - TEST-INFO | started process 12488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi1LURK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:37 INFO - PROCESS | 12488 | RSS: Main: 141561856 02:53:37 INFO - PROCESS | 12488 | 02:54:29 INFO - PROCESS | 12488 | 1466502869082 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] 02:56:36 INFO - PROCESS | 12488 | Cycle 1(1): loaded http://localhost:49730/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49730/tests/dromaeo/cssquery-ext.html) 02:56:37 INFO - PROCESS | 12488 | RSS: Main: 240197632 02:56:37 INFO - PROCESS | 12488 | 02:59:39 INFO - PROCESS | 12488 | Cycle 1(1): loaded http://localhost:49730/tests/dromaeo/cssquery-ext.html (next: http://localhost:49730/tests/dromaeo/cssquery-jquery.html) 02:59:39 INFO - PROCESS | 12488 | RSS: Main: 224870400 02:59:39 INFO - PROCESS | 12488 | 03:02:41 INFO - PROCESS | 12488 | Cycle 1(1): loaded http://localhost:49730/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49730/tests/dromaeo/cssquery-mootools.html) 03:02:42 INFO - PROCESS | 12488 | RSS: Main: 214941696 03:02:42 INFO - PROCESS | 12488 | 03:05:44 INFO - PROCESS | 12488 | Cycle 1(1): loaded http://localhost:49730/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49730/tests/dromaeo/cssquery-prototype.html) 03:05:44 INFO - PROCESS | 12488 | RSS: Main: 220549120 03:05:44 INFO - PROCESS | 12488 | 03:08:47 INFO - PROCESS | 12488 | Cycle 1(1): loaded http://localhost:49730/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49730/tests/dromaeo/cssquery-yui.html) 03:08:47 INFO - PROCESS | 12488 | RSS: Main: 183898112 03:08:47 INFO - PROCESS | 12488 | 03:11:50 INFO - PROCESS | 12488 | Cycle 1(1): loaded http://localhost:49730/tests/dromaeo/cssquery-yui.html (next: http://localhost:49730/tests/dromaeo/cssquery-dojo.html) 03:11:50 INFO - PROCESS | 12488 | RSS: Main: 255770624 03:11:50 INFO - PROCESS | 12488 | 03:11:50 INFO - PROCESS | 12488 | __start_tp_report 03:11:50 INFO - PROCESS | 12488 | _x_x_mozilla_page_load 03:11:50 INFO - PROCESS | 12488 | _x_x_mozilla_page_load_details 03:11:50 INFO - PROCESS | 12488 | |i|pagename|runs| 03:11:50 INFO - PROCESS | 12488 | |0;dojo.html;3294.341131773645;3347.263602007559;3350.8994730158097;3398.031561005114;3400.931981360373;5542.196381524676;5557.694326812024;5568;5581.804636837712;5587.357453892809;5569.582281328896;5610.859728506789;5611.186377975191;5617.691026993513;5654.953833540798;4980.8505744827535;4996.625253106014;5045.167547354691;5145.511176438233;5181.01560703467;5078.923816142761;5156.20078887773;5157.690538567698;5176;5189;5211.869703257411;5214.634975551713;5240.842774716764;5251.159814429692;5257.7108259045735;5236.921446178291;5250.976059668366;5268.578513718893;5271.314729085233;5295.4969277918535;4959.677620954626;4975.950240497585;5003.124453220708;5150.896982060375;5165.431802501722;5500.3949565547755;5558.86102847428;5561.221428999943;5566.972165139189;5569.749361278752;6034.155218269446;6038.3659715729655;6068;6088.1476593276975;6117.877642447171;5973.133895585116;5990.400959904018;5999.580029397944;6158.384161583851;6169.383061693795;5707.686077265748;5708.229389032511;5733.054046082391;5735.942640573624;5738.42615738427;6230.283517395557;6253.405926436982;6254.687265636791;6255.624662520263;6256.718447669866;5775.104858746901;5914.792982245601;5978.701064946736;6010.158577799111;6010.729517171738;5964.373740757244;5970.791022314198;5971.671558064349;5974.193483879708;5975.372585878507;5941.138534912414;5952.9107063394085;5956.55325850563;5959.731812068468;5962.821115366546;5918.615290006222;6068.059450785136;6116.366205733216;6125.17440701618;6127.234095738033;4615.9076818463445;4619.122366750306;4637.327587499861;4639.37368455261;4640.8375706850775;4113.259613269581;4142.2543942090115;4153.314703074019;4160.479940007499;4169.812358443877;5632.9436705632415;5802.24570805801;5826.096954971986;5844.47399734026;5872.7357268923;6103.115048317969;6114.847128821815;6117.388261173847;6120.1737765401995;6128.295246046761;5602.663840169603;5786.566007549451;5795.565332600072;5797.652140871562;5798.10129429939;5131.948680513222;5163.741812909339;5172.8965420691375;5194.272801807674;5194.4805519447755;6315.179026726496;6333.96833015832;6340.461060809791;6340.873182536416;6342.873142537216;5883.294004719461;6047.395260474005;6075.848103797441;6105.877882442415;6110.26676798787;6270.372962703693;6290.528210384331;6293.402126797947;6293.527985401021;6295.653739044396;5941.58408911372;5949.196858424058;5950.375210602998;5952.166696662384;5991.281046274475;5840.1531777892815;6006.579539432198;6053.424924632153;6093;6135.998322733915;5857.677827719346;5865.706714664335;5906.852328691817;5908.793192238251;5918.644881307136;5832.912506312494;5880.029795083763;5886;5893.2044174035955;5895.322037965689;5565.471280228534;5663.603547751618;5737.282839645044;5755.913661295001;5806.5645076618575;5903.409659034062;5910.438508341701;5910.674912879833;5921.023031199976;5921.851953701192;5767.077267637158;5767.279090113736;5767.653940763567;5773.509251713652;5802.970985145216 03:11:50 INFO - PROCESS | 12488 | |1;ext.html;670.8322919270182;680.2449281297762;686.2794066230458;739.9788292156826;751.1136858506961;35791.13670906328;36737.81631091844;38929.22141557171;39418.408723869165;39492.21015579686;43006;43386;43457.56542434575;43518.56481435185;43576.78211608937;8089.191080891923;8813.1627495388;8871.866921996176;8891.777705557348;10310.381377117359;10517.579296828118;10659.626913058044;10672.146228301717;10678.35929844208;10679.946600267027;10658.307210031362;10704.090152337061;10745.731356716105;10752.301100428485;10755.946220268888;10504.159667226604;10573.73565660857;10578;10585.417802020886;10587.576496940113;10304.227182961307;10435.582576696923;10468.214883883738;10772.946135269352;10783.299085559493;43472.565274347166;43909;44076.55923440788;44104.117917641786;44116;3804.1630841214887;3942.56631770505;4210.200061988213;4420.09388075447;4629.166749985001;29787.851060744775;29824.254393640116;29950.101496954907;30372;31071.689283107105;4583.175028494869;4586.909337103499;4606.239970404879;4619.3994780678295;4647.302904564309;222625;223155;223368;224696.876515618;227149;58000.12999805006;63680;64347;64428.67785661042;64430.355696443374;68974;70774;70812.2918770816;70818.2918170822;70819;19040.428787136407;19216.71174932377;19250.80749192518;19262.518437039187;19276.32532861371;13718.108322958975;14579.854201458062;15018.624534386729;15070.623234419008;15070.698586028218;19608.509787255432;19634;19876.50308742264;19960.3013894513;19967.600647986957;7138.9286107139305;7457.179710231871;7547.28300811422;7679.2704693054075;7697.807554811175;1081.5781845080267;1115.5091759625739;1141.6632093532428;1165.242592315002;1180.1856718863955;33467.83266083654;34275.65724342775;34352.31295374079;34359.312813743585;34372.14069648229;1161.5469966712988;1207.9456424460745;1256.58532684214;1307.718840449289;1314.1786383510307;17734.733978990327;17949.7307540387;17986.280548778162;18076.291038774805;18216.63566728658;487559;519970;530366;530792;531148;63213.68393158097;64522.35477645257;64576.35423645798;64599.35400645933;64762;1425.4939496478808;1508.1554329575254;1520.1107352198867;1543.1204213598367;1547.3733138079097;30324.393512129194;32472.51291230586;32715.836420818694;33010.17474563155;34454;51435.48564514307;52238.47761522336;52323;52396.21405678994;52493.47506524886;367384;368189;368682;369305;369919.8048117122;28111.71888281173;30472.695273047873;30761.8461907689;31094.378112438077;31380.686193137775;42789.35815962825;42842.57157428386;43264;43984.560154398045;44321.335179971684;36001.63998360088;36065;36307.45538816973;36317.45523817092;36587.63412365842;37097.443538347485;39681.80159099186;39725.40411893766;39811.40282895817;39975.80012099921;41537;42329.78835105805;42426;42450.575494244666;42549.14901701887;34524;36134.819325903205;36288.63711362852;36314.27371452609;37203.06992325214;27962.72037279601;27967.44065118727;28567.42865142644;28567.857160714895;28623.856880715462 03:11:50 INFO - PROCESS | 12488 | |2;jquery.html;439.6197289344716;445.32310887451075;450.6394884092725;451.668024002358;459.27205379473514;18956;19674.016299185037;19676.508087297807;20970.580588388224;21455.892720536416;19859.900700496477;20070.799292007076;20524.179032838667;20751.688724669104;20810;5706.65760054397;5871.178035075093;5914.704264786765;5920.733566989475;5924.644521328723;4396.89007774805;5831.4751672349485;6050.304215015286;6410.679466026703;6432.839179020515;6367.267764207129;6372.713227904732;6393;6394.5843520171275;6401.16784817973;5749.396313387076;6008.879822403571;6025.698715064251;6034.48706859913;6037.305709843358;4067.6542493888055;5721.713914304268;5879.029960056629;5942.049272116441;5951.821445356646;14623.341949612293;14673.926630366886;14691.63270918225;20127.39617811468;24343.878280608482;2572.3054775210776;2684.7315268473194;2825.265430987937;3209.2618697699427;3215.694509021639;10489.160867130688;10913.672589822318;10971.890281097167;11098.667039988813;11151.553937842476;1941.417574727576;1961.3331467301186;1992.721019057333;2028;2082.916683332665;75335.24664753392;78396;80667;80896.59551702262;81890.59054704748;10638.202134839918;10954.835677464844;11245.718857028476;11533.423328833525;11659.06727461801;15621.453249136226;16126.354945802272;16290.67418651644;16316.265768040466;16326.183690815411;8198.098209196984;8327.292180164754;8570.914290857136;8654.48073115615;8685.739427817176;8806.075362086889;8836.337274704423;8848.778780530538;8943.150400712053;8966.148215919477;4400.141972315368;4461.040876211565;4473;4475.70907890986;4544.431946006749;1791.2387235424892;1903.7715474143192;2030.796920307987;2054.6301665700316;2072.8549001570045;990.3513198854762;1036.8081904847627;1061.0874647802884;1082.98199692289;1104.5471356743697;19358.903205483883;19448.513787155433;19534.70697939532;19699.606007879764;20216.191352346035;1057;1069.7967386196597;1122.5004872831676;1137.9203455758184;1152.3093576498802;10814.35113893169;11215.111389772223;11216.853182393388;11229.562912851552;11241.100711943025;505754;507821;511223;528402;539398;93738;96148;96428;96863.51568242254;96991.51504242574;1100.7688385439149;1147.0536807134147;1174.3423682737694;1187.8871507206802;1210.2375503432957;17082.572935676708;17149.742753858452;17633.118344083003;17997.64004719872;18041.458756237334;39186.80406598063;39302.41046384249;39729;40074.79962600168;40459.59540404558;52116.21825672542;52185.7390713044;54804.45195547993;55210;56576.434235657114;9208.493532855757;9323.440593564408;9380.812383752424;9440.244780417688;9531.857022144535;10519.684409467729;13666.93166534161;13671;13712.862871371159;13738.450461981409;11788.76422471563;11986.580469683518;12149;12221.511139554319;12226;11573.652790416301;11911.583094591648;11955.521779128738;12063.819042714542;12241.510339586317;12431;12457.314847683465;12508.687282818002;12619.116661833583;12781.48874045065;8579.099194584729;8870.201681848665;8891.64433422656;9358.625654973725;9545.236381089357;11495.425228738697;12077.39613019363;12129.75740485203;12208.328541929925;12284.631461056182 03:11:50 INFO - PROCESS | 12488 | |3;mootools.html;1472.5508719840457;1571.5599632103012;1583.358739710417;1788.3293764838186;1949.756280464941;8285.54429506377;8439.70461033864;8453.957730211341;8458.66165353385;8470.152984701534;8243.258106770389;8386.077531471534;8415.074341822394;8415.747527574167;8426.199511046441;2425.454272788622;2440.8535487870695;2445.4742230420457;2446.1438496526252;2453.6932883389577;2464.155916769836;2503.0738626708053;2515.5975043992967;2528.115159694111;2542.758437948392;2406.470576473182;2419.443527988564;2429.5991161458337;2430.8419952703016;2449.8775061246956;2445.645381419702;2463.0640356664444;2467.2968204061935;2471.765182307678;2491.725910149882;2453.7423570525193;2481.969982457278;2502.186789293487;2503.962440563393;2505.949881002388;8269.669213231464;8473.745787626382;8474.915250847474;8544.273736732384;8553.828923421497;5301.151815709506;5433.945660543423;5437.048516509595;5440.591955603306;5453.83638490842;3610.5667319921777;3619.6199399063244;3637.527121474218;3671.596124426311;3718.4050551911564;1167.8131498960126;1193.6777070191;1198.1553005131361;1209.6129238643637;1245.1097465312346;11428.485718142703;11881.227720198245;11930.821037684442;11956.2228455151;12060.879391206063;4405.933910991338;4522.186006518858;4580.748058856728;4636.466806317249;4640.605548528345;9599.712008639752;9612.75968100803;9622.278329125344;9638;9660.613575457044;5286.7356632169;5299.735013249322;5308.177232528964;5309.123994540934;5312.92030619541;4343.587359200934;4410.051838854662;4417.646588272931;4641.791119399635;4914.066327397783;4101.569335219819;4226.4716910386205;4285.657147428198;4298.505671847715;4376.12477504494;1351.9188848669112;1354.343143575365;1361.4962463888426;1369.869862363094;1383.2737812648238;1027.0345874877592;1079.6707004363745;1082.6643740440331;1088.4068182840372;1097.7639807441437;5890.67601281925;5988.970055149696;6010.849728756729;6129.417705317987;6197.4732147767045;483.5986131510838;483.8645179349788;488.07266194230533;1107.479484642217;1130.6608017594854;4109.404136400205;4146.5853414658895;4151.8546850860075;4162.105147393325;4181.435506206684;9980.700578982642;10284.948575257076;10348.637797677196;10374.17006639467;10396.324238924597;10149.847752283722;10218.897811021943;10229.539670714836;10245.436500992368;10270.435126067989;7987.720429784929;8102.351811855037;8121.269085782308;8196.631151598192;8203.548804815673;5670;5738.340090889601;5744.569157313134;5783.132530120515;5885.323187833283;9472.194863436685;9494.05059494045;9584.185344245818;9665.468399238109;9682.70951871445;9679.758006049906;9694;9769.071938165864;9831.950840245752;10017.449040302561;6514;7031.648417579203;7195.496315258091;7291.052163218747;7305.269473052652;8141.755747327589;8162.6734930602115;8228;8239.093699693149;8241.093479717347;7325.4872158948365;7483.214262502576;7530.472866899265;7615.086189657277;7696.499727517694;7393.408527317909;7466.775996720107;7468.365188958999;7498.925010749823;7581.734639287599;6778.118844550177;6826.590404575742;6826.692798823966;6832.487563432663;6836.487263455161;4937.382827146606;5104.3619547556555;5137;5167.069927413102;5191.870203244949;5114.3862736471865;5164.793408263778;5173.379194496684;5184.377874655065;5362.51737343641 03:11:50 INFO - PROCESS | 12488 | |4;prototype.html;354.397524208845;364.18241048845346;365.22025475609576;367.18668150047637;367.97608155469885;6066.241719785027;6150.200473938393;6233.2208473940755;6264.467520260783;6271.466925311348;6169.0437982112735;6290.842728931779;6296.370362963701;6318.241810982689;6322.841928951779;4849.612031037508;4851.2238041913215;4852.223644216926;4857.149998750222;4872.7563621818945;4622.537746225367;4713.175194340976;4845.176320025586;4849.636277279201;4857.951420485803;4786.545278198566;4792;4797.52024797521;4805.303231031498;4816.349792777965;4788.545088216614;4792.592629626486;4794.161021821167;4803.61571074315;4810.110129625996;4237.87286381406;4245.702800803945;4246.7027308088445;4252.957470425287;4256.4679415073115;6008.188894499231;6021.126936594169;6026.427489388501;6038.124471951586;6043.305019922677;5337.386200586943;5601.831945041656;5605.327360716699;5621.100623900156;5622.044252477089;6498.0577816216855;6506.7722629708205;6553.082568440422;6569.310222426672;6572.901406478906;4613.7923793429045;4619.907601847978;4622.768861556909;4623.953760462419;4630.097131059445;6864.2106157791995;6927.064846245743;6936;6944.4097251733665;6948.965255173692;4721.386219791405;4723.645726570452;4726;4730.219513780256;4734.384530011145;4581.9541804582195;4784.784684689197;4789.712617242976;4793.592544633675;4798.856034318976;5397.136458166675;5398.406175320712;5402.810901618424;5434.64674796137;5454.181872719124;6537;6545.476361891037;6554.836129096715;6562.343765623399;6576.04647326135;1606.020327600163;1639.1148779658852;1679.4373884748502;1685.2416412614127;1685.3679870048732;1101.2456467319912;1112.6995711157942;1120.9327440353604;1123.556195302867;1127.3405058040973;6326.114343991845;6335.619862808154;6391.936080639134;6428.132202152649;6431.935680643227;6752.729890804411;6766.18805743314;6766.594004359754;6777.559458635173;6777.898331525031;6403.903941440882;6407.231132264158;6411.743530258831;6415.711292991827;6443.613383197023;3605.7295702822394;3639.090227443139;3645.3985092459448;3649.379605467077;3651.689606383487;7016.508844380946;7059.89410158848;7230.855382892312;7238.0952380952385;7241.818954526074;6988.126484189476;7000.579965202104;7007.404370628452;7017.578945263301;7021.964890175618;7205.2434494378385;7206.711731530785;7208.567485950754;7212.350888419963;7216.494845360774;6898.517103802686;6909.896351554831;6914.9308506914285;6918.273581273894;6918.481113916577;6567.376099270562;6800.149981252343;6818.215905170969;6823.215330237086;6838.623875686885;7143;7169.35475807159;7182.461315401261;7205.855882882418;7210.71157153708;4738.7867545959825;4766.594839438687;4769.9046019080115;4776.21192503233;4781.258904869751;6518.348165183444;6667.933130699065;6870.244273130052;6874.518783685094;6875.07186529812;6626.072349870926;6657.6005439671835;6663;6663.900041499284;6674.966625166843;6642.90035649456;6649.900251496135;6650.73397064112;6652.866942661217;6661.433778128913;6533.836654083686;6535.869282614416;6548.3124271950755;6551.770688025897;6552.3775241352;6510.056041873996;6647.368499992493;6676.265610782712;6692.230393504809;6706.631135287411;6469.611823290617;6521;6521.673916304071;6528.118703974903;6539.182602174728 03:11:50 INFO - PROCESS | 12488 | |5;yui.html;875.1598465473146;933.985990210147;937.9906200937988;950;961.8461046232604;14579.19814410207;14848.554543363703;14878.776818347733;14887;14916.7016659667;13899.096558723675;13957.860421395782;13963.860361396382;13990.510332138378;13995.65010874726;755.8148253677842;886.57887503436;891.0866361978991;891.9821603567925;895.789489469974;882.1002577371078;892.3887137310962;892.3976315986683;895.2479916869828;915.5330781301551;929.8884133903941;930.0513476254216;930.1117432851611;931.1479995803832;959.0217977662815;819.397742659145;953.4898829126419;964.71058682395;964.7636329099415;966.0146650416535;711.4770643576967;712;712.1952194020723;713.0552018575409;714.4641518860855;14017.229052402114;14019.43922243109;14030.579082627537;14060.296985150804;14068.155910645291;14542.854571454362;14794.55616331501;15047.172405517693;15517.068975861484;15653.608659783482;12149.878501214964;12280.815787763191;12430;12431.254124752544;12432.75134497314;4047.6357127858632;4096.139810639769;4117.855875044359;4136.896577585554;4166.91666166675;56852.71573642105;59003.704981475246;59132.99999999957;59169;59270.40729592692;11622.593209237637;11903.583374582022;11905.702357441134;12047.096467764954;12233.755324893453;22299.331020069425;22441;22553.4361640957;22580;22613.321600352017;8635.740927772176;8732.78168045804;8751.737447876574;8769.824603507894;8779.25376343018;4880.829170978998;4986.052649996489;5040.47075057121;5076.162433198481;5076.898462030738;3709.7588656737225;3785.772853628791;3792.962070379316;3794.734368594227;3796.6013568574904;638.8370965403792;666.8099591616464;672.357898207211;673.4578664175386;673.7473447457204;708.2952462300044;790.3874497264666;815.9592020398957;819.9918000820035;827.5034979012664;9742.659006934866;10016.64941727036;10188.694339169837;10281.434521101412;10296;730.4704089535045;791.0625908298684;793.7698067560343;798.2416704130983;809.2595275323131;4573.519780423074;4643.535646435397;4764.6664733469015;4782.234842425265;4795.184818580849;69661;70959.64520177366;71792.28207717961;72046;72179;55477.722611386685;55647.72176139093;56440.43559564352;58572.41427585755;59313.703431482565;48308.516914830405;48455.515444845805;48976.265356019685;49580.75209623929;50298.748506257965;9149.5882685278;9150.496722680316;9171.908280917372;9229.35394522377;9400;38727.80636096802;38916.2216755669;39499.80250098846;39713.60286397099;40084.19831603293;45803;48464;51612;51935;52499;10976.890231097586;11561.710957226136;12048.698782530508;12095.153339266168;12137.635870923887;12852.357382131044;12957.287349195885;13181.934090329487;13233.602991910258;13284.867151328363;12047.578334758242;12373.602582074342;12594.748105038032;12830.67923301925;13264.933675331948;12000.39998000079;12208.694782630506;12617.432215550505;12804.48782048745;12827.551035713705;12605.873941260837;12625.621231363073;12819.230846149261;12970.740585188432;13207;9691.612335506501;9743.967215071552;9948.154406875497;9994.150497207818;10271.640492582725;9968.700938971842;10575.841362379417;10613.575456981634;10844.837327439936;10876.510557024794 03:11:50 INFO - PROCESS | 12488 | __end_tp_report 03:11:50 INFO - PROCESS | 12488 | __start_cc_report 03:11:50 INFO - PROCESS | 12488 | _x_x_mozilla_cycle_collect,797 03:11:50 INFO - PROCESS | 12488 | __end_cc_report 03:11:50 INFO - PROCESS | 12488 | __startTimestamp1466503910344__endTimestamp 03:11:50 INFO - PROCESS | 12488 | 03:11:50 INFO - PROCESS | 12488 | ------- Summary: start ------- 03:11:50 INFO - PROCESS | 12488 | Number of tests: 6 03:11:50 INFO - PROCESS | 12488 | 03:11:50 INFO - PROCESS | 12488 | [#0] dojo.html Cycles:165 Average:5616.14 Median:5806.56 stddev:629.20 (10.8%) stddev-sans-first:604.19 03:11:50 INFO - PROCESS | 12488 | Values: 3294.3 3347.3 3350.9 3398.0 3400.9 5542.2 5557.7 5568.0 5581.8 5587.4 5569.6 5610.9 5611.2 5617.7 5655.0 4980.9 4996.6 5045.2 5145.5 5181.0 5078.9 5156.2 5157.7 5176.0 5189.0 5211.9 5214.6 5240.8 5251.2 5257.7 5236.9 5251.0 5268.6 5271.3 5295.5 4959.7 4976.0 5003.1 5150.9 5165.4 5500.4 5558.9 5561.2 5567.0 5569.7 6034.2 6038.4 6068.0 6088.1 6117.9 5973.1 5990.4 5999.6 6158.4 6169.4 5707.7 5708.2 5733.1 5735.9 5738.4 6230.3 6253.4 6254.7 6255.6 6256.7 5775.1 5914.8 5978.7 6010.2 6010.7 5964.4 5970.8 5971.7 5974.2 5975.4 5941.1 5952.9 5956.6 5959.7 5962.8 5918.6 6068.1 6116.4 6125.2 6127.2 4615.9 4619.1 4637.3 4639.4 4640.8 4113.3 4142.3 4153.3 4160.5 4169.8 5632.9 5802.2 5826.1 5844.5 5872.7 6103.1 6114.8 6117.4 6120.2 6128.3 5602.7 5786.6 5795.6 5797.7 5798.1 5131.9 5163.7 5172.9 5194.3 5194.5 6315.2 6334.0 6340.5 6340.9 6342.9 5883.3 6047.4 6075.8 6105.9 6110.3 6270.4 6290.5 6293.4 6293.5 6295.7 5941.6 5949.2 5950.4 5952.2 5991.3 5840.2 6006.6 6053.4 6093.0 6136.0 5857.7 5865.7 5906.9 5908.8 5918.6 5832.9 5880.0 5886.0 5893.2 5895.3 5565.5 5663.6 5737.3 5755.9 5806.6 5903.4 5910.4 5910.7 5921.0 5921.9 5767.1 5767.3 5767.7 5773.5 5803.0 03:11:50 INFO - PROCESS | 12488 | 03:11:50 INFO - PROCESS | 12488 | [#1] ext.html Cycles:180 Average:55145.99 Median:36211.73 stddev:103442.54 (285.7%) stddev-sans-first:103651.86 03:11:50 INFO - PROCESS | 12488 | Values: 670.8 680.2 686.3 740.0 751.1 35791.1 36737.8 38929.2 39418.4 39492.2 43006.0 43386.0 43457.6 43518.6 43576.8 8089.2 8813.2 8871.9 8891.8 10310.4 10517.6 10659.6 10672.1 10678.4 10679.9 10658.3 10704.1 10745.7 10752.3 10755.9 10504.2 10573.7 10578.0 10585.4 10587.6 10304.2 10435.6 10468.2 10772.9 10783.3 43472.6 43909.0 44076.6 44104.1 44116.0 3804.2 3942.6 4210.2 4420.1 4629.2 29787.9 29824.3 29950.1 30372.0 31071.7 4583.2 4586.9 4606.2 4619.4 4647.3 222625.0 223155.0 223368.0 224696.9 227149.0 58000.1 63680.0 64347.0 64428.7 64430.4 68974.0 70774.0 70812.3 70818.3 70819.0 19040.4 19216.7 19250.8 19262.5 19276.3 13718.1 14579.9 15018.6 15070.6 15070.7 19608.5 19634.0 19876.5 19960.3 19967.6 7138.9 7457.2 7547.3 7679.3 7697.8 1081.6 1115.5 1141.7 1165.2 1180.2 33467.8 34275.7 34352.3 34359.3 34372.1 1161.5 1207.9 1256.6 1307.7 1314.2 17734.7 17949.7 17986.3 18076.3 18216.6 487559.0 519970.0 530366.0 530792.0 531148.0 63213.7 64522.4 64576.4 64599.4 64762.0 1425.5 1508.2 1520.1 1543.1 1547.4 30324.4 32472.5 32715.8 33010.2 34454.0 51435.5 52238.5 52323.0 52396.2 52493.5 367384.0 368189.0 368682.0 369305.0 369919.8 28111.7 30472.7 30761.8 31094.4 31380.7 42789.4 42842.6 43264.0 43984.6 44321.3 36001.6 36065.0 36307.5 36317.5 36587.6 37097.4 39681.8 39725.4 39811.4 39975.8 41537.0 42329.8 42426.0 42450.6 42549.1 34524.0 36134.8 36288.6 36314.3 37203.1 27962.7 27967.4 28567.4 28567.9 28623.9 03:11:50 INFO - PROCESS | 12488 | 03:11:50 INFO - PROCESS | 12488 | [#2] jquery.html Cycles:180 Average:29860.12 Median:11526.75 stddev:85347.37 (740.4%) stddev-sans-first:85558.20 03:11:50 INFO - PROCESS | 12488 | Values: 439.6 445.3 450.6 451.7 459.3 18956.0 19674.0 19676.5 20970.6 21455.9 19859.9 20070.8 20524.2 20751.7 20810.0 5706.7 5871.2 5914.7 5920.7 5924.6 4396.9 5831.5 6050.3 6410.7 6432.8 6367.3 6372.7 6393.0 6394.6 6401.2 5749.4 6008.9 6025.7 6034.5 6037.3 4067.7 5721.7 5879.0 5942.0 5951.8 14623.3 14673.9 14691.6 20127.4 24343.9 2572.3 2684.7 2825.3 3209.3 3215.7 10489.2 10913.7 10971.9 11098.7 11151.6 1941.4 1961.3 1992.7 2028.0 2082.9 75335.2 78396.0 80667.0 80896.6 81890.6 10638.2 10954.8 11245.7 11533.4 11659.1 15621.5 16126.4 16290.7 16316.3 16326.2 8198.1 8327.3 8570.9 8654.5 8685.7 8806.1 8836.3 8848.8 8943.2 8966.1 4400.1 4461.0 4473.0 4475.7 4544.4 1791.2 1903.8 2030.8 2054.6 2072.9 990.4 1036.8 1061.1 1083.0 1104.5 19358.9 19448.5 19534.7 19699.6 20216.2 1057.0 1069.8 1122.5 1137.9 1152.3 10814.4 11215.1 11216.9 11229.6 11241.1 505754.0 507821.0 511223.0 528402.0 539398.0 93738.0 96148.0 96428.0 96863.5 96991.5 1100.8 1147.1 1174.3 1187.9 1210.2 17082.6 17149.7 17633.1 17997.6 18041.5 39186.8 39302.4 39729.0 40074.8 40459.6 52116.2 52185.7 54804.5 55210.0 56576.4 9208.5 9323.4 9380.8 9440.2 9531.9 10519.7 13666.9 13671.0 13712.9 13738.5 11788.8 11986.6 12149.0 12221.5 12226.0 11573.7 11911.6 11955.5 12063.8 12241.5 12431.0 12457.3 12508.7 12619.1 12781.5 8579.1 8870.2 8891.6 9358.6 9545.2 11495.4 12077.4 12129.8 12208.3 12284.6 03:11:50 INFO - PROCESS | 12488 | 03:11:50 INFO - PROCESS | 12488 | [#3] mootools.html Cycles:180 Average:5673.01 Median:5020.87 stddev:3066.79 (61.1%) stddev-sans-first:3059.14 03:11:50 INFO - PROCESS | 12488 | Values: 1472.6 1571.6 1583.4 1788.3 1949.8 8285.5 8439.7 8454.0 8458.7 8470.2 8243.3 8386.1 8415.1 8415.7 8426.2 2425.5 2440.9 2445.5 2446.1 2453.7 2464.2 2503.1 2515.6 2528.1 2542.8 2406.5 2419.4 2429.6 2430.8 2449.9 2445.6 2463.1 2467.3 2471.8 2491.7 2453.7 2482.0 2502.2 2504.0 2505.9 8269.7 8473.7 8474.9 8544.3 8553.8 5301.2 5433.9 5437.0 5440.6 5453.8 3610.6 3619.6 3637.5 3671.6 3718.4 1167.8 1193.7 1198.2 1209.6 1245.1 11428.5 11881.2 11930.8 11956.2 12060.9 4405.9 4522.2 4580.7 4636.5 4640.6 9599.7 9612.8 9622.3 9638.0 9660.6 5286.7 5299.7 5308.2 5309.1 5312.9 4343.6 4410.1 4417.6 4641.8 4914.1 4101.6 4226.5 4285.7 4298.5 4376.1 1351.9 1354.3 1361.5 1369.9 1383.3 1027.0 1079.7 1082.7 1088.4 1097.8 5890.7 5989.0 6010.8 6129.4 6197.5 483.6 483.9 488.1 1107.5 1130.7 4109.4 4146.6 4151.9 4162.1 4181.4 9980.7 10284.9 10348.6 10374.2 10396.3 10149.8 10218.9 10229.5 10245.4 10270.4 7987.7 8102.4 8121.3 8196.6 8203.5 5670.0 5738.3 5744.6 5783.1 5885.3 9472.2 9494.1 9584.2 9665.5 9682.7 9679.8 9694.0 9769.1 9832.0 10017.4 6514.0 7031.6 7195.5 7291.1 7305.3 8141.8 8162.7 8228.0 8239.1 8241.1 7325.5 7483.2 7530.5 7615.1 7696.5 7393.4 7466.8 7468.4 7498.9 7581.7 6778.1 6826.6 6826.7 6832.5 6836.5 4937.4 5104.4 5137.0 5167.1 5191.9 5114.4 5164.8 5173.4 5184.4 5362.5 03:11:50 INFO - PROCESS | 12488 | 03:11:50 INFO - PROCESS | 12488 | [#4] prototype.html Cycles:180 Average:5561.22 Median:6330.87 stddev:1676.54 (26.5%) stddev-sans-first:1635.05 03:11:50 INFO - PROCESS | 12488 | Values: 354.4 364.2 365.2 367.2 368.0 6066.2 6150.2 6233.2 6264.5 6271.5 6169.0 6290.8 6296.4 6318.2 6322.8 4849.6 4851.2 4852.2 4857.1 4872.8 4622.5 4713.2 4845.2 4849.6 4858.0 4786.5 4792.0 4797.5 4805.3 4816.3 4788.5 4792.6 4794.2 4803.6 4810.1 4237.9 4245.7 4246.7 4253.0 4256.5 6008.2 6021.1 6026.4 6038.1 6043.3 5337.4 5601.8 5605.3 5621.1 5622.0 6498.1 6506.8 6553.1 6569.3 6572.9 4613.8 4619.9 4622.8 4624.0 4630.1 6864.2 6927.1 6936.0 6944.4 6949.0 4721.4 4723.6 4726.0 4730.2 4734.4 4582.0 4784.8 4789.7 4793.6 4798.9 5397.1 5398.4 5402.8 5434.6 5454.2 6537.0 6545.5 6554.8 6562.3 6576.0 1606.0 1639.1 1679.4 1685.2 1685.4 1101.2 1112.7 1120.9 1123.6 1127.3 6326.1 6335.6 6391.9 6428.1 6431.9 6752.7 6766.2 6766.6 6777.6 6777.9 6403.9 6407.2 6411.7 6415.7 6443.6 3605.7 3639.1 3645.4 3649.4 3651.7 7016.5 7059.9 7230.9 7238.1 7241.8 6988.1 7000.6 7007.4 7017.6 7022.0 7205.2 7206.7 7208.6 7212.4 7216.5 6898.5 6909.9 6914.9 6918.3 6918.5 6567.4 6800.1 6818.2 6823.2 6838.6 7143.0 7169.4 7182.5 7205.9 7210.7 4738.8 4766.6 4769.9 4776.2 4781.3 6518.3 6667.9 6870.2 6874.5 6875.1 6626.1 6657.6 6663.0 6663.9 6675.0 6642.9 6649.9 6650.7 6652.9 6661.4 6533.8 6535.9 6548.3 6551.8 6552.4 6510.1 6647.4 6676.3 6692.2 6706.6 6469.6 6521.0 6521.7 6528.1 6539.2 03:11:50 INFO - PROCESS | 12488 | 03:11:50 INFO - PROCESS | 12488 | [#5] yui.html Cycles:180 Average:15747.69 Median:48382.02 stddev:18563.70 (38.4%) stddev-sans-first:18582.18 03:11:50 INFO - PROCESS | 12488 | Values: 875.2 934.0 938.0 950.0 961.8 14579.2 14848.6 14878.8 14887.0 14916.7 13899.1 13957.9 13963.9 13990.5 13995.7 755.8 886.6 891.1 892.0 895.8 882.1 892.4 892.4 895.2 915.5 929.9 930.1 930.1 931.1 959.0 819.4 953.5 964.7 964.8 966.0 711.5 712.0 712.2 713.1 714.5 14017.2 14019.4 14030.6 14060.3 14068.2 14542.9 14794.6 15047.2 15517.1 15653.6 12149.9 12280.8 12430.0 12431.3 12432.8 4047.6 4096.1 4117.9 4136.9 4166.9 56852.7 59003.7 59133.0 59169.0 59270.4 11622.6 11903.6 11905.7 12047.1 12233.8 22299.3 22441.0 22553.4 22580.0 22613.3 8635.7 8732.8 8751.7 8769.8 8779.3 4880.8 4986.1 5040.5 5076.2 5076.9 3709.8 3785.8 3793.0 3794.7 3796.6 638.8 666.8 672.4 673.5 673.7 708.3 790.4 816.0 820.0 827.5 9742.7 10016.6 10188.7 10281.4 10296.0 730.5 791.1 793.8 798.2 809.3 4573.5 4643.5 4764.7 4782.2 4795.2 69661.0 70959.6 71792.3 72046.0 72179.0 55477.7 55647.7 56440.4 58572.4 59313.7 48308.5 48455.5 48976.3 49580.8 50298.7 9149.6 9150.5 9171.9 9229.4 9400.0 38727.8 38916.2 39499.8 39713.6 40084.2 45803.0 48464.0 51612.0 51935.0 52499.0 10976.9 11561.7 12048.7 12095.2 12137.6 12852.4 12957.3 13181.9 13233.6 13284.9 12047.6 12373.6 12594.7 12830.7 13264.9 12000.4 12208.7 12617.4 12804.5 12827.6 12605.9 12625.6 12819.2 12970.7 13207.0 9691.6 9744.0 9948.2 9994.2 10271.6 9968.7 10575.8 10613.6 10844.8 10876.5 03:11:50 INFO - PROCESS | 12488 | -------- Summary: end -------- 03:11:50 INFO - PROCESS | 12488 | 03:11:50 INFO - TEST-INFO | 12488: exit 0 03:11:50 INFO - TEST-OK | dromaeo_css | took 1111277ms 03:11:50 INFO - TEST-START | kraken 03:11:50 INFO - operating with platform_type : linux_ 03:11:50 INFO - Initialising browser for kraken test... 03:11:51 INFO - TEST-INFO | started process 12676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQEfFlB/profile http://localhost:49730/getInfo.html) 03:11:55 INFO - PROCESS | 12676 | __metrics Screen width/height:1600/1200 03:11:55 INFO - PROCESS | 12676 | colorDepth:24 03:11:55 INFO - PROCESS | 12676 | Browser inner width/height: 1024/697 03:11:55 INFO - PROCESS | 12676 | __metrics 03:11:56 ERROR - PROCESS | 12676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:11:57 INFO - TEST-INFO | 12676: exit 0 03:11:57 INFO - Browser initialized. 03:11:57 INFO - Running cycle 1/1 for kraken test... 03:11:57 INFO - TEST-INFO | started process 12768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQEfFlB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:08 INFO - PROCESS | 12768 | RSS: Main: 141131776 03:12:08 INFO - PROCESS | 12768 | 03:12:11 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49730/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:12 INFO - PROCESS | 12768 | RSS: Main: 198049792 03:12:12 INFO - PROCESS | 12768 | 03:12:14 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49730/tests/kraken/driver.html?testName=audio-dft) 03:12:15 INFO - PROCESS | 12768 | RSS: Main: 185487360 03:12:15 INFO - PROCESS | 12768 | 03:12:18 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49730/tests/kraken/driver.html?testName=audio-fft) 03:12:18 INFO - PROCESS | 12768 | RSS: Main: 274628608 03:12:18 INFO - PROCESS | 12768 | 03:12:20 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49730/tests/kraken/driver.html?testName=audio-oscillator) 03:12:21 INFO - PROCESS | 12768 | RSS: Main: 181600256 03:12:21 INFO - PROCESS | 12768 | 03:12:23 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49730/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:12:24 INFO - PROCESS | 12768 | RSS: Main: 178855936 03:12:24 INFO - PROCESS | 12768 | 03:12:27 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49730/tests/kraken/driver.html?testName=imaging-darkroom) 03:12:27 INFO - PROCESS | 12768 | RSS: Main: 213647360 03:12:27 INFO - PROCESS | 12768 | 03:12:31 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49730/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:31 INFO - PROCESS | 12768 | RSS: Main: 213090304 03:12:31 INFO - PROCESS | 12768 | 03:12:34 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49730/tests/kraken/driver.html?testName=json-parse-financial) 03:12:35 INFO - PROCESS | 12768 | RSS: Main: 213258240 03:12:35 INFO - PROCESS | 12768 | 03:12:36 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49730/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:37 INFO - PROCESS | 12768 | RSS: Main: 194830336 03:12:37 INFO - PROCESS | 12768 | 03:12:38 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49730/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:12:39 INFO - PROCESS | 12768 | RSS: Main: 198811648 03:12:39 INFO - PROCESS | 12768 | 03:12:41 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49730/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:12:42 INFO - PROCESS | 12768 | RSS: Main: 208957440 03:12:42 INFO - PROCESS | 12768 | 03:12:44 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:12:45 INFO - PROCESS | 12768 | RSS: Main: 215441408 03:12:45 INFO - PROCESS | 12768 | 03:12:47 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:12:48 INFO - PROCESS | 12768 | RSS: Main: 212668416 03:12:48 INFO - PROCESS | 12768 | 03:12:49 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:49730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49730/tests/kraken/driver.html?testName=ai-astar) 03:12:50 INFO - PROCESS | 12768 | RSS: Main: 272781312 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | __start_tp_report 03:12:50 INFO - PROCESS | 12768 | _x_x_mozilla_page_load 03:12:50 INFO - PROCESS | 12768 | _x_x_mozilla_page_load_details 03:12:50 INFO - PROCESS | 12768 | |i|pagename|runs| 03:12:50 INFO - PROCESS | 12768 | |0;ai-astar;110;111;109;109;109;110;106;109;109;110 03:12:50 INFO - PROCESS | 12768 | |1;audio-beat-detection;162;129;162;171;125;149;153;127;181;126 03:12:50 INFO - PROCESS | 12768 | |2;audio-dft;162;160;158;161;160;162;159;159;160;159 03:12:50 INFO - PROCESS | 12768 | |3;audio-fft;75;75;75;178;75;76;74;73;159;75 03:12:50 INFO - PROCESS | 12768 | |4;audio-oscillator;91;92;153;91;91;92;143;91;91;151 03:12:50 INFO - PROCESS | 12768 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;116;117 03:12:50 INFO - PROCESS | 12768 | |6;imaging-darkroom;145;145;145;145;144;145;146;145;145;146 03:12:50 INFO - PROCESS | 12768 | |7;imaging-desaturate;95;94;96;95;95;95;95;95;94;94 03:12:50 INFO - PROCESS | 12768 | |8;json-parse-financial;53;55;54;56;55;53;55;82;55;55 03:12:50 INFO - PROCESS | 12768 | |9;json-stringify-tinderbox;59;59;60;59;60;60;60;59;60;59 03:12:50 INFO - PROCESS | 12768 | |10;stanford-crypto-aes;71;73;71;79;73;73;73;73;73;72 03:12:50 INFO - PROCESS | 12768 | |11;stanford-crypto-ccm;112;120;112;113;111;120;115;111;129;126 03:12:50 INFO - PROCESS | 12768 | |12;stanford-crypto-pbkdf2;156;156;155;156;155;157;157;159;160;154 03:12:50 INFO - PROCESS | 12768 | |13;stanford-crypto-sha256-iterative;67;66;67;68;66;65;66;65;66;66 03:12:50 INFO - PROCESS | 12768 | __end_tp_report 03:12:50 INFO - PROCESS | 12768 | __start_cc_report 03:12:50 INFO - PROCESS | 12768 | _x_x_mozilla_cycle_collect,1616 03:12:50 INFO - PROCESS | 12768 | __end_cc_report 03:12:50 INFO - PROCESS | 12768 | __startTimestamp1466503970215__endTimestamp 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | ------- Summary: start ------- 03:12:50 INFO - PROCESS | 12768 | Number of tests: 14 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:1.32 (1.2%) stddev-sans-first:1.36 03:12:50 INFO - PROCESS | 12768 | Values: 110.0 111.0 109.0 109.0 109.0 110.0 106.0 109.0 109.0 110.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:157.50 stddev:20.68 (13.1%) stddev-sans-first:21.35 03:12:50 INFO - PROCESS | 12768 | Values: 162.0 129.0 162.0 171.0 125.0 149.0 153.0 127.0 181.0 126.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.33 (0.8%) stddev-sans-first:1.20 03:12:50 INFO - PROCESS | 12768 | Values: 162.0 160.0 158.0 161.0 160.0 162.0 159.0 159.0 160.0 159.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.00 stddev:39.79 (53.1%) stddev-sans-first:41.64 03:12:50 INFO - PROCESS | 12768 | Values: 75.0 75.0 75.0 178.0 75.0 76.0 74.0 73.0 159.0 75.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:91.00 stddev:27.99 (30.8%) stddev-sans-first:28.96 03:12:50 INFO - PROCESS | 12768 | Values: 91.0 92.0 153.0 91.0 91.0 92.0 143.0 91.0 91.0 151.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 03:12:50 INFO - PROCESS | 12768 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:12:50 INFO - PROCESS | 12768 | Values: 145.0 145.0 145.0 145.0 144.0 145.0 146.0 145.0 145.0 146.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:12:50 INFO - PROCESS | 12768 | Values: 95.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:55.00 stddev:8.73 (15.9%) stddev-sans-first:9.12 03:12:50 INFO - PROCESS | 12768 | Values: 53.0 55.0 54.0 56.0 55.0 53.0 55.0 82.0 55.0 55.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 03:12:50 INFO - PROCESS | 12768 | Values: 59.0 59.0 60.0 59.0 60.0 60.0 60.0 59.0 60.0 59.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:2.23 (3.1%) stddev-sans-first:2.24 03:12:50 INFO - PROCESS | 12768 | Values: 71.0 73.0 71.0 79.0 73.0 73.0 73.0 73.0 73.0 72.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:117.50 stddev:6.54 (5.6%) stddev-sans-first:6.69 03:12:50 INFO - PROCESS | 12768 | Values: 112.0 120.0 112.0 113.0 111.0 120.0 115.0 111.0 129.0 126.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:156.50 stddev:1.84 (1.2%) stddev-sans-first:1.94 03:12:50 INFO - PROCESS | 12768 | Values: 156.0 156.0 155.0 156.0 155.0 157.0 157.0 159.0 160.0 154.0 03:12:50 INFO - PROCESS | 12768 | 03:12:50 INFO - PROCESS | 12768 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 03:12:50 INFO - PROCESS | 12768 | Values: 67.0 66.0 67.0 68.0 66.0 65.0 66.0 65.0 66.0 66.0 03:12:50 INFO - PROCESS | 12768 | -------- Summary: end -------- 03:12:50 INFO - PROCESS | 12768 | 03:12:51 INFO - TEST-INFO | 12768: exit 0 03:12:51 INFO - TEST-OK | kraken | took 60117ms 03:12:51 INFO - SUITE-END | took 1171s 03:12:51 INFO - Completed test suite (00:19:31) 03:12:51 INFO - javascript benchmark 03:12:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.341131773645, 3347.263602007559, 3350.8994730158097, 3398.031561005114, 3400.931981360373, 5542.196381524676, 5557.694326812024, 5568.0, 5581.804636837712, 5587.357453892809, 5569.582281328896, 5610.859728506789, 5611.186377975191, 5617.691026993513, 5654.953833540798, 4980.8505744827535, 4996.625253106014, 5045.167547354691, 5145.511176438233, 5181.01560703467, 5078.923816142761, 5156.20078887773, 5157.690538567698, 5176.0, 5189.0, 5211.869703257411, 5214.634975551713, 5240.842774716764, 5251.159814429692, 5257.7108259045735, 5236.921446178291, 5250.976059668366, 5268.578513718893, 5271.314729085233, 5295.4969277918535, 4959.677620954626, 4975.950240497585, 5003.124453220708, 5150.896982060375, 5165.431802501722, 5500.3949565547755, 5558.86102847428, 5561.221428999943, 5566.972165139189, 5569.749361278752, 6034.155218269446, 6038.3659715729655, 6068.0, 6088.1476593276975, 6117.877642447171, 5973.133895585116, 5990.400959904018, 5999.580029397944, 6158.384161583851, 6169.383061693795, 5707.686077265748, 5708.229389032511, 5733.054046082391, 5735.942640573624, 5738.42615738427, 6230.283517395557, 6253.405926436982, 6254.687265636791, 6255.624662520263, 6256.718447669866, 5775.104858746901, 5914.792982245601, 5978.701064946736, 6010.158577799111, 6010.729517171738, 5964.373740757244, 5970.791022314198, 5971.671558064349, 5974.193483879708, 5975.372585878507, 5941.138534912414, 5952.9107063394085, 5956.55325850563, 5959.731812068468, 5962.821115366546, 5918.615290006222, 6068.059450785136, 6116.366205733216, 6125.17440701618, 6127.234095738033, 4615.9076818463445, 4619.122366750306, 4637.327587499861, 4639.37368455261, 4640.8375706850775, 4113.259613269581, 4142.2543942090115, 4153.314703074019, 4160.479940007499, 4169.812358443877, 5632.9436705632415, 5802.24570805801, 5826.096954971986, 5844.47399734026, 5872.7357268923, 6103.115048317969, 6114.847128821815, 6117.388261173847, 6120.1737765401995, 6128.295246046761, 5602.663840169603, 5786.566007549451, 5795.565332600072, 5797.652140871562, 5798.10129429939, 5131.948680513222, 5163.741812909339, 5172.8965420691375, 5194.272801807674, 5194.4805519447755, 6315.179026726496, 6333.96833015832, 6340.461060809791, 6340.873182536416, 6342.873142537216, 5883.294004719461, 6047.395260474005, 6075.848103797441, 6105.877882442415, 6110.26676798787, 6270.372962703693, 6290.528210384331, 6293.402126797947, 6293.527985401021, 6295.653739044396, 5941.58408911372, 5949.196858424058, 5950.375210602998, 5952.166696662384, 5991.281046274475, 5840.1531777892815, 6006.579539432198, 6053.424924632153, 6093.0, 6135.998322733915, 5857.677827719346, 5865.706714664335, 5906.852328691817, 5908.793192238251, 5918.644881307136, 5832.912506312494, 5880.029795083763, 5886.0, 5893.2044174035955, 5895.322037965689, 5565.471280228534, 5663.603547751618, 5737.282839645044, 5755.913661295001, 5806.5645076618575, 5903.409659034062, 5910.438508341701, 5910.674912879833, 5921.023031199976, 5921.851953701192, 5767.077267637158, 5767.279090113736, 5767.653940763567, 5773.509251713652, 5802.970985145216], "value": 5574.826577523315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.8322919270182, 680.2449281297762, 686.2794066230458, 739.9788292156826, 751.1136858506961, 35791.13670906328, 36737.81631091844, 38929.22141557171, 39418.408723869165, 39492.21015579686, 43006.0, 43386.0, 43457.56542434575, 43518.56481435185, 43576.78211608937, 8089.191080891923, 8813.1627495388, 8871.866921996176, 8891.777705557348, 10310.381377117359, 10517.579296828118, 10659.626913058044, 10672.146228301717, 10678.35929844208, 10679.946600267027, 10658.307210031362, 10704.090152337061, 10745.731356716105, 10752.301100428485, 10755.946220268888, 10504.159667226604, 10573.73565660857, 10578.0, 10585.417802020886, 10587.576496940113, 10304.227182961307, 10435.582576696923, 10468.214883883738, 10772.946135269352, 10783.299085559493, 43472.565274347166, 43909.0, 44076.55923440788, 44104.117917641786, 44116.0, 3804.1630841214887, 3942.56631770505, 4210.200061988213, 4420.09388075447, 4629.166749985001, 29787.851060744775, 29824.254393640116, 29950.101496954907, 30372.0, 31071.689283107105, 4583.175028494869, 4586.909337103499, 4606.239970404879, 4619.3994780678295, 4647.302904564309, 222625.0, 223155.0, 223368.0, 224696.876515618, 227149.0, 58000.12999805006, 63680.0, 64347.0, 64428.67785661042, 64430.355696443374, 68974.0, 70774.0, 70812.2918770816, 70818.2918170822, 70819.0, 19040.428787136407, 19216.71174932377, 19250.80749192518, 19262.518437039187, 19276.32532861371, 13718.108322958975, 14579.854201458062, 15018.624534386729, 15070.623234419008, 15070.698586028218, 19608.509787255432, 19634.0, 19876.50308742264, 19960.3013894513, 19967.600647986957, 7138.9286107139305, 7457.179710231871, 7547.28300811422, 7679.2704693054075, 7697.807554811175, 1081.5781845080267, 1115.5091759625739, 1141.6632093532428, 1165.242592315002, 1180.1856718863955, 33467.83266083654, 34275.65724342775, 34352.31295374079, 34359.312813743585, 34372.14069648229, 1161.5469966712988, 1207.9456424460745, 1256.58532684214, 1307.718840449289, 1314.1786383510307, 17734.733978990327, 17949.7307540387, 17986.280548778162, 18076.291038774805, 18216.63566728658, 487559.0, 519970.0, 530366.0, 530792.0, 531148.0, 63213.68393158097, 64522.35477645257, 64576.35423645798, 64599.35400645933, 64762.0, 1425.4939496478808, 1508.1554329575254, 1520.1107352198867, 1543.1204213598367, 1547.3733138079097, 30324.393512129194, 32472.51291230586, 32715.836420818694, 33010.17474563155, 34454.0, 51435.48564514307, 52238.47761522336, 52323.0, 52396.21405678994, 52493.47506524886, 367384.0, 368189.0, 368682.0, 369305.0, 369919.8048117122, 28111.71888281173, 30472.695273047873, 30761.8461907689, 31094.378112438077, 31380.686193137775, 42789.35815962825, 42842.57157428386, 43264.0, 43984.560154398045, 44321.335179971684, 36001.63998360088, 36065.0, 36307.45538816973, 36317.45523817092, 36587.63412365842, 37097.443538347485, 39681.80159099186, 39725.40411893766, 39811.40282895817, 39975.80012099921, 41537.0, 42329.78835105805, 42426.0, 42450.575494244666, 42549.14901701887, 34524.0, 36134.819325903205, 36288.63711362852, 36314.27371452609, 37203.06992325214, 27962.72037279601, 27967.44065118727, 28567.42865142644, 28567.857160714895, 28623.856880715462], "value": 20876.7192130565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.6197289344716, 445.32310887451075, 450.6394884092725, 451.668024002358, 459.27205379473514, 18956.0, 19674.016299185037, 19676.508087297807, 20970.580588388224, 21455.892720536416, 19859.900700496477, 20070.799292007076, 20524.179032838667, 20751.688724669104, 20810.0, 5706.65760054397, 5871.178035075093, 5914.704264786765, 5920.733566989475, 5924.644521328723, 4396.89007774805, 5831.4751672349485, 6050.304215015286, 6410.679466026703, 6432.839179020515, 6367.267764207129, 6372.713227904732, 6393.0, 6394.5843520171275, 6401.16784817973, 5749.396313387076, 6008.879822403571, 6025.698715064251, 6034.48706859913, 6037.305709843358, 4067.6542493888055, 5721.713914304268, 5879.029960056629, 5942.049272116441, 5951.821445356646, 14623.341949612293, 14673.926630366886, 14691.63270918225, 20127.39617811468, 24343.878280608482, 2572.3054775210776, 2684.7315268473194, 2825.265430987937, 3209.2618697699427, 3215.694509021639, 10489.160867130688, 10913.672589822318, 10971.890281097167, 11098.667039988813, 11151.553937842476, 1941.417574727576, 1961.3331467301186, 1992.721019057333, 2028.0, 2082.916683332665, 75335.24664753392, 78396.0, 80667.0, 80896.59551702262, 81890.59054704748, 10638.202134839918, 10954.835677464844, 11245.718857028476, 11533.423328833525, 11659.06727461801, 15621.453249136226, 16126.354945802272, 16290.67418651644, 16316.265768040466, 16326.183690815411, 8198.098209196984, 8327.292180164754, 8570.914290857136, 8654.48073115615, 8685.739427817176, 8806.075362086889, 8836.337274704423, 8848.778780530538, 8943.150400712053, 8966.148215919477, 4400.141972315368, 4461.040876211565, 4473.0, 4475.70907890986, 4544.431946006749, 1791.2387235424892, 1903.7715474143192, 2030.796920307987, 2054.6301665700316, 2072.8549001570045, 990.3513198854762, 1036.8081904847627, 1061.0874647802884, 1082.98199692289, 1104.5471356743697, 19358.903205483883, 19448.513787155433, 19534.70697939532, 19699.606007879764, 20216.191352346035, 1057.0, 1069.7967386196597, 1122.5004872831676, 1137.9203455758184, 1152.3093576498802, 10814.35113893169, 11215.111389772223, 11216.853182393388, 11229.562912851552, 11241.100711943025, 505754.0, 507821.0, 511223.0, 528402.0, 539398.0, 93738.0, 96148.0, 96428.0, 96863.51568242254, 96991.51504242574, 1100.7688385439149, 1147.0536807134147, 1174.3423682737694, 1187.8871507206802, 1210.2375503432957, 17082.572935676708, 17149.742753858452, 17633.118344083003, 17997.64004719872, 18041.458756237334, 39186.80406598063, 39302.41046384249, 39729.0, 40074.79962600168, 40459.59540404558, 52116.21825672542, 52185.7390713044, 54804.45195547993, 55210.0, 56576.434235657114, 9208.493532855757, 9323.440593564408, 9380.812383752424, 9440.244780417688, 9531.857022144535, 10519.684409467729, 13666.93166534161, 13671.0, 13712.862871371159, 13738.450461981409, 11788.76422471563, 11986.580469683518, 12149.0, 12221.511139554319, 12226.0, 11573.652790416301, 11911.583094591648, 11955.521779128738, 12063.819042714542, 12241.510339586317, 12431.0, 12457.314847683465, 12508.687282818002, 12619.116661833583, 12781.48874045065, 8579.099194584729, 8870.201681848665, 8891.64433422656, 9358.625654973725, 9545.236381089357, 11495.425228738697, 12077.39613019363, 12129.75740485203, 12208.328541929925, 12284.631461056182], "value": 9554.587055055714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.5508719840457, 1571.5599632103012, 1583.358739710417, 1788.3293764838186, 1949.756280464941, 8285.54429506377, 8439.70461033864, 8453.957730211341, 8458.66165353385, 8470.152984701534, 8243.258106770389, 8386.077531471534, 8415.074341822394, 8415.747527574167, 8426.199511046441, 2425.454272788622, 2440.8535487870695, 2445.4742230420457, 2446.1438496526252, 2453.6932883389577, 2464.155916769836, 2503.0738626708053, 2515.5975043992967, 2528.115159694111, 2542.758437948392, 2406.470576473182, 2419.443527988564, 2429.5991161458337, 2430.8419952703016, 2449.8775061246956, 2445.645381419702, 2463.0640356664444, 2467.2968204061935, 2471.765182307678, 2491.725910149882, 2453.7423570525193, 2481.969982457278, 2502.186789293487, 2503.962440563393, 2505.949881002388, 8269.669213231464, 8473.745787626382, 8474.915250847474, 8544.273736732384, 8553.828923421497, 5301.151815709506, 5433.945660543423, 5437.048516509595, 5440.591955603306, 5453.83638490842, 3610.5667319921777, 3619.6199399063244, 3637.527121474218, 3671.596124426311, 3718.4050551911564, 1167.8131498960126, 1193.6777070191, 1198.1553005131361, 1209.6129238643637, 1245.1097465312346, 11428.485718142703, 11881.227720198245, 11930.821037684442, 11956.2228455151, 12060.879391206063, 4405.933910991338, 4522.186006518858, 4580.748058856728, 4636.466806317249, 4640.605548528345, 9599.712008639752, 9612.75968100803, 9622.278329125344, 9638.0, 9660.613575457044, 5286.7356632169, 5299.735013249322, 5308.177232528964, 5309.123994540934, 5312.92030619541, 4343.587359200934, 4410.051838854662, 4417.646588272931, 4641.791119399635, 4914.066327397783, 4101.569335219819, 4226.4716910386205, 4285.657147428198, 4298.505671847715, 4376.12477504494, 1351.9188848669112, 1354.343143575365, 1361.4962463888426, 1369.869862363094, 1383.2737812648238, 1027.0345874877592, 1079.6707004363745, 1082.6643740440331, 1088.4068182840372, 1097.7639807441437, 5890.67601281925, 5988.970055149696, 6010.849728756729, 6129.417705317987, 6197.4732147767045, 483.5986131510838, 483.8645179349788, 488.07266194230533, 1107.479484642217, 1130.6608017594854, 4109.404136400205, 4146.5853414658895, 4151.8546850860075, 4162.105147393325, 4181.435506206684, 9980.700578982642, 10284.948575257076, 10348.637797677196, 10374.17006639467, 10396.324238924597, 10149.847752283722, 10218.897811021943, 10229.539670714836, 10245.436500992368, 10270.435126067989, 7987.720429784929, 8102.351811855037, 8121.269085782308, 8196.631151598192, 8203.548804815673, 5670.0, 5738.340090889601, 5744.569157313134, 5783.132530120515, 5885.323187833283, 9472.194863436685, 9494.05059494045, 9584.185344245818, 9665.468399238109, 9682.70951871445, 9679.758006049906, 9694.0, 9769.071938165864, 9831.950840245752, 10017.449040302561, 6514.0, 7031.648417579203, 7195.496315258091, 7291.052163218747, 7305.269473052652, 8141.755747327589, 8162.6734930602115, 8228.0, 8239.093699693149, 8241.093479717347, 7325.4872158948365, 7483.214262502576, 7530.472866899265, 7615.086189657277, 7696.499727517694, 7393.408527317909, 7466.775996720107, 7468.365188958999, 7498.925010749823, 7581.734639287599, 6778.118844550177, 6826.590404575742, 6826.692798823966, 6832.487563432663, 6836.487263455161, 4937.382827146606, 5104.3619547556555, 5137.0, 5167.069927413102, 5191.870203244949, 5114.3862736471865, 5164.793408263778, 5173.379194496684, 5184.377874655065, 5362.51737343641], "value": 4622.591995524417, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.397524208845, 364.18241048845346, 365.22025475609576, 367.18668150047637, 367.97608155469885, 6066.241719785027, 6150.200473938393, 6233.2208473940755, 6264.467520260783, 6271.466925311348, 6169.0437982112735, 6290.842728931779, 6296.370362963701, 6318.241810982689, 6322.841928951779, 4849.612031037508, 4851.2238041913215, 4852.223644216926, 4857.149998750222, 4872.7563621818945, 4622.537746225367, 4713.175194340976, 4845.176320025586, 4849.636277279201, 4857.951420485803, 4786.545278198566, 4792.0, 4797.52024797521, 4805.303231031498, 4816.349792777965, 4788.545088216614, 4792.592629626486, 4794.161021821167, 4803.61571074315, 4810.110129625996, 4237.87286381406, 4245.702800803945, 4246.7027308088445, 4252.957470425287, 4256.4679415073115, 6008.188894499231, 6021.126936594169, 6026.427489388501, 6038.124471951586, 6043.305019922677, 5337.386200586943, 5601.831945041656, 5605.327360716699, 5621.100623900156, 5622.044252477089, 6498.0577816216855, 6506.7722629708205, 6553.082568440422, 6569.310222426672, 6572.901406478906, 4613.7923793429045, 4619.907601847978, 4622.768861556909, 4623.953760462419, 4630.097131059445, 6864.2106157791995, 6927.064846245743, 6936.0, 6944.4097251733665, 6948.965255173692, 4721.386219791405, 4723.645726570452, 4726.0, 4730.219513780256, 4734.384530011145, 4581.9541804582195, 4784.784684689197, 4789.712617242976, 4793.592544633675, 4798.856034318976, 5397.136458166675, 5398.406175320712, 5402.810901618424, 5434.64674796137, 5454.181872719124, 6537.0, 6545.476361891037, 6554.836129096715, 6562.343765623399, 6576.04647326135, 1606.020327600163, 1639.1148779658852, 1679.4373884748502, 1685.2416412614127, 1685.3679870048732, 1101.2456467319912, 1112.6995711157942, 1120.9327440353604, 1123.556195302867, 1127.3405058040973, 6326.114343991845, 6335.619862808154, 6391.936080639134, 6428.132202152649, 6431.935680643227, 6752.729890804411, 6766.18805743314, 6766.594004359754, 6777.559458635173, 6777.898331525031, 6403.903941440882, 6407.231132264158, 6411.743530258831, 6415.711292991827, 6443.613383197023, 3605.7295702822394, 3639.090227443139, 3645.3985092459448, 3649.379605467077, 3651.689606383487, 7016.508844380946, 7059.89410158848, 7230.855382892312, 7238.0952380952385, 7241.818954526074, 6988.126484189476, 7000.579965202104, 7007.404370628452, 7017.578945263301, 7021.964890175618, 7205.2434494378385, 7206.711731530785, 7208.567485950754, 7212.350888419963, 7216.494845360774, 6898.517103802686, 6909.896351554831, 6914.9308506914285, 6918.273581273894, 6918.481113916577, 6567.376099270562, 6800.149981252343, 6818.215905170969, 6823.215330237086, 6838.623875686885, 7143.0, 7169.35475807159, 7182.461315401261, 7205.855882882418, 7210.71157153708, 4738.7867545959825, 4766.594839438687, 4769.9046019080115, 4776.21192503233, 4781.258904869751, 6518.348165183444, 6667.933130699065, 6870.244273130052, 6874.518783685094, 6875.07186529812, 6626.072349870926, 6657.6005439671835, 6663.0, 6663.900041499284, 6674.966625166843, 6642.90035649456, 6649.900251496135, 6650.73397064112, 6652.866942661217, 6661.433778128913, 6533.836654083686, 6535.869282614416, 6548.3124271950755, 6551.770688025897, 6552.3775241352, 6510.056041873996, 6647.368499992493, 6676.265610782712, 6692.230393504809, 6706.631135287411, 6469.611823290617, 6521.0, 6521.673916304071, 6528.118703974903, 6539.182602174728], "value": 5017.889032913602, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [875.1598465473146, 933.985990210147, 937.9906200937988, 950.0, 961.8461046232604, 14579.19814410207, 14848.554543363703, 14878.776818347733, 14887.0, 14916.7016659667, 13899.096558723675, 13957.860421395782, 13963.860361396382, 13990.510332138378, 13995.65010874726, 755.8148253677842, 886.57887503436, 891.0866361978991, 891.9821603567925, 895.789489469974, 882.1002577371078, 892.3887137310962, 892.3976315986683, 895.2479916869828, 915.5330781301551, 929.8884133903941, 930.0513476254216, 930.1117432851611, 931.1479995803832, 959.0217977662815, 819.397742659145, 953.4898829126419, 964.71058682395, 964.7636329099415, 966.0146650416535, 711.4770643576967, 712.0, 712.1952194020723, 713.0552018575409, 714.4641518860855, 14017.229052402114, 14019.43922243109, 14030.579082627537, 14060.296985150804, 14068.155910645291, 14542.854571454362, 14794.55616331501, 15047.172405517693, 15517.068975861484, 15653.608659783482, 12149.878501214964, 12280.815787763191, 12430.0, 12431.254124752544, 12432.75134497314, 4047.6357127858632, 4096.139810639769, 4117.855875044359, 4136.896577585554, 4166.91666166675, 56852.71573642105, 59003.704981475246, 59132.99999999957, 59169.0, 59270.40729592692, 11622.593209237637, 11903.583374582022, 11905.702357441134, 12047.096467764954, 12233.755324893453, 22299.331020069425, 22441.0, 22553.4361640957, 22580.0, 22613.321600352017, 8635.740927772176, 8732.78168045804, 8751.737447876574, 8769.824603507894, 8779.25376343018, 4880.829170978998, 4986.052649996489, 5040.47075057121, 5076.162433198481, 5076.898462030738, 3709.7588656737225, 3785.772853628791, 3792.962070379316, 3794.734368594227, 3796.6013568574904, 638.8370965403792, 666.8099591616464, 672.357898207211, 673.4578664175386, 673.7473447457204, 708.2952462300044, 790.3874497264666, 815.9592020398957, 819.9918000820035, 827.5034979012664, 9742.659006934866, 10016.64941727036, 10188.694339169837, 10281.434521101412, 10296.0, 730.4704089535045, 791.0625908298684, 793.7698067560343, 798.2416704130983, 809.2595275323131, 4573.519780423074, 4643.535646435397, 4764.6664733469015, 4782.234842425265, 4795.184818580849, 69661.0, 70959.64520177366, 71792.28207717961, 72046.0, 72179.0, 55477.722611386685, 55647.72176139093, 56440.43559564352, 58572.41427585755, 59313.703431482565, 48308.516914830405, 48455.515444845805, 48976.265356019685, 49580.75209623929, 50298.748506257965, 9149.5882685278, 9150.496722680316, 9171.908280917372, 9229.35394522377, 9400.0, 38727.80636096802, 38916.2216755669, 39499.80250098846, 39713.60286397099, 40084.19831603293, 45803.0, 48464.0, 51612.0, 51935.0, 52499.0, 10976.890231097586, 11561.710957226136, 12048.698782530508, 12095.153339266168, 12137.635870923887, 12852.357382131044, 12957.287349195885, 13181.934090329487, 13233.602991910258, 13284.867151328363, 12047.578334758242, 12373.602582074342, 12594.748105038032, 12830.67923301925, 13264.933675331948, 12000.39998000079, 12208.694782630506, 12617.432215550505, 12804.48782048745, 12827.551035713705, 12605.873941260837, 12625.621231363073, 12819.230846149261, 12970.740585188432, 13207.0, 9691.612335506501, 9743.967215071552, 9948.154406875497, 9994.150497207818, 10271.640492582725, 9968.700938971842, 10575.841362379417, 10613.575456981634, 10844.837327439936, 10876.510557024794], "value": 7166.35786740756, "unit": "score"}], "name": "dromaeo_css", "value": 7547.592448591104, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 109.0, 109.0, 109.0, 110.0, 106.0, 109.0, 109.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 129.0, 162.0, 171.0, 125.0, 149.0, 153.0, 127.0, 181.0, 126.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 158.0, 161.0, 160.0, 162.0, 159.0, 159.0, 160.0, 159.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 178.0, 75.0, 76.0, 74.0, 73.0, 159.0, 75.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 153.0, 91.0, 91.0, 92.0, 143.0, 91.0, 91.0, 151.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 56.0, 55.0, 53.0, 55.0, 82.0, 55.0, 55.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 71.0, 79.0, 73.0, 73.0, 73.0, 73.0, 73.0, 72.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 120.0, 112.0, 113.0, 111.0, 120.0, 115.0, 111.0, 129.0, 126.0], "value": 116.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 155.0, 156.0, 155.0, 157.0, 157.0, 159.0, 160.0, 154.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 68.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1505.9, "alertThreshold": 2.0}]} 03:12:51 INFO - Return code: 0 03:12:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:12:51 ERROR - # TBPL SUCCESS # 03:12:51 INFO - Running post-action listener: _resource_record_post_action 03:12:51 INFO - Running post-run listener: _resource_record_post_run 03:12:52 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 468836352; Read time: 140; Write time: 488164 03:12:52 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 4096; Write bytes: 241344512; Read time: 72; Write time: 334436 03:12:52 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 219308032; Read time: 68; Write time: 152300 03:12:52 INFO - Running post-run listener: _upload_blobber_files 03:12:52 INFO - Blob upload gear active. 03:12:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:12:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:12:52 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'] 03:12:52 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 03:12:53 INFO - (blobuploader) - INFO - Open directory for files ... 03:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:12:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:53 INFO - (blobuploader) - INFO - Done attempting. 03:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:12:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:54 INFO - (blobuploader) - INFO - Done attempting. 03:12:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:12:54 INFO - Return code: 0 03:12:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:12:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:12:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a2815e3ecd0cfa8378d2de5b4a6c6531a66677749b022b9d4c3046f8b0c72fd8e50dde50ed3783846a3ac1315f220e63e058fb8fda4bd07449db10f4c71c49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72b26e476612c958d9aec42fa683ba3f50b6c21ecc3f33f7331a1c5a1def85cd16f6b1833f8e49ccb02ff829359e67985d12cef154ec688be4f4640a8f147a17"} 03:12:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:12:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:12:54 INFO - Contents: 03:12:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a2815e3ecd0cfa8378d2de5b4a6c6531a66677749b022b9d4c3046f8b0c72fd8e50dde50ed3783846a3ac1315f220e63e058fb8fda4bd07449db10f4c71c49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72b26e476612c958d9aec42fa683ba3f50b6c21ecc3f33f7331a1c5a1def85cd16f6b1833f8e49ccb02ff829359e67985d12cef154ec688be4f4640a8f147a17"} 03:12:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:12:54 INFO - Copying logs to upload dir... 03:12:54 INFO - mkdir: /builds/slave/test/build/upload/logs 03:12:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1296.264731 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2016-06-21 03:12:54.500500) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 03:12:54.503985) ========= 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=eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a2815e3ecd0cfa8378d2de5b4a6c6531a66677749b022b9d4c3046f8b0c72fd8e50dde50ed3783846a3ac1315f220e63e058fb8fda4bd07449db10f4c71c49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72b26e476612c958d9aec42fa683ba3f50b6c21ecc3f33f7331a1c5a1def85cd16f6b1833f8e49ccb02ff829359e67985d12cef154ec688be4f4640a8f147a17"} build_url:https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011560 build_url: 'https://queue.taskcluster.net/v1/task/ffkwXNipT2aK5l1MytLaYw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a2815e3ecd0cfa8378d2de5b4a6c6531a66677749b022b9d4c3046f8b0c72fd8e50dde50ed3783846a3ac1315f220e63e058fb8fda4bd07449db10f4c71c49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72b26e476612c958d9aec42fa683ba3f50b6c21ecc3f33f7331a1c5a1def85cd16f6b1833f8e49ccb02ff829359e67985d12cef154ec688be4f4640a8f147a17"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 03:12:54.529206) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:12:54.529581) ========= 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=eca2ab57546de7b41f256b19000001ef-1466502676.636362-1217482826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:12:54.612656) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 03:12:54.612982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 03:12:54.613288) ========= ========= Total master_lag: 0.17 =========