builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1464235647.05 results: success (0) buildid: 20160525183450 builduid: 63f91898e679451db7d589c242ad058b revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.053323) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.054059) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.054337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.080551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.080897) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 21:07:27-- 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% 23.3M=0s 2016-05-25 21:07:27 (23.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074567 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.166863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.167175) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021395 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.220153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.220463) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33693d8bdec17f07fc460ca7cc908ade88f97b86 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33693d8bdec17f07fc460ca7cc908ade88f97b86 --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=03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 21:07:27,461 truncating revision to first 12 chars 2016-05-25 21:07:27,461 Setting DEBUG logging. 2016-05-25 21:07:27,461 attempt 1/10 2016-05-25 21:07:27,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/33693d8bdec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 21:07:27,759 unpacking tar archive at: mozilla-aurora-33693d8bdec1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648709 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.882122) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.882424) ========= script_repo_revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.882841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.883105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 21:07:27.893014) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-25 21:07:27.893282) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:07:28 INFO - MultiFileLogger online at 20160525 21:07:28 in /builds/slave/test 21:07:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:07:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:07:28 INFO - {'append_to_log': False, 21:07:28 INFO - 'base_work_dir': '/builds/slave/test', 21:07:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:07:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:07:28 INFO - 'branch': 'Mozilla-Aurora', 21:07:28 INFO - 'buildbot_json_path': 'buildprops.json', 21:07:28 INFO - 'config_files': ('talos/linux_config.py',), 21:07:28 INFO - 'default_actions': ('clobber', 21:07:28 INFO - 'read-buildbot-config', 21:07:28 INFO - 'download-and-extract', 21:07:28 INFO - 'populate-webroot', 21:07:28 INFO - 'create-virtualenv', 21:07:28 INFO - 'install', 21:07:28 INFO - 'run-tests'), 21:07:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:07:28 INFO - 'download_minidump_stackwalk': True, 21:07:28 INFO - 'download_symbols': 'ondemand', 21:07:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:07:28 INFO - 'tooltool.py': '/tools/tooltool.py', 21:07:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:07:28 INFO - '/tools/misc-python/virtualenv.py')}, 21:07:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:07:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:07:28 INFO - 'installer_path': 'installer.exe', 21:07:28 INFO - 'log_level': 'info', 21:07:28 INFO - 'log_name': 'talos', 21:07:28 INFO - 'log_to_console': True, 21:07:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:07:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:07:28 INFO - 'opt_config_files': (), 21:07:28 INFO - 'pip_index': False, 21:07:28 INFO - 'sps_profile': False, 21:07:28 INFO - 'sps_profile_interval': 0, 21:07:28 INFO - 'suite': 'dromaeojs', 21:07:28 INFO - 'system_bits': '32', 21:07:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:07:28 INFO - 'title': 'talos-linux64-ix-047', 21:07:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:07:28 INFO - 'use_talos_json': True, 21:07:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:07:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:07:28 INFO - 'work_dir': 'build'} 21:07:28 INFO - ##### 21:07:28 INFO - ##### Running clobber step. 21:07:28 INFO - ##### 21:07:28 INFO - Running pre-action listener: _resource_record_pre_action 21:07:28 INFO - Running main action method: clobber 21:07:28 INFO - rmtree: /builds/slave/test/build 21:07:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:07:28 INFO - Running post-action listener: _resource_record_post_action 21:07:28 INFO - ##### 21:07:28 INFO - ##### Running read-buildbot-config step. 21:07:28 INFO - ##### 21:07:28 INFO - Running pre-action listener: _resource_record_pre_action 21:07:28 INFO - Running main action method: read_buildbot_config 21:07:28 INFO - Using buildbot properties: 21:07:28 INFO - { 21:07:28 INFO - "project": "", 21:07:28 INFO - "product": "firefox", 21:07:28 INFO - "script_repo_revision": "production", 21:07:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:07:28 INFO - "repository": "", 21:07:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:07:28 INFO - "buildid": "20160525183450", 21:07:28 INFO - "pgo_build": "True", 21:07:28 INFO - "basedir": "/builds/slave/test", 21:07:28 INFO - "buildnumber": 518, 21:07:28 INFO - "slavename": "talos-linux64-ix-047", 21:07:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:07:28 INFO - "platform": "ubuntu64_hw", 21:07:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:07:28 INFO - "branch": "mozilla-aurora", 21:07:28 INFO - "repo_path": "releases/mozilla-aurora", 21:07:28 INFO - "revision": "33693d8bdec17f07fc460ca7cc908ade88f97b86", 21:07:28 INFO - "stage_platform": "linux64-pgo", 21:07:28 INFO - "builduid": "63f91898e679451db7d589c242ad058b", 21:07:28 INFO - "slavebuilddir": "test" 21:07:28 INFO - } 21:07:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 21:07:28 INFO - Running post-action listener: _resource_record_post_action 21:07:28 INFO - ##### 21:07:28 INFO - ##### Running download-and-extract step. 21:07:28 INFO - ##### 21:07:28 INFO - Running pre-action listener: _resource_record_pre_action 21:07:28 INFO - Running main action method: download_and_extract 21:07:28 INFO - mkdir: /builds/slave/test/build/tests 21:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:28 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:07:29 INFO - Downloaded 1361 bytes. 21:07:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:07:29 INFO - Using the following test package requirements: 21:07:29 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:07:29 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:07:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:07:29 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:07:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:07:29 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:07:29 INFO - u'jsshell-linux-x86_64.zip'], 21:07:29 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:07:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:07:29 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:07:29 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:07:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:07:29 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:07:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:07:29 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:07:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:07:29 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:07:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:07:29 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:29 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:07:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:07:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:07:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:07:30 INFO - Downloaded 24140640 bytes. 21:07:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:07:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:07:32 INFO - Return code: 0 21:07:32 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:32 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:07:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:07:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:07:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:07:40 INFO - Downloaded 24140640 bytes. 21:07:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:07:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:07:41 INFO - Return code: 0 21:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:41 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:07:43 INFO - Downloaded 10840145 bytes. 21:07:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:07:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:07:43 INFO - Return code: 0 21:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:43 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:07:44 INFO - Downloaded 62759817 bytes. 21:07:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:07:44 INFO - mkdir: /builds/slave/test/properties 21:07:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:07:44 INFO - Writing to file /builds/slave/test/properties/build_url 21:07:44 INFO - Contents: 21:07:44 INFO - build_url:https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:07:45 INFO - Running post-action listener: _resource_record_post_action 21:07:45 INFO - Running post-action listener: set_extra_try_arguments 21:07:45 INFO - ##### 21:07:45 INFO - ##### Running populate-webroot step. 21:07:45 INFO - ##### 21:07:45 INFO - Running pre-action listener: _resource_record_pre_action 21:07:45 INFO - Running main action method: populate_webroot 21:07:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:07:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:07:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:07:45 INFO - '--tppagecycles', 21:07:45 INFO - '7'], 21:07:45 INFO - 'tests': ['tsvgm']}}, 21:07:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:07:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:07:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:07:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:07:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:07:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:07:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:45 INFO - 'talos_options': ['--disable-e10s'], 21:07:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:07:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:07:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:45 INFO - 'talos_options': ['--disable-e10s'], 21:07:45 INFO - 'tests': ['damp', 'tps']}, 21:07:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:45 INFO - 'tests': ['damp', 'tps']}, 21:07:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:07:45 INFO - 'tests': ['dromaeo_dom']}, 21:07:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:07:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:07:45 INFO - 'tests': ['a11yr', 21:07:45 INFO - 'ts_paint', 21:07:45 INFO - 'tpaint', 21:07:45 INFO - 'sessionrestore', 21:07:45 INFO - 'sessionrestore_no_auto_restore', 21:07:45 INFO - 'tabpaint']}, 21:07:45 INFO - 'other-e10s': {'tests': ['a11yr', 21:07:45 INFO - 'ts_paint', 21:07:45 INFO - 'tpaint', 21:07:45 INFO - 'sessionrestore', 21:07:45 INFO - 'sessionrestore_no_auto_restore', 21:07:45 INFO - 'tabpaint']}, 21:07:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:07:45 INFO - 'ts_paint', 21:07:45 INFO - 'tpaint', 21:07:45 INFO - 'sessionrestore', 21:07:45 INFO - 'sessionrestore_no_auto_restore', 21:07:45 INFO - 'tabpaint']}, 21:07:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:07:45 INFO - 'ts_paint', 21:07:45 INFO - 'tpaint', 21:07:45 INFO - 'sessionrestore', 21:07:45 INFO - 'sessionrestore_no_auto_restore', 21:07:45 INFO - 'tabpaint']}, 21:07:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:07:45 INFO - 'tests': ['a11yr', 21:07:45 INFO - 'ts_paint', 21:07:45 INFO - 'tpaint', 21:07:45 INFO - 'sessionrestore', 21:07:45 INFO - 'sessionrestore_no_auto_restore', 21:07:45 INFO - 'tabpaint']}, 21:07:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:07:45 INFO - 'tests': ['a11yr', 21:07:45 INFO - 'ts_paint', 21:07:45 INFO - 'tpaint', 21:07:45 INFO - 'sessionrestore', 21:07:45 INFO - 'sessionrestore_no_auto_restore', 21:07:45 INFO - 'tabpaint']}, 21:07:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:07:45 INFO - 'tests': ['tsvgx', 21:07:45 INFO - 'tsvgr_opacity', 21:07:45 INFO - 'tart', 21:07:45 INFO - 'tscrollx', 21:07:45 INFO - 'cart']}, 21:07:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:07:45 INFO - 'tsvgr_opacity', 21:07:45 INFO - 'tart', 21:07:45 INFO - 'tscrollx', 21:07:45 INFO - 'cart']}, 21:07:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:45 INFO - 'talos_options': ['--disable-e10s'], 21:07:45 INFO - 'tests': ['tp5o']}, 21:07:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:45 INFO - 'tests': ['tp5o']}, 21:07:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:45 INFO - 'talos_options': ['--disable-e10s', 21:07:45 INFO - '--xperf_path', 21:07:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:07:45 INFO - 'tests': ['tp5n']}, 21:07:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:45 INFO - 'talos_options': ['--xperf_path', 21:07:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:07:45 INFO - 'tests': ['tp5n']}}, 21:07:45 INFO - 'talos.zip': {'path': '', 21:07:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:07:45 INFO - Running post-action listener: _resource_record_post_action 21:07:45 INFO - ##### 21:07:45 INFO - ##### Running create-virtualenv step. 21:07:45 INFO - ##### 21:07:45 INFO - Running pre-action listener: _resource_record_pre_action 21:07:45 INFO - Running main action method: create_virtualenv 21:07:45 INFO - Creating virtualenv /builds/slave/test/build/venv 21:07:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:07:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:07:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:07:45 INFO - Using real prefix '/usr' 21:07:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:07:46 INFO - Installing distribute.............................................................................................................................................................................................done. 21:07:48 INFO - Installing pip.................done. 21:07:48 INFO - Return code: 0 21:07:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:07: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')]} 21:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07: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')]} 21:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d4b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be410>, '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 0x14bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:07: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', 'pip>=1.5'] in /builds/slave/test/build 21:07: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 pip>=1.5 21:07:48 INFO - Using env: {'DISPLAY': ':0', 21:07:48 INFO - 'HOME': '/home/cltbld', 21:07:48 INFO - 'LANG': 'en_US.UTF-8', 21:07:48 INFO - 'LANGUAGE': 'en_US:en', 21:07:48 INFO - 'LOGNAME': 'cltbld', 21:07:48 INFO - 'MAIL': '/var/mail/cltbld', 21:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:48 INFO - 'MOZ_NO_REMOTE': '1', 21:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:48 INFO - 'NO_EM_RESTART': '1', 21:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:48 INFO - 'PWD': '/builds/slave/test', 21:07:48 INFO - 'SHELL': '/bin/bash', 21:07:48 INFO - 'SHLVL': '1', 21:07:48 INFO - 'TERM': 'linux', 21:07:48 INFO - 'TMOUT': '86400', 21:07:48 INFO - 'USER': 'cltbld', 21:07:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 21:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:48 INFO - '_': '/tools/buildbot/bin/python'} 21:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:07:48 INFO - Cleaning up... 21:07:48 INFO - Return code: 0 21:07:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:07: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')]} 21:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07: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')]} 21:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07: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', '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 0x7ff9d4b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be410>, '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 0x14bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:07: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', 'psutil>=0.7.1'] in /builds/slave/test/build 21:07: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 psutil>=0.7.1 21:07:48 INFO - Using env: {'DISPLAY': ':0', 21:07:48 INFO - 'HOME': '/home/cltbld', 21:07:48 INFO - 'LANG': 'en_US.UTF-8', 21:07:48 INFO - 'LANGUAGE': 'en_US:en', 21:07:48 INFO - 'LOGNAME': 'cltbld', 21:07:48 INFO - 'MAIL': '/var/mail/cltbld', 21:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:48 INFO - 'MOZ_NO_REMOTE': '1', 21:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:48 INFO - 'NO_EM_RESTART': '1', 21:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:48 INFO - 'PWD': '/builds/slave/test', 21:07:48 INFO - 'SHELL': '/bin/bash', 21:07:48 INFO - 'SHLVL': '1', 21:07:48 INFO - 'TERM': 'linux', 21:07:48 INFO - 'TMOUT': '86400', 21:07:48 INFO - 'USER': 'cltbld', 21:07:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 21:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:48 INFO - '_': '/tools/buildbot/bin/python'} 21:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:48 INFO - Downloading/unpacking psutil>=0.7.1 21:07: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 21:07: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 21:07: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 21:07: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 21:07: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 21:07: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 21:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:07:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:07:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:07:50 INFO - Installing collected packages: psutil 21:07:50 INFO - Running setup.py install for psutil 21:07:50 INFO - building 'psutil._psutil_linux' extension 21:07:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:07:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:07:51 INFO - building 'psutil._psutil_posix' extension 21:07:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:07:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:07:51 INFO - Successfully installed psutil 21:07:51 INFO - Cleaning up... 21:07:51 INFO - Return code: 0 21:07:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:07: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')]} 21:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07: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')]} 21:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff9d4b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be410>, '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 0x14bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:07:51 INFO - Using env: {'DISPLAY': ':0', 21:07:51 INFO - 'HOME': '/home/cltbld', 21:07:51 INFO - 'LANG': 'en_US.UTF-8', 21:07:51 INFO - 'LANGUAGE': 'en_US:en', 21:07:51 INFO - 'LOGNAME': 'cltbld', 21:07:51 INFO - 'MAIL': '/var/mail/cltbld', 21:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:51 INFO - 'MOZ_NO_REMOTE': '1', 21:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:51 INFO - 'NO_EM_RESTART': '1', 21:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:51 INFO - 'PWD': '/builds/slave/test', 21:07:51 INFO - 'SHELL': '/bin/bash', 21:07:51 INFO - 'SHLVL': '1', 21:07:51 INFO - 'TERM': 'linux', 21:07:51 INFO - 'TMOUT': '86400', 21:07:51 INFO - 'USER': 'cltbld', 21:07:51 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 21:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:51 INFO - '_': '/tools/buildbot/bin/python'} 21:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:07:53 INFO - Installing collected packages: mozsystemmonitor 21:07:53 INFO - Running setup.py install for mozsystemmonitor 21:07:53 INFO - Successfully installed mozsystemmonitor 21:07:53 INFO - Cleaning up... 21:07:53 INFO - Return code: 0 21:07:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:53 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 0x7ff9d4b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be410>, '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 0x14bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:07:53 INFO - Using env: {'DISPLAY': ':0', 21:07:53 INFO - 'HOME': '/home/cltbld', 21:07:53 INFO - 'LANG': 'en_US.UTF-8', 21:07:53 INFO - 'LANGUAGE': 'en_US:en', 21:07:53 INFO - 'LOGNAME': 'cltbld', 21:07:53 INFO - 'MAIL': '/var/mail/cltbld', 21:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:53 INFO - 'MOZ_NO_REMOTE': '1', 21:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:53 INFO - 'NO_EM_RESTART': '1', 21:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:53 INFO - 'PWD': '/builds/slave/test', 21:07:53 INFO - 'SHELL': '/bin/bash', 21:07:53 INFO - 'SHLVL': '1', 21:07:53 INFO - 'TERM': 'linux', 21:07:53 INFO - 'TMOUT': '86400', 21:07:53 INFO - 'USER': 'cltbld', 21:07:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 21:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:53 INFO - '_': '/tools/buildbot/bin/python'} 21:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:53 INFO - Downloading/unpacking blobuploader==1.2.4 21:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:55 INFO - Downloading blobuploader-1.2.4.tar.gz 21:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:07:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:07:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:56 INFO - Downloading docopt-0.6.1.tar.gz 21:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:07:56 INFO - Installing collected packages: blobuploader, requests, docopt 21:07:56 INFO - Running setup.py install for blobuploader 21:07:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:07:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:07:56 INFO - Running setup.py install for requests 21:07:56 INFO - Running setup.py install for docopt 21:07:57 INFO - Successfully installed blobuploader requests docopt 21:07:57 INFO - Cleaning up... 21:07:57 INFO - Return code: 0 21:07:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:57 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 0x7ff9d4b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be410>, '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 0x14bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:07:57 INFO - Using env: {'DISPLAY': ':0', 21:07:57 INFO - 'HOME': '/home/cltbld', 21:07:57 INFO - 'LANG': 'en_US.UTF-8', 21:07:57 INFO - 'LANGUAGE': 'en_US:en', 21:07:57 INFO - 'LOGNAME': 'cltbld', 21:07:57 INFO - 'MAIL': '/var/mail/cltbld', 21:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:57 INFO - 'MOZ_NO_REMOTE': '1', 21:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:57 INFO - 'NO_EM_RESTART': '1', 21:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:57 INFO - 'PWD': '/builds/slave/test', 21:07:57 INFO - 'SHELL': '/bin/bash', 21:07:57 INFO - 'SHLVL': '1', 21:07:57 INFO - 'TERM': 'linux', 21:07:57 INFO - 'TMOUT': '86400', 21:07:57 INFO - 'USER': 'cltbld', 21:07:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 21:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:57 INFO - '_': '/tools/buildbot/bin/python'} 21:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:07:57 INFO - Running setup.py (path:/tmp/pip-FhS8Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:07:57 INFO - Running setup.py (path:/tmp/pip-whmNkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:07:57 INFO - Running setup.py (path:/tmp/pip-B5GKRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:07:57 INFO - Running setup.py (path:/tmp/pip-Mz9spg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:07:57 INFO - Running setup.py (path:/tmp/pip-UFrxqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:07:57 INFO - Running setup.py (path:/tmp/pip-UTs58n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:07:57 INFO - Running setup.py (path:/tmp/pip-YLF11J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:07:57 INFO - Running setup.py (path:/tmp/pip-wHqBjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:07:57 INFO - Running setup.py (path:/tmp/pip-A_iXq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:07:57 INFO - Running setup.py (path:/tmp/pip-E4GR90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:07:57 INFO - Running setup.py (path:/tmp/pip-OxFB2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:07:58 INFO - Running setup.py (path:/tmp/pip-UbkK4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:07:58 INFO - Running setup.py (path:/tmp/pip-RwuuNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:07:58 INFO - Running setup.py (path:/tmp/pip-DADfe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:58 INFO - Running setup.py (path:/tmp/pip-dnabhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:07:58 INFO - Running setup.py (path:/tmp/pip-BJSDxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:07:58 INFO - Running setup.py (path:/tmp/pip-QhZNVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:07:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:07:58 INFO - Running setup.py install for manifestparser 21:07:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:07:58 INFO - Running setup.py install for mozcrash 21:07:58 INFO - Running setup.py install for mozdebug 21:07:58 INFO - Running setup.py install for mozdevice 21:07:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:07:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:07:58 INFO - Running setup.py install for mozfile 21:07:59 INFO - Running setup.py install for mozhttpd 21:07:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Running setup.py install for mozinfo 21:07:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Running setup.py install for mozInstall 21:07:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Running setup.py install for mozleak 21:07:59 INFO - Running setup.py install for mozlog 21:07:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Running setup.py install for moznetwork 21:07:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Running setup.py install for mozprocess 21:07:59 INFO - Running setup.py install for mozprofile 21:07:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:07:59 INFO - Running setup.py install for mozrunner 21:07:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:08:00 INFO - Running setup.py install for mozscreenshot 21:08:00 INFO - Running setup.py install for moztest 21:08:00 INFO - Running setup.py install for mozversion 21:08:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:08:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:08:00 INFO - Cleaning up... 21:08:00 INFO - Return code: 0 21:08:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:00 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 0x7ff9d4b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be410>, '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 0x14bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:08:00 INFO - Using env: {'DISPLAY': ':0', 21:08:00 INFO - 'HOME': '/home/cltbld', 21:08:00 INFO - 'LANG': 'en_US.UTF-8', 21:08:00 INFO - 'LANGUAGE': 'en_US:en', 21:08:00 INFO - 'LOGNAME': 'cltbld', 21:08:00 INFO - 'MAIL': '/var/mail/cltbld', 21:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:00 INFO - 'MOZ_NO_REMOTE': '1', 21:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:00 INFO - 'NO_EM_RESTART': '1', 21:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:00 INFO - 'PWD': '/builds/slave/test', 21:08:00 INFO - 'SHELL': '/bin/bash', 21:08:00 INFO - 'SHLVL': '1', 21:08:00 INFO - 'TERM': 'linux', 21:08:00 INFO - 'TMOUT': '86400', 21:08:00 INFO - 'USER': 'cltbld', 21:08:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 21:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:00 INFO - '_': '/tools/buildbot/bin/python'} 21:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:08:00 INFO - Running setup.py (path:/tmp/pip-L2cS_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:08:00 INFO - Running setup.py (path:/tmp/pip-CwekGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:08:00 INFO - Running setup.py (path:/tmp/pip-4h3O3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:08:00 INFO - Running setup.py (path:/tmp/pip-4xlk9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:08:00 INFO - Running setup.py (path:/tmp/pip-g9TjWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:08:00 INFO - Running setup.py (path:/tmp/pip-IswXe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:08:00 INFO - Running setup.py (path:/tmp/pip-g5HHff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:08:01 INFO - Running setup.py (path:/tmp/pip-xgZM2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:08:01 INFO - Running setup.py (path:/tmp/pip-UQyX5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:08:01 INFO - Running setup.py (path:/tmp/pip-bm33LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:08:01 INFO - Running setup.py (path:/tmp/pip-1VBGVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:08:01 INFO - Running setup.py (path:/tmp/pip-7lC1Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:08:01 INFO - Running setup.py (path:/tmp/pip-3s9PSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:08:01 INFO - Running setup.py (path:/tmp/pip-rqMNLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:01 INFO - Running setup.py (path:/tmp/pip-uN8eH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:08:01 INFO - Running setup.py (path:/tmp/pip-lkIG_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:08:01 INFO - Running setup.py (path:/tmp/pip-WDp6I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:08:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08:03 INFO - Downloading blessings-1.6.tar.gz 21:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:08:03 INFO - Installing collected packages: blessings 21:08:03 INFO - Running setup.py install for blessings 21:08:03 INFO - Successfully installed blessings 21:08:03 INFO - Cleaning up... 21:08:03 INFO - Return code: 0 21:08:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:08:04 INFO - Reading from file tmpfile_stdout 21:08:04 INFO - Current package versions: 21:08:04 INFO - argparse == 1.2.1 21:08:04 INFO - blessings == 1.6 21:08:04 INFO - blobuploader == 1.2.4 21:08:04 INFO - docopt == 0.6.1 21:08:04 INFO - manifestparser == 1.1 21:08:04 INFO - mozInstall == 1.12 21:08:04 INFO - mozcrash == 0.17 21:08:04 INFO - mozdebug == 0.1 21:08:04 INFO - mozdevice == 0.48 21:08:04 INFO - mozfile == 1.2 21:08:04 INFO - mozhttpd == 0.7 21:08:04 INFO - mozinfo == 0.9 21:08:04 INFO - mozleak == 0.1 21:08:04 INFO - mozlog == 3.1 21:08:04 INFO - moznetwork == 0.27 21:08:04 INFO - mozprocess == 0.22 21:08:04 INFO - mozprofile == 0.28 21:08:04 INFO - mozrunner == 6.11 21:08:04 INFO - mozscreenshot == 0.1 21:08:04 INFO - mozsystemmonitor == 0.0 21:08:04 INFO - moztest == 0.7 21:08:04 INFO - mozversion == 1.4 21:08:04 INFO - psutil == 3.1.1 21:08:04 INFO - requests == 1.2.3 21:08:04 INFO - wsgiref == 0.1.2 21:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:04 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 0x7ff9d4b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be410>, '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 0x14bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:08:04 INFO - Using env: {'DISPLAY': ':0', 21:08:04 INFO - 'HOME': '/home/cltbld', 21:08:04 INFO - 'LANG': 'en_US.UTF-8', 21:08:04 INFO - 'LANGUAGE': 'en_US:en', 21:08:04 INFO - 'LOGNAME': 'cltbld', 21:08:04 INFO - 'MAIL': '/var/mail/cltbld', 21:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:04 INFO - 'MOZ_NO_REMOTE': '1', 21:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:04 INFO - 'NO_EM_RESTART': '1', 21:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:04 INFO - 'PWD': '/builds/slave/test', 21:08:04 INFO - 'SHELL': '/bin/bash', 21:08:04 INFO - 'SHLVL': '1', 21:08:04 INFO - 'TERM': 'linux', 21:08:04 INFO - 'TMOUT': '86400', 21:08:04 INFO - 'USER': 'cltbld', 21:08:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 21:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:04 INFO - '_': '/tools/buildbot/bin/python'} 21:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:08:04 INFO - Cleaning up... 21:08:04 INFO - Return code: 0 21:08:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d4b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be410>, '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 0x14bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:08:04 INFO - Using env: {'DISPLAY': ':0', 21:08:04 INFO - 'HOME': '/home/cltbld', 21:08:04 INFO - 'LANG': 'en_US.UTF-8', 21:08:04 INFO - 'LANGUAGE': 'en_US:en', 21:08:04 INFO - 'LOGNAME': 'cltbld', 21:08:04 INFO - 'MAIL': '/var/mail/cltbld', 21:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:04 INFO - 'MOZ_NO_REMOTE': '1', 21:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:04 INFO - 'NO_EM_RESTART': '1', 21:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:04 INFO - 'PWD': '/builds/slave/test', 21:08:04 INFO - 'SHELL': '/bin/bash', 21:08:04 INFO - 'SHLVL': '1', 21:08:04 INFO - 'TERM': 'linux', 21:08:04 INFO - 'TMOUT': '86400', 21:08:04 INFO - 'USER': 'cltbld', 21:08:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 21:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:04 INFO - '_': '/tools/buildbot/bin/python'} 21:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:04 INFO - Downloading/unpacking jsonschema 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:08:06 INFO - Downloading/unpacking functools32 (from jsonschema) 21:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:06 INFO - Downloading functools32-3.2.3-2.tar.gz 21:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:08:06 INFO - warning: no files found matching '*.txt' 21:08:06 INFO - no previously-included directories found matching 'build' 21:08:06 INFO - no previously-included directories found matching 'dist' 21:08:06 INFO - no previously-included directories found matching '.git*' 21:08:06 INFO - Installing collected packages: jsonschema, functools32 21:08:06 INFO - Running setup.py install for functools32 21:08:07 INFO - warning: no files found matching '*.txt' 21:08:07 INFO - no previously-included directories found matching 'build' 21:08:07 INFO - no previously-included directories found matching 'dist' 21:08:07 INFO - no previously-included directories found matching '.git*' 21:08:07 INFO - Successfully installed jsonschema functools32 21:08:07 INFO - Cleaning up... 21:08:07 INFO - Return code: 0 21:08:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:07 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 0x7ff9d4b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be410>, '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 0x14bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf7a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:08:07 INFO - Using env: {'DISPLAY': ':0', 21:08:07 INFO - 'HOME': '/home/cltbld', 21:08:07 INFO - 'LANG': 'en_US.UTF-8', 21:08:07 INFO - 'LANGUAGE': 'en_US:en', 21:08:07 INFO - 'LOGNAME': 'cltbld', 21:08:07 INFO - 'MAIL': '/var/mail/cltbld', 21:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:07 INFO - 'MOZ_NO_REMOTE': '1', 21:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:07 INFO - 'NO_EM_RESTART': '1', 21:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:07 INFO - 'PWD': '/builds/slave/test', 21:08:07 INFO - 'SHELL': '/bin/bash', 21:08:07 INFO - 'SHLVL': '1', 21:08:07 INFO - 'TERM': 'linux', 21:08:07 INFO - 'TMOUT': '86400', 21:08:07 INFO - 'USER': 'cltbld', 21:08:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 21:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:07 INFO - '_': '/tools/buildbot/bin/python'} 21:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:07 INFO - Downloading/unpacking flake8 21:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:08:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:08:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:08:09 INFO - no previously-included directories found matching 'docs/_build' 21:08:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:08:10 INFO - Running setup.py install for pep8 21:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:08:10 INFO - no previously-included directories found matching 'docs/_build' 21:08:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:08:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:08:10 INFO - Cleaning up... 21:08:10 INFO - Return code: 0 21:08:10 INFO - Running post-action listener: _resource_record_post_action 21:08:10 INFO - Running post-action listener: _start_resource_monitoring 21:08:10 INFO - Starting resource monitoring. 21:08:10 INFO - ##### 21:08:10 INFO - ##### Running install step. 21:08:10 INFO - ##### 21:08:10 INFO - Running pre-action listener: _resource_record_pre_action 21:08:10 INFO - Running main action method: install 21:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:08:10 INFO - Reading from file tmpfile_stdout 21:08:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:08:10 INFO - Reading from file tmpfile_stdout 21:08:10 INFO - Output received: 21:08:10 INFO - Usage: mozinstall [options] installer 21:08:10 INFO - Options: 21:08:10 INFO - -h, --help show this help message and exit 21:08:10 INFO - -d DEST, --destination=DEST 21:08:10 INFO - Directory to install application into. [default: 21:08:10 INFO - "/builds/slave/test"] 21:08:10 INFO - --app=APP Application being installed. [default: firefox] 21:08:10 INFO - mkdir: /builds/slave/test/build/application 21:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:08:26 INFO - Reading from file tmpfile_stdout 21:08:26 INFO - Output received: 21:08:26 INFO - /builds/slave/test/build/application/firefox/firefox 21:08:26 INFO - Running post-action listener: _resource_record_post_action 21:08:26 INFO - ##### 21:08:26 INFO - ##### Running run-tests step. 21:08:26 INFO - ##### 21:08:26 INFO - Running pre-action listener: _resource_record_pre_action 21:08:26 INFO - Running main action method: run_tests 21:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:08:26 INFO - Python 2.7.3 21:08:26 INFO - Return code: 0 21:08:26 INFO - grabbing minidump binary from tooltool 21:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:26 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 0x14be410>, '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 0x14bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:08:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:08:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:08:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:08:26 INFO - Return code: 0 21:08:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:08:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:08:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:08:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:08:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:08:27 INFO - Return code: 0 21:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:08:27 INFO - Using env: {'DISPLAY': ':0', 21:08:27 INFO - 'HOME': '/home/cltbld', 21:08:27 INFO - 'LANG': 'en_US.UTF-8', 21:08:27 INFO - 'LANGUAGE': 'en_US:en', 21:08:27 INFO - 'LOGNAME': 'cltbld', 21:08:27 INFO - 'MAIL': '/var/mail/cltbld', 21:08:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:08:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:27 INFO - 'MOZ_NO_REMOTE': '1', 21:08:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:27 INFO - 'NO_EM_RESTART': '1', 21:08:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:27 INFO - 'PWD': '/builds/slave/test', 21:08:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:08:27 INFO - 'SHELL': '/bin/bash', 21:08:27 INFO - 'SHLVL': '1', 21:08:27 INFO - 'TERM': 'linux', 21:08:27 INFO - 'TMOUT': '86400', 21:08:27 INFO - 'USER': 'cltbld', 21:08:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091', 21:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:27 INFO - '_': '/tools/buildbot/bin/python'} 21:08:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:08:27 INFO - mozversion application_buildid: 20160525183450 21:08:27 INFO - mozversion application_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 21:08:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:08:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:08:27 INFO - mozversion application_name: Firefox 21:08:27 INFO - mozversion application_remotingname: firefox-dev 21:08:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:08:27 INFO - mozversion application_vendor: Mozilla 21:08:27 INFO - mozversion application_version: 48.0a2 21:08:27 INFO - mozversion platform_buildid: 20160525183450 21:08:27 INFO - mozversion platform_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 21:08:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:08:27 INFO - mozversion platform_version: 48.0a2 21:08:27 INFO - using testdate: 1464235707 21:08:27 INFO - actual date: 1464235707 21:08:27 INFO - starting webserver on 'localhost:38649' 21:08:27 INFO - SUITE-START | Running 2 tests 21:08:27 INFO - TEST-START | dromaeo_css 21:08:27 INFO - operating with platform_type : linux_ 21:08:27 INFO - Initialising browser for dromaeo_css test... 21:08:27 INFO - TEST-INFO | started process 25542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmG8DFw/profile http://localhost:38649/getInfo.html) 21:08:31 INFO - PROCESS | 25542 | __metrics Screen width/height:1600/1200 21:08:31 INFO - PROCESS | 25542 | colorDepth:24 21:08:31 INFO - PROCESS | 25542 | Browser inner width/height: 1024/697 21:08:31 INFO - PROCESS | 25542 | __metrics 21:08:32 ERROR - PROCESS | 25542 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:08:33 INFO - TEST-INFO | 25542: exit 0 21:08:33 INFO - Browser initialized. 21:08:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:08:33 INFO - TEST-INFO | started process 25635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmG8DFw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:08:44 INFO - PROCESS | 25635 | RSS: Main: 142004224 21:08:44 INFO - PROCESS | 25635 | 21:09:36 INFO - PROCESS | 25635 | 1464235776052 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:11:43 INFO - PROCESS | 25635 | Cycle 1(1): loaded http://localhost:38649/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38649/tests/dromaeo/cssquery-ext.html) 21:11:44 INFO - PROCESS | 25635 | RSS: Main: 252063744 21:11:44 INFO - PROCESS | 25635 | 21:14:46 INFO - PROCESS | 25635 | Cycle 1(1): loaded http://localhost:38649/tests/dromaeo/cssquery-ext.html (next: http://localhost:38649/tests/dromaeo/cssquery-jquery.html) 21:14:47 INFO - PROCESS | 25635 | RSS: Main: 225857536 21:14:47 INFO - PROCESS | 25635 | 21:17:48 INFO - PROCESS | 25635 | Cycle 1(1): loaded http://localhost:38649/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38649/tests/dromaeo/cssquery-mootools.html) 21:17:49 INFO - PROCESS | 25635 | RSS: Main: 223305728 21:17:49 INFO - PROCESS | 25635 | 21:20:51 INFO - PROCESS | 25635 | Cycle 1(1): loaded http://localhost:38649/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38649/tests/dromaeo/cssquery-prototype.html) 21:20:51 INFO - PROCESS | 25635 | RSS: Main: 220598272 21:20:51 INFO - PROCESS | 25635 | 21:23:54 INFO - PROCESS | 25635 | Cycle 1(1): loaded http://localhost:38649/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38649/tests/dromaeo/cssquery-yui.html) 21:23:55 INFO - PROCESS | 25635 | RSS: Main: 210026496 21:23:55 INFO - PROCESS | 25635 | 21:26:57 INFO - PROCESS | 25635 | Cycle 1(1): loaded http://localhost:38649/tests/dromaeo/cssquery-yui.html (next: http://localhost:38649/tests/dromaeo/cssquery-dojo.html) 21:26:57 INFO - PROCESS | 25635 | RSS: Main: 255512576 21:26:57 INFO - PROCESS | 25635 | 21:26:57 INFO - PROCESS | 25635 | __start_tp_report 21:26:57 INFO - PROCESS | 25635 | _x_x_mozilla_page_load 21:26:57 INFO - PROCESS | 25635 | _x_x_mozilla_page_load_details 21:26:57 INFO - PROCESS | 25635 | |i|pagename|runs| 21:26:57 INFO - PROCESS | 25635 | |0;dojo.html;3344.1806757344452;3377.3076519313545;3398.320335932813;3426.8800591979257;3442.363162814878;5599.384067752554;5606.299212598426;5615.326160860693;5618.91571626426;5620.91568626471;5594.524465420434;5629.155626656004;5631.239782629344;5636.746346414411;5641.407652196522;4979.0788704089855;5091.338126043618;5140.177571588547;5212.087884620195;5247.737613119348;5070.062038522867;5104;5106.387233531963;5107.4892510749;5109.208072748711;5121.359830021247;5157.974210128963;5187.299714538527;5196.350456192976;5210.400803907562;5108.4125325587665;5114.64197506171;5126.641135120543;5131.358580177478;5159.14874045782;4956.727379994099;4982.202847544376;5011.273365362002;5047.343845300087;5111.897762044739;5466.180072989044;5490.066688662937;5524.06090964537;5547.528460080898;5551.195076713854;6047.971844786397;6077.058056001282;6079;6080.483158931496;6086.421789929994;6096.664683442409;6109.175261339707;6120.877582448326;6138.69306534676;6152.846178845564;5664.065429204176;5698.430156984268;5699.857503562361;5700.287464066992;5703.942960570383;6070.3019152797115;6203.16257305258;6206.658633775095;6208.1308616793685;6211.782587609412;5859.2090067841145;5884.882302353929;5896.616719913192;5912.645241285537;5918.674472903946;6014.218151640346;6046.606970546901;6047.12316714074;6057.969710151421;6061.6666083365835;5861.472467477947;5949.375315591887;6013.609115407485;6014.248218972629;6025.789097381658;6064.969675151596;6067.9684453642985;6068.575199735976;6084.695765211722;6132.846678833065;4563.680542362003;4567.406237189144;4568.360429539867;4594.035252596992;4604.700694454849;3984.442178095069;4035.0517628357898;4064.8577299794365;4109.938350924738;4137.131202447459;5700.4869561738815;5711.685857277889;5719.19931209631;5723.8855222896145;5737.053386191232;6039.094135879654;6101.084837274356;6112.724927378279;6116.724747386378;6121.693915304217;5643.689597072118;5648.406917273709;5702.401247868914;5711.228984087178;5736.110902810071;5182.714950677673;5201.5838732901275;5217.634765566374;5221.686698798008;5224.477552244821;6272.153259310026;6315.147455093504;6330.588511746721;6336.936630633727;6340;5963.016102343152;6090.878182436415;6109.495762817132;6130.092410195535;6132.386102851662;6219.129321894848;6228.34602366745;6243.687815609293;6244.531660125418;6279.277883043325;5821.476067153976;5966.313873904556;5974.803604608899;5982.581219314607;6006.399360063959;5989.940100598938;6021.909671355021;6029.57792954489;6044.546659000681;6054.39456054391;5934.376890426443;5982.820515384371;5989.40105989415;5990.161377407079;5990.161377407254;5795.304563452412;5886.499647529837;5913.083472061838;5930.080837470199;5944.791932282349;5749.051406518045;5758.510526605285;5767.307923049261;5795.275590551181;5824.097264923944;5873.119032145212;5878.911816322673;5880.235569375954;5908.3796201399955;5914.763409463573;5774.884502310014;5790.449907258803;5793.0731083028195;5826.854328641818;5864.530837532901 21:26:57 INFO - PROCESS | 25635 | |1;ext.html;634.9904751428727;671.660811290298;677.8102131403209;680.9455243580512;714.774845923534;39966.40050399247;41560.79219603898;41679.583204167946;41707.37438938418;41749.16501669965;43284.783576082074;43678.78160609193;43955.78022109893;43960.3405948911;44053.33919991195;8628.870566941485;8775.385722999392;8798.208161265486;8802.07578204289;8811.647534098629;8804.955975220115;8916.15296546827;8933.062028487013;9172.12864777845;9172.678956236534;9203.17171454569;9269.814603707922;9271.814563708722;9275.489848058354;9291.070892910722;9121.81756364869;9131.08689131085;9187.67843125494;9188.908110918905;9213.355065145442;9071.863922041175;9166.312526560469;9185.402948808307;9187.035361287102;9192.862107068398;44500.554994450285;45334.093318133455;45403.54596454059;45429.77285113553;45547.178112875445;3959.465472161279;3997.600239976008;4034.4553485279407;4066.8983275418054;4109.321961876287;33482.83258583716;34057.14857128567;34122.82938585316;34176.14559636004;35571;4448.955510444886;4495.842645507391;4525.434320709911;4526.140033393644;4557.794899229542;330898.9999999976;334561;334795;335567;337124;39636;63730.362696372445;64444.355556444774;64581.67709161518;64682;38062.61937380591;38235.23529529394;38257.80871095627;38272;38317;16314.510564683078;16571;16593.50219493393;16600.916995414944;16602.169891505375;12648.430820613094;12702.80945785814;12717.427715752814;12722.173058751152;12725.681857953625;9132.178103970542;9271.07289271081;9339.90660093404;9387.859182112274;9396.577154028086;3559.1635965548076;3605.7656252344036;3617.656322649344;3618.764780289273;3644.1071937375514;1160.7620437810228;1189.3220864107375;1225.3580202528653;1233.105998151351;1247.2267194339386;34228.14429639229;34518.19701164938;34598.30803383918;34599.827000865334;34986.12534686602;1272.3828942962655;1273.1043008394158;1273.7452509497953;1304.1718508746824;1402.6353148181547;17499.212535435683;18065.367712130013;18271.72592411115;18321.816781832276;18363;484480;485157;488540;489768;489778;63529;63745.68127159335;64380.35619643837;64411.35588644147;64514.677426612565;1457.6355911022245;1470.4338829550486;1495.1776522912571;1516.5753588995099;1520.217088199578;33490.162745930575;33952;34192.48711269383;34205.48819400112;34360.31279374449;55990;56643.71678141583;56690.433095668515;56691.149632754714;56849;446765;447649;448691;449405;449573;27891;30327.393452130393;31012.22469438282;31485.055448336585;31552;45198.54801451943;45713.54286457226;45779.31331030104;46200.30699539577;46925;40758.38862417007;41206.97737042164;42104.57895421007;42533;42637.36043959405;40131.799341003105;40761;40917.79541102275;41257.381139283534;41693.58306417018;42863.3570496449;45455.31817022681;46220;46511;47031.52968470408;35944.64055359518;37371.81314093412;37840.43239351467;37893.24213515659;38348.23303533858;29043.419131617673;29528.704712953455;29688.851555742945;29701.108966730168;29882.551761724026 21:26:57 INFO - PROCESS | 25635 | |2;jquery.html;391.5458068640377;396.59547261792966;402.24980411532465;422.5457633044478;431.52963270035656;15786.36854525819;18699.158537865795;18732.344367947124;18736.62526749464;18738.15678294475;18837.340693075745;19184;19497.22011119557;19506.609867802636;19510.31713890014;4329.177456283312;5727.541796656268;5886.411358864122;5887.175795388627;5893.057110862263;6234.376562343775;6563.048357988089;6565.179352580927;6566.113574667406;6577.24361698406;5647.09646456567;5886.411358864122;6480.902786458207;6497.05792660064;6502.122213501164;5198.428172900978;5833.533317334645;5846.473817356437;5851.707414629294;5873.911891321633;5687.402822703598;5706.258186435778;5716.742746576414;5728.828135155952;5779.422057794229;13712.862871371259;13728.45086196551;13768.65578360549;13877.306134693326;19464;2350.670906073151;2478.120267305099;2509.723930367658;2513.9748602513923;2586.237060067285;10180.898191018143;10720.51757670899;10937.781244375068;13136.540221092217;14688.55934321972;2056.619525387793;2057.845661575373;2064.6283668939586;2081.4172031831113;2082.9479263018393;80294;81441.18558814396;87083.56458217732;87512;88015.55992219997;11224.270422422516;11252.887471125348;11267.492962816694;11491.42542872853;11517.827232591519;15175.937684361988;15257.389704411698;15257.847421525865;15314.693706126038;15631;8207.302379297827;8353.24820766134;8403.201695838885;8462.323014158852;8569.357298202534;8339.54132522705;8418.158184181655;8438.620262088221;8526.445781024213;8533.658653653783;4872.585830204402;4876.439209490883;4885.413750349981;4905.166121759309;4985.351904252497;1955.1299671645982;1996.2813387180604;2008.7589489261381;2043.4074118505466;2056.42420122363;940.6707652321633;1064.5103252503934;1092.202692034819;1113.4210210690396;1147.5352482244705;18722.906385467984;19716.70424943627;20311.593768124556;20663.17347306091;20734;1043.3531210649446;1056.7569459024467;1095.9342439453499;1099.444780385916;1153.4809335798925;10597.4701264938;11000.119990400908;11024.283421577571;11097.72255693598;11216.887831121747;264875;473241;512291;591560.5063696192;591759;59067.40932590619;90949;101617.49191254145;104171.4791426038;104935;1094.3488624268548;1100.1748688483638;1109.6530837279097;1113.3820729495046;1121.1647322744607;16705.331786728882;16729.33082676728;17371.392001279895;17730.670199734814;18063.2774689011;38526.229475409775;38843.80578097091;40798.796006020966;42640;43434;55619;55637.16544251759;56376.46305916326;56537;56922;9053.456792592466;9152.313576481658;9156.633734650539;9168.770780730536;9384.57769400365;9858.950705246429;13461.528846490326;13541.322933853071;13635.318234088058;14042.578722638336;12225.205361651464;12312.445939932904;12371.628851134481;12376.195547289397;12479.251244925334;10016.298859079794;10027.298089133983;12222.449989750305;12222.633321000385;12427.587169593178;12252.75494490123;12657.367131643565;12834.871651283742;12849.614511564669;13010.284434356201;9109.817803643757;9111.498867562348;9154.450732956044;9226.215771659485;9354;9384.859227111463;11882.584109556125;12312.199707019015;12500.31248281317;12785.105042647298 21:26:57 INFO - PROCESS | 25635 | |3;mootools.html;1376.8210132682746;1381.6338670252378;1403.501756876309;1557.6183834960436;1852.0461962089526;7958.960205198973;8137.349012079034;8154.673813047471;8174.713885014025;8183.795405114867;8096.797580060502;8247.42268041236;8250.298724608401;8273.089960104398;8288.419810613259;2109.757377901538;2134.1676746069047;2379.1316169598144;2406.254061241012;2426.805855531562;2427.987860060706;2445.645381419693;2447.363685441789;2450.5588993981078;2450.7059152901675;2342.61346877765;2356.1164563288767;2395.808335333169;2403.9519209615796;2405.9157929472385;2087.4781304673834;2131.509752756859;2133.349328454821;2353.635186546088;2419.4072452249225;2358.929232123022;2365.6451532270125;2387.5105603351444;2388.2954528413984;2389.127968291561;7965.641546130438;7995.960020199862;8022.197780221931;8033.638486268132;8041.758747237593;5159.458256883011;5242.344706911636;5253.001929633358;5281.947180528184;5290.629655924048;3285.7535684823733;3294.324663444012;3392.5759280089987;3418.1454636340914;3420.9144771380666;1173.8180582009716;1195.940202989847;1207.4445754952733;1207.4928530017414;1224.6203676860114;11673.1828771986;11688;11688.941555292255;11709.824352634718;11712.355820429873;4586.816527338936;4685.484596694361;4739.275938493586;4761.976190119097;4881.219004959189;10007.599696012223;10017.298789084694;10033.698989030341;10048.648297309705;10078.19374450057;5232.659877108052;5274.525292723597;5278.287431196816;5289.814856480005;5294.523492885659;4192.559781222989;4791.520847915251;4829.613630909519;4895.0209958008545;4896.902061958812;4072.6175187515637;4084.6528045116497;4115.8765237042935;4129.091599848029;4177.352510360899;1270.968225794344;1278.725074109071;1279.6883194725294;1283.076185146693;1310.462710288777;965.9275554333453;1056.5351245451977;1067.0876400677464;1077.3374374759467;1091.6179337231906;5931.7627294907725;5956.5532585055425;5959.076343166729;6065.4541091302;6200.627962322275;436.93664418659114;446.2547545598858;450.6665067849833;457.38253357966477;457.75052596335075;3984.960150398459;4000.159966407029;4033.8184781684895;4049.8987525312104;4053.8175782089875;9712.9028709712;9888.110070093582;9932.304738668225;9945.055219754111;9954.751131221778;9493.66772162971;9787.070228328297;9793.559289831976;9797.902020979698;9813.558389872473;7718.343940765098;7767.417443691746;7834;7844.097928738268;7853.293203611703;5566.4990150886615;5584.246126772834;5676.091825307931;5688.374278829243;5715.685637289989;8668.956655216683;8708.521031343336;8743.475391476532;8790.033096359522;8946.150115738994;8895.110488951053;8991.190792828676;9021;9040.186383225542;9102.544872756203;6421.229452465547;6501.284858665448;7218.422526197996;7283.635818209174;7345.706171753283;7907.327877130509;7909.485883417559;7927;7927.484713493604;7960.243776841423;7075.6815943281645;7220.0613920190035;7241.167265764505;7311.488195826241;7399.371053460516;6977.33715297046;6999.545029573062;7168.820779480555;7240.674169662272;7267.890981635174;6614.10709554204;6642.867142657024;6933.0293758874805;6965.303469653197;6966;5143.434222235626;5156.1492353761205;5167.1474206755465;5187.29971453864;5219.76511057011;4991.3511243538105;5047.167217409086;5107.438181800073;5245.580353571781;5246.921296180484 21:26:57 INFO - PROCESS | 25635 | |4;prototype.html;356.21276977878887;356.5471850749548;360.06562969095194;360.4359177886608;363.89992751993196;6169.043798211284;6170.197874276343;6180.443760061594;6195.504359651229;6213.378662133784;6107.3587273336325;6109.602875813081;6119;6134.04922237054;6135.079738039296;4555.157295900261;4636;4661.067786442708;4709.670323077386;4721.7639118044135;4722.504137065593;4731.78706958186;4742.19382704941;4748.169070412681;4764.6188304935695;4721.079389519028;4722.7402492862875;4732.384789977315;4735.171345014626;4745.620350371962;4550.203714349992;4618;4709.505501922283;4716.551927566876;4730.408698912636;4187.099773548671;4190.099128687317;4191.685623578243;4195.139996300751;4197.769122698251;5902.173695682608;5920.97039514804;5921.289445266552;5927.614705044159;5943.0194017987415;5506.889862202774;5509.614326997112;5510.586705997026;5517.724113794295;5520.66875987438;6441.388068133567;6448.54860159789;6452.870942581122;6453.354664533556;6453.709583068773;4565.817367305303;4654.534546545352;4658.510856360067;4661.160991021615;4665.346851440801;6696.1629796275465;6712.060311556386;6714.731410743564;6714.932850671479;6720.428763555104;4743.45450273223;4756.025014871943;4757.738324392191;4765.380500534909;4772.284157376422;4818.759062046884;4823.252395878644;4828;4831.202851529529;4834.685745426536;5487.945120548743;5490.066688662937;5494.340679118452;5496.835094947158;5506.146547285177;6271.247450305992;6429.9678501607195;6445.1621289233035;6499.512536559777;6516.902246466307;1637.8689704823585;1647.1928754910007;1654.6690661867433;1657.2128239086337;1658.7263101588103;1041.5521325829814;1084.159776173472;1093.830456279278;1107.6289443036674;1119.0488085127738;6116.2048933639235;6238.937610623926;6245.875082498324;6248.094026366242;6268.49852011838;6652.434543063797;6677.165354330708;6677.198736151596;6680.432163266177;6680.766173183915;6212.502999760009;6222.906656400158;6225.782097626652;6231.906521402183;6248.687565621701;3525.383057964846;3595.7482976191413;3600.71194304455;3602.585702644177;3606.13452771333;6814.795556133324;6895.379415852597;6955.339242771928;6960.408365289007;6977.755778547727;6795.18457785059;6808.319168083152;6810.795676129724;6812.114425124702;6817.965910170417;6877.071595334666;6918.169819621678;6934.271901450275;6945.583265004116;6948.722051117898;6659.866802663822;6660.333966603301;6660.600363978177;6676.632785196666;6679.198496180489;6475.061116138228;6554.8361290968105;6598.769043083469;6607.141071660653;6609.966950165411;6888.758893438706;6919.619420931897;6921.861562768817;6925.68834402443;6930.3762661360715;4663.696859704109;4668.976655116839;4670.579647831712;4673.3924589804465;4678.274867395559;6632.734690612321;6636.469082473487;6647.401733843783;6647.567908085959;6647.667616619053;6359.459445946961;6482.384173503509;6482.448991835747;6490.870182596416;6505.2844187138435;6417.6470294132405;6449.677516124081;6455.580387274812;6455.806325810233;6459.709313080829;6335.588186767845;6341.0805433212845;6355.459785918249;6359.554831161774;6362.554621176473;6505.089287499659;6508.869822603616;6510.641914694737;6518.120053792867;6521.445677117498;6021.277446706424;6135.84660383494;6337.714802833976;6350.428461438492;6368.363163683594 21:26:57 INFO - PROCESS | 25635 | |5;yui.html;799.1249581708028;819.1153554161502;873.5064688451029;908.3232991421391;921.2445794448553;15284.541463756077;15600.843991560081;15610.375584976602;15690.84309156908;15736.291866865975;14128.646783830409;14341.13953162811;14341.928290358534;14363.856361436383;14370.856291437083;727.6361819090455;858.2490320969152;876.4215617692324;890.9465432074064;899.4783025844994;889.4707648948897;895.4403497813867;895.8745775591423;896.6547879066541;896.8565029595266;932.580338847518;933.2673851026946;933.593886659302;933.6685476655791;934.0332755597957;769.042542035167;923.9445633261993;925.7685578605349;945.5130607737021;946.839037363643;695.8712638161957;696.4532841719276;696.4532841719276;697.504771612156;697.9720811167547;14828.55514334561;14906.552803415807;14907;14924.850751492564;14957.626059348495;15109.848901510954;15360.769588456182;15408.152551609657;15510.379584816594;15575.37698492059;11306.547738090467;11331.093512518979;11658.708532286675;11710.297382157098;11859.347735874524;4033.132876431552;4070.6743460523385;4098.098418347959;4125.257453658341;4176.895577610554;57215.14177287344;57264.42735572633;57352.13971790426;57420.71289643567;57422.7128864353;11140.554377824958;11189.160812939062;11257.155713321534;11558.479868405942;11748.471318790504;21717.891410542845;21728.565428691654;21749.78250217509;21770.238041668465;21789.564208716052;8647.740567782977;8715.651373944971;8723.476591404537;8794.780130496789;8921.776955576162;4905.607551395951;4918.606511479073;4956.207006878954;5070.949290507121;5106.591472682177;3596.6403359663823;3638.8180590970346;3646.070252085701;3646.3983442732183;3648.7445878788762;672.9966350168218;674.6694119881223;676.4317972902687;678.3115138134797;691.6991108867659;654.3881470824793;696.2654399608462;753.1978442958341;767.7965339185121;768.965396557145;9949.154321882575;10530.736731581772;10660.360378377321;10718.839217411745;10788.244822862482;689.2797027106685;726.8364617960916;760.1941941541983;799.2007992007992;808.1110031636922;4843.806247750051;4942.950570494321;4947.109520286383;4993.675411098339;5105.693658380509;66173.00740488897;66915.33084669188;67720.6613966927;67848.6607566959;67992.98010529845;56494.43505564974;59256.40743592509;59613.40386596078;59683.40316596865;59778.10332845011;54568.181477277874;54851.72574137104;54948.725256373466;55359.723201383735;55529;9678.322517423994;9903.207743380368;9947.104760571583;9953.153981911619;9991.950040249752;38647.42028869625;38869.22261554696;39670.60329396669;40219.59780402276;40344.596554034084;44069.11861762811;44757.328640069776;51024;52023;52455.47544524506;11661.76676466483;11686.94156529212;11801.468933898166;12086.516539338329;12164.513419463476;10993.725156871142;12500.624981250578;12670.986321094106;12740.299283539494;12848.871511284768;12373.814392783936;12433.316167610868;12591.748165036464;12635.684107897008;12734.68163295888;12615.684607884876;12858.0999330046;12943.870561294643;13038.804417933548;13287.534936277183;13031.934840326117;13040.934795326342;13319;13525.864741352461;13710.17738935667;10882.374990629109;11209;11301;11422.82865757031;11635;11223;11564.248323858923;11579.421028948687;11594.94202528982;11673.066154707432 21:26:57 INFO - PROCESS | 25635 | __end_tp_report 21:26:57 INFO - PROCESS | 25635 | __start_cc_report 21:26:57 INFO - PROCESS | 25635 | _x_x_mozilla_cycle_collect,837 21:26:57 INFO - PROCESS | 25635 | __end_cc_report 21:26:57 INFO - PROCESS | 25635 | __startTimestamp1464236817507__endTimestamp 21:26:57 INFO - PROCESS | 25635 | 21:26:57 INFO - PROCESS | 25635 | ------- Summary: start ------- 21:26:57 INFO - PROCESS | 25635 | Number of tests: 6 21:26:57 INFO - PROCESS | 25635 | 21:26:57 INFO - PROCESS | 25635 | [#0] dojo.html Cycles:165 Average:5609.57 Median:5795.30 stddev:636.44 (11.0%) stddev-sans-first:613.08 21:26:57 INFO - PROCESS | 25635 | Values: 3344.2 3377.3 3398.3 3426.9 3442.4 5599.4 5606.3 5615.3 5618.9 5620.9 5594.5 5629.2 5631.2 5636.7 5641.4 4979.1 5091.3 5140.2 5212.1 5247.7 5070.1 5104.0 5106.4 5107.5 5109.2 5121.4 5158.0 5187.3 5196.4 5210.4 5108.4 5114.6 5126.6 5131.4 5159.1 4956.7 4982.2 5011.3 5047.3 5111.9 5466.2 5490.1 5524.1 5547.5 5551.2 6048.0 6077.1 6079.0 6080.5 6086.4 6096.7 6109.2 6120.9 6138.7 6152.8 5664.1 5698.4 5699.9 5700.3 5703.9 6070.3 6203.2 6206.7 6208.1 6211.8 5859.2 5884.9 5896.6 5912.6 5918.7 6014.2 6046.6 6047.1 6058.0 6061.7 5861.5 5949.4 6013.6 6014.2 6025.8 6065.0 6068.0 6068.6 6084.7 6132.8 4563.7 4567.4 4568.4 4594.0 4604.7 3984.4 4035.1 4064.9 4109.9 4137.1 5700.5 5711.7 5719.2 5723.9 5737.1 6039.1 6101.1 6112.7 6116.7 6121.7 5643.7 5648.4 5702.4 5711.2 5736.1 5182.7 5201.6 5217.6 5221.7 5224.5 6272.2 6315.1 6330.6 6336.9 6340.0 5963.0 6090.9 6109.5 6130.1 6132.4 6219.1 6228.3 6243.7 6244.5 6279.3 5821.5 5966.3 5974.8 5982.6 6006.4 5989.9 6021.9 6029.6 6044.5 6054.4 5934.4 5982.8 5989.4 5990.2 5990.2 5795.3 5886.5 5913.1 5930.1 5944.8 5749.1 5758.5 5767.3 5795.3 5824.1 5873.1 5878.9 5880.2 5908.4 5914.8 5774.9 5790.4 5793.1 5826.9 5864.5 21:26:57 INFO - PROCESS | 25635 | 21:26:57 INFO - PROCESS | 25635 | [#1] ext.html Cycles:180 Average:58691.05 Median:41700.48 stddev:113414.07 (272.0%) stddev-sans-first:113648.46 21:26:57 INFO - PROCESS | 25635 | Values: 635.0 671.7 677.8 680.9 714.8 39966.4 41560.8 41679.6 41707.4 41749.2 43284.8 43678.8 43955.8 43960.3 44053.3 8628.9 8775.4 8798.2 8802.1 8811.6 8805.0 8916.2 8933.1 9172.1 9172.7 9203.2 9269.8 9271.8 9275.5 9291.1 9121.8 9131.1 9187.7 9188.9 9213.4 9071.9 9166.3 9185.4 9187.0 9192.9 44500.6 45334.1 45403.5 45429.8 45547.2 3959.5 3997.6 4034.5 4066.9 4109.3 33482.8 34057.1 34122.8 34176.1 35571.0 4449.0 4495.8 4525.4 4526.1 4557.8 330899.0 334561.0 334795.0 335567.0 337124.0 39636.0 63730.4 64444.4 64581.7 64682.0 38062.6 38235.2 38257.8 38272.0 38317.0 16314.5 16571.0 16593.5 16600.9 16602.2 12648.4 12702.8 12717.4 12722.2 12725.7 9132.2 9271.1 9339.9 9387.9 9396.6 3559.2 3605.8 3617.7 3618.8 3644.1 1160.8 1189.3 1225.4 1233.1 1247.2 34228.1 34518.2 34598.3 34599.8 34986.1 1272.4 1273.1 1273.7 1304.2 1402.6 17499.2 18065.4 18271.7 18321.8 18363.0 484480.0 485157.0 488540.0 489768.0 489778.0 63529.0 63745.7 64380.4 64411.4 64514.7 1457.6 1470.4 1495.2 1516.6 1520.2 33490.2 33952.0 34192.5 34205.5 34360.3 55990.0 56643.7 56690.4 56691.1 56849.0 446765.0 447649.0 448691.0 449405.0 449573.0 27891.0 30327.4 31012.2 31485.1 31552.0 45198.5 45713.5 45779.3 46200.3 46925.0 40758.4 41207.0 42104.6 42533.0 42637.4 40131.8 40761.0 40917.8 41257.4 41693.6 42863.4 45455.3 46220.0 46511.0 47031.5 35944.6 37371.8 37840.4 37893.2 38348.2 29043.4 29528.7 29688.9 29701.1 29882.6 21:26:57 INFO - PROCESS | 25635 | 21:26:57 INFO - PROCESS | 25635 | [#2] jquery.html Cycles:180 Average:28926.14 Median:11363.90 stddev:82826.93 (728.9%) stddev-sans-first:83031.57 21:26:57 INFO - PROCESS | 25635 | Values: 391.5 396.6 402.2 422.5 431.5 15786.4 18699.2 18732.3 18736.6 18738.2 18837.3 19184.0 19497.2 19506.6 19510.3 4329.2 5727.5 5886.4 5887.2 5893.1 6234.4 6563.0 6565.2 6566.1 6577.2 5647.1 5886.4 6480.9 6497.1 6502.1 5198.4 5833.5 5846.5 5851.7 5873.9 5687.4 5706.3 5716.7 5728.8 5779.4 13712.9 13728.5 13768.7 13877.3 19464.0 2350.7 2478.1 2509.7 2514.0 2586.2 10180.9 10720.5 10937.8 13136.5 14688.6 2056.6 2057.8 2064.6 2081.4 2082.9 80294.0 81441.2 87083.6 87512.0 88015.6 11224.3 11252.9 11267.5 11491.4 11517.8 15175.9 15257.4 15257.8 15314.7 15631.0 8207.3 8353.2 8403.2 8462.3 8569.4 8339.5 8418.2 8438.6 8526.4 8533.7 4872.6 4876.4 4885.4 4905.2 4985.4 1955.1 1996.3 2008.8 2043.4 2056.4 940.7 1064.5 1092.2 1113.4 1147.5 18722.9 19716.7 20311.6 20663.2 20734.0 1043.4 1056.8 1095.9 1099.4 1153.5 10597.5 11000.1 11024.3 11097.7 11216.9 264875.0 473241.0 512291.0 591560.5 591759.0 59067.4 90949.0 101617.5 104171.5 104935.0 1094.3 1100.2 1109.7 1113.4 1121.2 16705.3 16729.3 17371.4 17730.7 18063.3 38526.2 38843.8 40798.8 42640.0 43434.0 55619.0 55637.2 56376.5 56537.0 56922.0 9053.5 9152.3 9156.6 9168.8 9384.6 9859.0 13461.5 13541.3 13635.3 14042.6 12225.2 12312.4 12371.6 12376.2 12479.3 10016.3 10027.3 12222.4 12222.6 12427.6 12252.8 12657.4 12834.9 12849.6 13010.3 9109.8 9111.5 9154.5 9226.2 9354.0 9384.9 11882.6 12312.2 12500.3 12785.1 21:26:57 INFO - PROCESS | 25635 | 21:26:57 INFO - PROCESS | 25635 | [#3] mootools.html Cycles:180 Average:5501.60 Median:5177.22 stddev:2984.26 (57.6%) stddev-sans-first:2976.52 21:26:57 INFO - PROCESS | 25635 | Values: 1376.8 1381.6 1403.5 1557.6 1852.0 7959.0 8137.3 8154.7 8174.7 8183.8 8096.8 8247.4 8250.3 8273.1 8288.4 2109.8 2134.2 2379.1 2406.3 2426.8 2428.0 2445.6 2447.4 2450.6 2450.7 2342.6 2356.1 2395.8 2404.0 2405.9 2087.5 2131.5 2133.3 2353.6 2419.4 2358.9 2365.6 2387.5 2388.3 2389.1 7965.6 7996.0 8022.2 8033.6 8041.8 5159.5 5242.3 5253.0 5281.9 5290.6 3285.8 3294.3 3392.6 3418.1 3420.9 1173.8 1195.9 1207.4 1207.5 1224.6 11673.2 11688.0 11688.9 11709.8 11712.4 4586.8 4685.5 4739.3 4762.0 4881.2 10007.6 10017.3 10033.7 10048.6 10078.2 5232.7 5274.5 5278.3 5289.8 5294.5 4192.6 4791.5 4829.6 4895.0 4896.9 4072.6 4084.7 4115.9 4129.1 4177.4 1271.0 1278.7 1279.7 1283.1 1310.5 965.9 1056.5 1067.1 1077.3 1091.6 5931.8 5956.6 5959.1 6065.5 6200.6 436.9 446.3 450.7 457.4 457.8 3985.0 4000.2 4033.8 4049.9 4053.8 9712.9 9888.1 9932.3 9945.1 9954.8 9493.7 9787.1 9793.6 9797.9 9813.6 7718.3 7767.4 7834.0 7844.1 7853.3 5566.5 5584.2 5676.1 5688.4 5715.7 8669.0 8708.5 8743.5 8790.0 8946.2 8895.1 8991.2 9021.0 9040.2 9102.5 6421.2 6501.3 7218.4 7283.6 7345.7 7907.3 7909.5 7927.0 7927.5 7960.2 7075.7 7220.1 7241.2 7311.5 7399.4 6977.3 6999.5 7168.8 7240.7 7267.9 6614.1 6642.9 6933.0 6965.3 6966.0 5143.4 5156.1 5167.1 5187.3 5219.8 4991.4 5047.2 5107.4 5245.6 5246.9 21:26:57 INFO - PROCESS | 25635 | 21:26:57 INFO - PROCESS | 25635 | [#4] prototype.html Cycles:180 Average:5444.38 Median:6187.97 stddev:1615.45 (26.1%) stddev-sans-first:1574.19 21:26:57 INFO - PROCESS | 25635 | Values: 356.2 356.5 360.1 360.4 363.9 6169.0 6170.2 6180.4 6195.5 6213.4 6107.4 6109.6 6119.0 6134.0 6135.1 4555.2 4636.0 4661.1 4709.7 4721.8 4722.5 4731.8 4742.2 4748.2 4764.6 4721.1 4722.7 4732.4 4735.2 4745.6 4550.2 4618.0 4709.5 4716.6 4730.4 4187.1 4190.1 4191.7 4195.1 4197.8 5902.2 5921.0 5921.3 5927.6 5943.0 5506.9 5509.6 5510.6 5517.7 5520.7 6441.4 6448.5 6452.9 6453.4 6453.7 4565.8 4654.5 4658.5 4661.2 4665.3 6696.2 6712.1 6714.7 6714.9 6720.4 4743.5 4756.0 4757.7 4765.4 4772.3 4818.8 4823.3 4828.0 4831.2 4834.7 5487.9 5490.1 5494.3 5496.8 5506.1 6271.2 6430.0 6445.2 6499.5 6516.9 1637.9 1647.2 1654.7 1657.2 1658.7 1041.6 1084.2 1093.8 1107.6 1119.0 6116.2 6238.9 6245.9 6248.1 6268.5 6652.4 6677.2 6677.2 6680.4 6680.8 6212.5 6222.9 6225.8 6231.9 6248.7 3525.4 3595.7 3600.7 3602.6 3606.1 6814.8 6895.4 6955.3 6960.4 6977.8 6795.2 6808.3 6810.8 6812.1 6818.0 6877.1 6918.2 6934.3 6945.6 6948.7 6659.9 6660.3 6660.6 6676.6 6679.2 6475.1 6554.8 6598.8 6607.1 6610.0 6888.8 6919.6 6921.9 6925.7 6930.4 4663.7 4669.0 4670.6 4673.4 4678.3 6632.7 6636.5 6647.4 6647.6 6647.7 6359.5 6482.4 6482.4 6490.9 6505.3 6417.6 6449.7 6455.6 6455.8 6459.7 6335.6 6341.1 6355.5 6359.6 6362.6 6505.1 6508.9 6510.6 6518.1 6521.4 6021.3 6135.8 6337.7 6350.4 6368.4 21:26:57 INFO - PROCESS | 25635 | 21:26:57 INFO - PROCESS | 25635 | [#5] yui.html Cycles:180 Average:15890.39 Median:24800.57 stddev:18519.63 (74.7%) stddev-sans-first:18536.90 21:26:57 INFO - PROCESS | 25635 | Values: 799.1 819.1 873.5 908.3 921.2 15284.5 15600.8 15610.4 15690.8 15736.3 14128.6 14341.1 14341.9 14363.9 14370.9 727.6 858.2 876.4 890.9 899.5 889.5 895.4 895.9 896.7 896.9 932.6 933.3 933.6 933.7 934.0 769.0 923.9 925.8 945.5 946.8 695.9 696.5 696.5 697.5 698.0 14828.6 14906.6 14907.0 14924.9 14957.6 15109.8 15360.8 15408.2 15510.4 15575.4 11306.5 11331.1 11658.7 11710.3 11859.3 4033.1 4070.7 4098.1 4125.3 4176.9 57215.1 57264.4 57352.1 57420.7 57422.7 11140.6 11189.2 11257.2 11558.5 11748.5 21717.9 21728.6 21749.8 21770.2 21789.6 8647.7 8715.7 8723.5 8794.8 8921.8 4905.6 4918.6 4956.2 5070.9 5106.6 3596.6 3638.8 3646.1 3646.4 3648.7 673.0 674.7 676.4 678.3 691.7 654.4 696.3 753.2 767.8 769.0 9949.2 10530.7 10660.4 10718.8 10788.2 689.3 726.8 760.2 799.2 808.1 4843.8 4943.0 4947.1 4993.7 5105.7 66173.0 66915.3 67720.7 67848.7 67993.0 56494.4 59256.4 59613.4 59683.4 59778.1 54568.2 54851.7 54948.7 55359.7 55529.0 9678.3 9903.2 9947.1 9953.2 9992.0 38647.4 38869.2 39670.6 40219.6 40344.6 44069.1 44757.3 51024.0 52023.0 52455.5 11661.8 11686.9 11801.5 12086.5 12164.5 10993.7 12500.6 12671.0 12740.3 12848.9 12373.8 12433.3 12591.7 12635.7 12734.7 12615.7 12858.1 12943.9 13038.8 13287.5 13031.9 13040.9 13319.0 13525.9 13710.2 10882.4 11209.0 11301.0 11422.8 11635.0 11223.0 11564.2 11579.4 11594.9 11673.1 21:26:57 INFO - PROCESS | 25635 | -------- Summary: end -------- 21:26:57 INFO - PROCESS | 25635 | 21:26:58 INFO - TEST-INFO | 25635: exit 0 21:26:58 INFO - TEST-OK | dromaeo_css | took 1110773ms 21:26:58 INFO - TEST-START | kraken 21:26:58 INFO - operating with platform_type : linux_ 21:26:58 INFO - Initialising browser for kraken test... 21:26:58 INFO - TEST-INFO | started process 25828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI2a_JF/profile http://localhost:38649/getInfo.html) 21:27:02 INFO - PROCESS | 25828 | __metrics Screen width/height:1600/1200 21:27:02 INFO - PROCESS | 25828 | colorDepth:24 21:27:02 INFO - PROCESS | 25828 | Browser inner width/height: 1024/697 21:27:02 INFO - PROCESS | 25828 | __metrics 21:27:03 ERROR - PROCESS | 25828 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:27:03 INFO - TEST-INFO | 25828: exit 0 21:27:03 INFO - Browser initialized. 21:27:03 INFO - Running cycle 1/1 for kraken test... 21:27:03 INFO - TEST-INFO | started process 25917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI2a_JF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:27:15 INFO - PROCESS | 25917 | RSS: Main: 141791232 21:27:15 INFO - PROCESS | 25917 | 21:27:17 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38649/tests/kraken/driver.html?testName=audio-beat-detection) 21:27:18 INFO - PROCESS | 25917 | RSS: Main: 197292032 21:27:18 INFO - PROCESS | 25917 | 21:27:21 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38649/tests/kraken/driver.html?testName=audio-dft) 21:27:22 INFO - PROCESS | 25917 | RSS: Main: 181768192 21:27:22 INFO - PROCESS | 25917 | 21:27:24 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38649/tests/kraken/driver.html?testName=audio-fft) 21:27:25 INFO - PROCESS | 25917 | RSS: Main: 271798272 21:27:25 INFO - PROCESS | 25917 | 21:27:27 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38649/tests/kraken/driver.html?testName=audio-oscillator) 21:27:28 INFO - PROCESS | 25917 | RSS: Main: 178343936 21:27:28 INFO - PROCESS | 25917 | 21:27:30 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38649/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:27:30 INFO - PROCESS | 25917 | RSS: Main: 176119808 21:27:30 INFO - PROCESS | 25917 | 21:27:33 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38649/tests/kraken/driver.html?testName=imaging-darkroom) 21:27:34 INFO - PROCESS | 25917 | RSS: Main: 211075072 21:27:34 INFO - PROCESS | 25917 | 21:27:37 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38649/tests/kraken/driver.html?testName=imaging-desaturate) 21:27:38 INFO - PROCESS | 25917 | RSS: Main: 211197952 21:27:38 INFO - PROCESS | 25917 | 21:27:41 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38649/tests/kraken/driver.html?testName=json-parse-financial) 21:27:41 INFO - PROCESS | 25917 | RSS: Main: 211656704 21:27:41 INFO - PROCESS | 25917 | 21:27:43 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38649/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:27:43 INFO - PROCESS | 25917 | RSS: Main: 190443520 21:27:43 INFO - PROCESS | 25917 | 21:27:45 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38649/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:27:46 INFO - PROCESS | 25917 | RSS: Main: 195489792 21:27:46 INFO - PROCESS | 25917 | 21:27:48 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38649/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:27:48 INFO - PROCESS | 25917 | RSS: Main: 206512128 21:27:48 INFO - PROCESS | 25917 | 21:27:51 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:27:51 INFO - PROCESS | 25917 | RSS: Main: 213327872 21:27:51 INFO - PROCESS | 25917 | 21:27:54 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:27:55 INFO - PROCESS | 25917 | RSS: Main: 210173952 21:27:55 INFO - PROCESS | 25917 | 21:27:56 INFO - PROCESS | 25917 | Cycle 1(1): loaded http://localhost:38649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38649/tests/kraken/driver.html?testName=ai-astar) 21:27:57 INFO - PROCESS | 25917 | RSS: Main: 273784832 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | __start_tp_report 21:27:57 INFO - PROCESS | 25917 | _x_x_mozilla_page_load 21:27:57 INFO - PROCESS | 25917 | _x_x_mozilla_page_load_details 21:27:57 INFO - PROCESS | 25917 | |i|pagename|runs| 21:27:57 INFO - PROCESS | 25917 | |0;ai-astar;112;111;113;110;113;112;106;111;109;110 21:27:57 INFO - PROCESS | 25917 | |1;audio-beat-detection;160;126;155;173;126;159;153;126;199;127 21:27:57 INFO - PROCESS | 25917 | |2;audio-dft;162;161;161;161;159;162;160;162;160;161 21:27:57 INFO - PROCESS | 25917 | |3;audio-fft;77;77;75;169;75;76;81;73;169;75 21:27:57 INFO - PROCESS | 25917 | |4;audio-oscillator;92;91;155;98;93;92;143;92;92;150 21:27:57 INFO - PROCESS | 25917 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 21:27:57 INFO - PROCESS | 25917 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;144 21:27:57 INFO - PROCESS | 25917 | |7;imaging-desaturate;94;94;94;94;95;96;94;94;95;94 21:27:57 INFO - PROCESS | 25917 | |8;json-parse-financial;53;53;54;53;54;54;54;72;51;50 21:27:57 INFO - PROCESS | 25917 | |9;json-stringify-tinderbox;60;58;58;57;58;57;57;58;58;58 21:27:57 INFO - PROCESS | 25917 | |10;stanford-crypto-aes;73;73;73;74;76;81;75;73;73;74 21:27:57 INFO - PROCESS | 25917 | |11;stanford-crypto-ccm;113;121;113;113;113;110;108;110;130;119 21:27:57 INFO - PROCESS | 25917 | |12;stanford-crypto-pbkdf2;155;158;156;156;157;160;164;160;155;160 21:27:57 INFO - PROCESS | 25917 | |13;stanford-crypto-sha256-iterative;68;69;65;67;67;67;67;66;67;66 21:27:57 INFO - PROCESS | 25917 | __end_tp_report 21:27:57 INFO - PROCESS | 25917 | __start_cc_report 21:27:57 INFO - PROCESS | 25917 | _x_x_mozilla_cycle_collect,1609 21:27:57 INFO - PROCESS | 25917 | __end_cc_report 21:27:57 INFO - PROCESS | 25917 | __startTimestamp1464236877051__endTimestamp 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | ------- Summary: start ------- 21:27:57 INFO - PROCESS | 25917 | Number of tests: 14 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.11 (1.9%) stddev-sans-first:2.19 21:27:57 INFO - PROCESS | 25917 | Values: 112.0 111.0 113.0 110.0 113.0 112.0 106.0 111.0 109.0 110.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:157.00 stddev:24.50 (15.6%) stddev-sans-first:25.73 21:27:57 INFO - PROCESS | 25917 | Values: 160.0 126.0 155.0 173.0 126.0 159.0 153.0 126.0 199.0 127.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 21:27:57 INFO - PROCESS | 25917 | Values: 162.0 161.0 161.0 161.0 159.0 162.0 160.0 162.0 160.0 161.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.50 stddev:39.21 (51.9%) stddev-sans-first:41.07 21:27:57 INFO - PROCESS | 25917 | Values: 77.0 77.0 75.0 169.0 75.0 76.0 81.0 73.0 169.0 75.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:27.49 (29.9%) stddev-sans-first:28.40 21:27:57 INFO - PROCESS | 25917 | Values: 92.0 91.0 155.0 98.0 93.0 92.0 143.0 92.0 92.0 150.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:27:57 INFO - PROCESS | 25917 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 21:27:57 INFO - PROCESS | 25917 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 21:27:57 INFO - PROCESS | 25917 | Values: 94.0 94.0 94.0 94.0 95.0 96.0 94.0 94.0 95.0 94.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:6.20 (11.5%) stddev-sans-first:6.54 21:27:57 INFO - PROCESS | 25917 | Values: 53.0 53.0 54.0 53.0 54.0 54.0 54.0 72.0 51.0 50.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.88 (1.5%) stddev-sans-first:0.50 21:27:57 INFO - PROCESS | 25917 | Values: 60.0 58.0 58.0 57.0 58.0 57.0 57.0 58.0 58.0 58.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.51 (3.4%) stddev-sans-first:2.60 21:27:57 INFO - PROCESS | 25917 | Values: 73.0 73.0 73.0 74.0 76.0 81.0 75.0 73.0 73.0 74.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:113.00 stddev:6.60 (5.8%) stddev-sans-first:6.96 21:27:57 INFO - PROCESS | 25917 | Values: 113.0 121.0 113.0 113.0 113.0 110.0 108.0 110.0 130.0 119.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:159.00 stddev:2.88 (1.8%) stddev-sans-first:2.83 21:27:57 INFO - PROCESS | 25917 | Values: 155.0 158.0 156.0 156.0 157.0 160.0 164.0 160.0 155.0 160.0 21:27:57 INFO - PROCESS | 25917 | 21:27:57 INFO - PROCESS | 25917 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.09 21:27:57 INFO - PROCESS | 25917 | Values: 68.0 69.0 65.0 67.0 67.0 67.0 67.0 66.0 67.0 66.0 21:27:57 INFO - PROCESS | 25917 | -------- Summary: end -------- 21:27:57 INFO - PROCESS | 25917 | 21:27:58 INFO - TEST-INFO | 25917: exit 0 21:27:58 INFO - TEST-OK | kraken | took 60060ms 21:27:58 INFO - SUITE-END | took 1170s 21:27:58 INFO - Completed test suite (00:19:30) 21:27:58 INFO - javascript benchmark 21:27:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3344.1806757344452, 3377.3076519313545, 3398.320335932813, 3426.8800591979257, 3442.363162814878, 5599.384067752554, 5606.299212598426, 5615.326160860693, 5618.91571626426, 5620.91568626471, 5594.524465420434, 5629.155626656004, 5631.239782629344, 5636.746346414411, 5641.407652196522, 4979.0788704089855, 5091.338126043618, 5140.177571588547, 5212.087884620195, 5247.737613119348, 5070.062038522867, 5104.0, 5106.387233531963, 5107.4892510749, 5109.208072748711, 5121.359830021247, 5157.974210128963, 5187.299714538527, 5196.350456192976, 5210.400803907562, 5108.4125325587665, 5114.64197506171, 5126.641135120543, 5131.358580177478, 5159.14874045782, 4956.727379994099, 4982.202847544376, 5011.273365362002, 5047.343845300087, 5111.897762044739, 5466.180072989044, 5490.066688662937, 5524.06090964537, 5547.528460080898, 5551.195076713854, 6047.971844786397, 6077.058056001282, 6079.0, 6080.483158931496, 6086.421789929994, 6096.664683442409, 6109.175261339707, 6120.877582448326, 6138.69306534676, 6152.846178845564, 5664.065429204176, 5698.430156984268, 5699.857503562361, 5700.287464066992, 5703.942960570383, 6070.3019152797115, 6203.16257305258, 6206.658633775095, 6208.1308616793685, 6211.782587609412, 5859.2090067841145, 5884.882302353929, 5896.616719913192, 5912.645241285537, 5918.674472903946, 6014.218151640346, 6046.606970546901, 6047.12316714074, 6057.969710151421, 6061.6666083365835, 5861.472467477947, 5949.375315591887, 6013.609115407485, 6014.248218972629, 6025.789097381658, 6064.969675151596, 6067.9684453642985, 6068.575199735976, 6084.695765211722, 6132.846678833065, 4563.680542362003, 4567.406237189144, 4568.360429539867, 4594.035252596992, 4604.700694454849, 3984.442178095069, 4035.0517628357898, 4064.8577299794365, 4109.938350924738, 4137.131202447459, 5700.4869561738815, 5711.685857277889, 5719.19931209631, 5723.8855222896145, 5737.053386191232, 6039.094135879654, 6101.084837274356, 6112.724927378279, 6116.724747386378, 6121.693915304217, 5643.689597072118, 5648.406917273709, 5702.401247868914, 5711.228984087178, 5736.110902810071, 5182.714950677673, 5201.5838732901275, 5217.634765566374, 5221.686698798008, 5224.477552244821, 6272.153259310026, 6315.147455093504, 6330.588511746721, 6336.936630633727, 6340.0, 5963.016102343152, 6090.878182436415, 6109.495762817132, 6130.092410195535, 6132.386102851662, 6219.129321894848, 6228.34602366745, 6243.687815609293, 6244.531660125418, 6279.277883043325, 5821.476067153976, 5966.313873904556, 5974.803604608899, 5982.581219314607, 6006.399360063959, 5989.940100598938, 6021.909671355021, 6029.57792954489, 6044.546659000681, 6054.39456054391, 5934.376890426443, 5982.820515384371, 5989.40105989415, 5990.161377407079, 5990.161377407254, 5795.304563452412, 5886.499647529837, 5913.083472061838, 5930.080837470199, 5944.791932282349, 5749.051406518045, 5758.510526605285, 5767.307923049261, 5795.275590551181, 5824.097264923944, 5873.119032145212, 5878.911816322673, 5880.235569375954, 5908.3796201399955, 5914.763409463573, 5774.884502310014, 5790.449907258803, 5793.0731083028195, 5826.854328641818, 5864.530837532901], "value": 5567.368382586148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.9904751428727, 671.660811290298, 677.8102131403209, 680.9455243580512, 714.774845923534, 39966.40050399247, 41560.79219603898, 41679.583204167946, 41707.37438938418, 41749.16501669965, 43284.783576082074, 43678.78160609193, 43955.78022109893, 43960.3405948911, 44053.33919991195, 8628.870566941485, 8775.385722999392, 8798.208161265486, 8802.07578204289, 8811.647534098629, 8804.955975220115, 8916.15296546827, 8933.062028487013, 9172.12864777845, 9172.678956236534, 9203.17171454569, 9269.814603707922, 9271.814563708722, 9275.489848058354, 9291.070892910722, 9121.81756364869, 9131.08689131085, 9187.67843125494, 9188.908110918905, 9213.355065145442, 9071.863922041175, 9166.312526560469, 9185.402948808307, 9187.035361287102, 9192.862107068398, 44500.554994450285, 45334.093318133455, 45403.54596454059, 45429.77285113553, 45547.178112875445, 3959.465472161279, 3997.600239976008, 4034.4553485279407, 4066.8983275418054, 4109.321961876287, 33482.83258583716, 34057.14857128567, 34122.82938585316, 34176.14559636004, 35571.0, 4448.955510444886, 4495.842645507391, 4525.434320709911, 4526.140033393644, 4557.794899229542, 330898.9999999976, 334561.0, 334795.0, 335567.0, 337124.0, 39636.0, 63730.362696372445, 64444.355556444774, 64581.67709161518, 64682.0, 38062.61937380591, 38235.23529529394, 38257.80871095627, 38272.0, 38317.0, 16314.510564683078, 16571.0, 16593.50219493393, 16600.916995414944, 16602.169891505375, 12648.430820613094, 12702.80945785814, 12717.427715752814, 12722.173058751152, 12725.681857953625, 9132.178103970542, 9271.07289271081, 9339.90660093404, 9387.859182112274, 9396.577154028086, 3559.1635965548076, 3605.7656252344036, 3617.656322649344, 3618.764780289273, 3644.1071937375514, 1160.7620437810228, 1189.3220864107375, 1225.3580202528653, 1233.105998151351, 1247.2267194339386, 34228.14429639229, 34518.19701164938, 34598.30803383918, 34599.827000865334, 34986.12534686602, 1272.3828942962655, 1273.1043008394158, 1273.7452509497953, 1304.1718508746824, 1402.6353148181547, 17499.212535435683, 18065.367712130013, 18271.72592411115, 18321.816781832276, 18363.0, 484480.0, 485157.0, 488540.0, 489768.0, 489778.0, 63529.0, 63745.68127159335, 64380.35619643837, 64411.35588644147, 64514.677426612565, 1457.6355911022245, 1470.4338829550486, 1495.1776522912571, 1516.5753588995099, 1520.217088199578, 33490.162745930575, 33952.0, 34192.48711269383, 34205.48819400112, 34360.31279374449, 55990.0, 56643.71678141583, 56690.433095668515, 56691.149632754714, 56849.0, 446765.0, 447649.0, 448691.0, 449405.0, 449573.0, 27891.0, 30327.393452130393, 31012.22469438282, 31485.055448336585, 31552.0, 45198.54801451943, 45713.54286457226, 45779.31331030104, 46200.30699539577, 46925.0, 40758.38862417007, 41206.97737042164, 42104.57895421007, 42533.0, 42637.36043959405, 40131.799341003105, 40761.0, 40917.79541102275, 41257.381139283534, 41693.58306417018, 42863.3570496449, 45455.31817022681, 46220.0, 46511.0, 47031.52968470408, 35944.64055359518, 37371.81314093412, 37840.43239351467, 37893.24213515659, 38348.23303533858, 29043.419131617673, 29528.704712953455, 29688.851555742945, 29701.108966730168, 29882.551761724026], "value": 19877.944810861267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.5458068640377, 396.59547261792966, 402.24980411532465, 422.5457633044478, 431.52963270035656, 15786.36854525819, 18699.158537865795, 18732.344367947124, 18736.62526749464, 18738.15678294475, 18837.340693075745, 19184.0, 19497.22011119557, 19506.609867802636, 19510.31713890014, 4329.177456283312, 5727.541796656268, 5886.411358864122, 5887.175795388627, 5893.057110862263, 6234.376562343775, 6563.048357988089, 6565.179352580927, 6566.113574667406, 6577.24361698406, 5647.09646456567, 5886.411358864122, 6480.902786458207, 6497.05792660064, 6502.122213501164, 5198.428172900978, 5833.533317334645, 5846.473817356437, 5851.707414629294, 5873.911891321633, 5687.402822703598, 5706.258186435778, 5716.742746576414, 5728.828135155952, 5779.422057794229, 13712.862871371259, 13728.45086196551, 13768.65578360549, 13877.306134693326, 19464.0, 2350.670906073151, 2478.120267305099, 2509.723930367658, 2513.9748602513923, 2586.237060067285, 10180.898191018143, 10720.51757670899, 10937.781244375068, 13136.540221092217, 14688.55934321972, 2056.619525387793, 2057.845661575373, 2064.6283668939586, 2081.4172031831113, 2082.9479263018393, 80294.0, 81441.18558814396, 87083.56458217732, 87512.0, 88015.55992219997, 11224.270422422516, 11252.887471125348, 11267.492962816694, 11491.42542872853, 11517.827232591519, 15175.937684361988, 15257.389704411698, 15257.847421525865, 15314.693706126038, 15631.0, 8207.302379297827, 8353.24820766134, 8403.201695838885, 8462.323014158852, 8569.357298202534, 8339.54132522705, 8418.158184181655, 8438.620262088221, 8526.445781024213, 8533.658653653783, 4872.585830204402, 4876.439209490883, 4885.413750349981, 4905.166121759309, 4985.351904252497, 1955.1299671645982, 1996.2813387180604, 2008.7589489261381, 2043.4074118505466, 2056.42420122363, 940.6707652321633, 1064.5103252503934, 1092.202692034819, 1113.4210210690396, 1147.5352482244705, 18722.906385467984, 19716.70424943627, 20311.593768124556, 20663.17347306091, 20734.0, 1043.3531210649446, 1056.7569459024467, 1095.9342439453499, 1099.444780385916, 1153.4809335798925, 10597.4701264938, 11000.119990400908, 11024.283421577571, 11097.72255693598, 11216.887831121747, 264875.0, 473241.0, 512291.0, 591560.5063696192, 591759.0, 59067.40932590619, 90949.0, 101617.49191254145, 104171.4791426038, 104935.0, 1094.3488624268548, 1100.1748688483638, 1109.6530837279097, 1113.3820729495046, 1121.1647322744607, 16705.331786728882, 16729.33082676728, 17371.392001279895, 17730.670199734814, 18063.2774689011, 38526.229475409775, 38843.80578097091, 40798.796006020966, 42640.0, 43434.0, 55619.0, 55637.16544251759, 56376.46305916326, 56537.0, 56922.0, 9053.456792592466, 9152.313576481658, 9156.633734650539, 9168.770780730536, 9384.57769400365, 9858.950705246429, 13461.528846490326, 13541.322933853071, 13635.318234088058, 14042.578722638336, 12225.205361651464, 12312.445939932904, 12371.628851134481, 12376.195547289397, 12479.251244925334, 10016.298859079794, 10027.298089133983, 12222.449989750305, 12222.633321000385, 12427.587169593178, 12252.75494490123, 12657.367131643565, 12834.871651283742, 12849.614511564669, 13010.284434356201, 9109.817803643757, 9111.498867562348, 9154.450732956044, 9226.215771659485, 9354.0, 9384.859227111463, 11882.584109556125, 12312.199707019015, 12500.31248281317, 12785.105042647298], "value": 9419.920359953265, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.8210132682746, 1381.6338670252378, 1403.501756876309, 1557.6183834960436, 1852.0461962089526, 7958.960205198973, 8137.349012079034, 8154.673813047471, 8174.713885014025, 8183.795405114867, 8096.797580060502, 8247.42268041236, 8250.298724608401, 8273.089960104398, 8288.419810613259, 2109.757377901538, 2134.1676746069047, 2379.1316169598144, 2406.254061241012, 2426.805855531562, 2427.987860060706, 2445.645381419693, 2447.363685441789, 2450.5588993981078, 2450.7059152901675, 2342.61346877765, 2356.1164563288767, 2395.808335333169, 2403.9519209615796, 2405.9157929472385, 2087.4781304673834, 2131.509752756859, 2133.349328454821, 2353.635186546088, 2419.4072452249225, 2358.929232123022, 2365.6451532270125, 2387.5105603351444, 2388.2954528413984, 2389.127968291561, 7965.641546130438, 7995.960020199862, 8022.197780221931, 8033.638486268132, 8041.758747237593, 5159.458256883011, 5242.344706911636, 5253.001929633358, 5281.947180528184, 5290.629655924048, 3285.7535684823733, 3294.324663444012, 3392.5759280089987, 3418.1454636340914, 3420.9144771380666, 1173.8180582009716, 1195.940202989847, 1207.4445754952733, 1207.4928530017414, 1224.6203676860114, 11673.1828771986, 11688.0, 11688.941555292255, 11709.824352634718, 11712.355820429873, 4586.816527338936, 4685.484596694361, 4739.275938493586, 4761.976190119097, 4881.219004959189, 10007.599696012223, 10017.298789084694, 10033.698989030341, 10048.648297309705, 10078.19374450057, 5232.659877108052, 5274.525292723597, 5278.287431196816, 5289.814856480005, 5294.523492885659, 4192.559781222989, 4791.520847915251, 4829.613630909519, 4895.0209958008545, 4896.902061958812, 4072.6175187515637, 4084.6528045116497, 4115.8765237042935, 4129.091599848029, 4177.352510360899, 1270.968225794344, 1278.725074109071, 1279.6883194725294, 1283.076185146693, 1310.462710288777, 965.9275554333453, 1056.5351245451977, 1067.0876400677464, 1077.3374374759467, 1091.6179337231906, 5931.7627294907725, 5956.5532585055425, 5959.076343166729, 6065.4541091302, 6200.627962322275, 436.93664418659114, 446.2547545598858, 450.6665067849833, 457.38253357966477, 457.75052596335075, 3984.960150398459, 4000.159966407029, 4033.8184781684895, 4049.8987525312104, 4053.8175782089875, 9712.9028709712, 9888.110070093582, 9932.304738668225, 9945.055219754111, 9954.751131221778, 9493.66772162971, 9787.070228328297, 9793.559289831976, 9797.902020979698, 9813.558389872473, 7718.343940765098, 7767.417443691746, 7834.0, 7844.097928738268, 7853.293203611703, 5566.4990150886615, 5584.246126772834, 5676.091825307931, 5688.374278829243, 5715.685637289989, 8668.956655216683, 8708.521031343336, 8743.475391476532, 8790.033096359522, 8946.150115738994, 8895.110488951053, 8991.190792828676, 9021.0, 9040.186383225542, 9102.544872756203, 6421.229452465547, 6501.284858665448, 7218.422526197996, 7283.635818209174, 7345.706171753283, 7907.327877130509, 7909.485883417559, 7927.0, 7927.484713493604, 7960.243776841423, 7075.6815943281645, 7220.0613920190035, 7241.167265764505, 7311.488195826241, 7399.371053460516, 6977.33715297046, 6999.545029573062, 7168.820779480555, 7240.674169662272, 7267.890981635174, 6614.10709554204, 6642.867142657024, 6933.0293758874805, 6965.303469653197, 6966.0, 5143.434222235626, 5156.1492353761205, 5167.1474206755465, 5187.29971453864, 5219.76511057011, 4991.3511243538105, 5047.167217409086, 5107.438181800073, 5245.580353571781, 5246.921296180484], "value": 4423.262819798979, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.21276977878887, 356.5471850749548, 360.06562969095194, 360.4359177886608, 363.89992751993196, 6169.043798211284, 6170.197874276343, 6180.443760061594, 6195.504359651229, 6213.378662133784, 6107.3587273336325, 6109.602875813081, 6119.0, 6134.04922237054, 6135.079738039296, 4555.157295900261, 4636.0, 4661.067786442708, 4709.670323077386, 4721.7639118044135, 4722.504137065593, 4731.78706958186, 4742.19382704941, 4748.169070412681, 4764.6188304935695, 4721.079389519028, 4722.7402492862875, 4732.384789977315, 4735.171345014626, 4745.620350371962, 4550.203714349992, 4618.0, 4709.505501922283, 4716.551927566876, 4730.408698912636, 4187.099773548671, 4190.099128687317, 4191.685623578243, 4195.139996300751, 4197.769122698251, 5902.173695682608, 5920.97039514804, 5921.289445266552, 5927.614705044159, 5943.0194017987415, 5506.889862202774, 5509.614326997112, 5510.586705997026, 5517.724113794295, 5520.66875987438, 6441.388068133567, 6448.54860159789, 6452.870942581122, 6453.354664533556, 6453.709583068773, 4565.817367305303, 4654.534546545352, 4658.510856360067, 4661.160991021615, 4665.346851440801, 6696.1629796275465, 6712.060311556386, 6714.731410743564, 6714.932850671479, 6720.428763555104, 4743.45450273223, 4756.025014871943, 4757.738324392191, 4765.380500534909, 4772.284157376422, 4818.759062046884, 4823.252395878644, 4828.0, 4831.202851529529, 4834.685745426536, 5487.945120548743, 5490.066688662937, 5494.340679118452, 5496.835094947158, 5506.146547285177, 6271.247450305992, 6429.9678501607195, 6445.1621289233035, 6499.512536559777, 6516.902246466307, 1637.8689704823585, 1647.1928754910007, 1654.6690661867433, 1657.2128239086337, 1658.7263101588103, 1041.5521325829814, 1084.159776173472, 1093.830456279278, 1107.6289443036674, 1119.0488085127738, 6116.2048933639235, 6238.937610623926, 6245.875082498324, 6248.094026366242, 6268.49852011838, 6652.434543063797, 6677.165354330708, 6677.198736151596, 6680.432163266177, 6680.766173183915, 6212.502999760009, 6222.906656400158, 6225.782097626652, 6231.906521402183, 6248.687565621701, 3525.383057964846, 3595.7482976191413, 3600.71194304455, 3602.585702644177, 3606.13452771333, 6814.795556133324, 6895.379415852597, 6955.339242771928, 6960.408365289007, 6977.755778547727, 6795.18457785059, 6808.319168083152, 6810.795676129724, 6812.114425124702, 6817.965910170417, 6877.071595334666, 6918.169819621678, 6934.271901450275, 6945.583265004116, 6948.722051117898, 6659.866802663822, 6660.333966603301, 6660.600363978177, 6676.632785196666, 6679.198496180489, 6475.061116138228, 6554.8361290968105, 6598.769043083469, 6607.141071660653, 6609.966950165411, 6888.758893438706, 6919.619420931897, 6921.861562768817, 6925.68834402443, 6930.3762661360715, 4663.696859704109, 4668.976655116839, 4670.579647831712, 4673.3924589804465, 4678.274867395559, 6632.734690612321, 6636.469082473487, 6647.401733843783, 6647.567908085959, 6647.667616619053, 6359.459445946961, 6482.384173503509, 6482.448991835747, 6490.870182596416, 6505.2844187138435, 6417.6470294132405, 6449.677516124081, 6455.580387274812, 6455.806325810233, 6459.709313080829, 6335.588186767845, 6341.0805433212845, 6355.459785918249, 6359.554831161774, 6362.554621176473, 6505.089287499659, 6508.869822603616, 6510.641914694737, 6518.120053792867, 6521.445677117498, 6021.277446706424, 6135.84660383494, 6337.714802833976, 6350.428461438492, 6368.363163683594], "value": 4920.655746478581, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.1249581708028, 819.1153554161502, 873.5064688451029, 908.3232991421391, 921.2445794448553, 15284.541463756077, 15600.843991560081, 15610.375584976602, 15690.84309156908, 15736.291866865975, 14128.646783830409, 14341.13953162811, 14341.928290358534, 14363.856361436383, 14370.856291437083, 727.6361819090455, 858.2490320969152, 876.4215617692324, 890.9465432074064, 899.4783025844994, 889.4707648948897, 895.4403497813867, 895.8745775591423, 896.6547879066541, 896.8565029595266, 932.580338847518, 933.2673851026946, 933.593886659302, 933.6685476655791, 934.0332755597957, 769.042542035167, 923.9445633261993, 925.7685578605349, 945.5130607737021, 946.839037363643, 695.8712638161957, 696.4532841719276, 696.4532841719276, 697.504771612156, 697.9720811167547, 14828.55514334561, 14906.552803415807, 14907.0, 14924.850751492564, 14957.626059348495, 15109.848901510954, 15360.769588456182, 15408.152551609657, 15510.379584816594, 15575.37698492059, 11306.547738090467, 11331.093512518979, 11658.708532286675, 11710.297382157098, 11859.347735874524, 4033.132876431552, 4070.6743460523385, 4098.098418347959, 4125.257453658341, 4176.895577610554, 57215.14177287344, 57264.42735572633, 57352.13971790426, 57420.71289643567, 57422.7128864353, 11140.554377824958, 11189.160812939062, 11257.155713321534, 11558.479868405942, 11748.471318790504, 21717.891410542845, 21728.565428691654, 21749.78250217509, 21770.238041668465, 21789.564208716052, 8647.740567782977, 8715.651373944971, 8723.476591404537, 8794.780130496789, 8921.776955576162, 4905.607551395951, 4918.606511479073, 4956.207006878954, 5070.949290507121, 5106.591472682177, 3596.6403359663823, 3638.8180590970346, 3646.070252085701, 3646.3983442732183, 3648.7445878788762, 672.9966350168218, 674.6694119881223, 676.4317972902687, 678.3115138134797, 691.6991108867659, 654.3881470824793, 696.2654399608462, 753.1978442958341, 767.7965339185121, 768.965396557145, 9949.154321882575, 10530.736731581772, 10660.360378377321, 10718.839217411745, 10788.244822862482, 689.2797027106685, 726.8364617960916, 760.1941941541983, 799.2007992007992, 808.1110031636922, 4843.806247750051, 4942.950570494321, 4947.109520286383, 4993.675411098339, 5105.693658380509, 66173.00740488897, 66915.33084669188, 67720.6613966927, 67848.6607566959, 67992.98010529845, 56494.43505564974, 59256.40743592509, 59613.40386596078, 59683.40316596865, 59778.10332845011, 54568.181477277874, 54851.72574137104, 54948.725256373466, 55359.723201383735, 55529.0, 9678.322517423994, 9903.207743380368, 9947.104760571583, 9953.153981911619, 9991.950040249752, 38647.42028869625, 38869.22261554696, 39670.60329396669, 40219.59780402276, 40344.596554034084, 44069.11861762811, 44757.328640069776, 51024.0, 52023.0, 52455.47544524506, 11661.76676466483, 11686.94156529212, 11801.468933898166, 12086.516539338329, 12164.513419463476, 10993.725156871142, 12500.624981250578, 12670.986321094106, 12740.299283539494, 12848.871511284768, 12373.814392783936, 12433.316167610868, 12591.748165036464, 12635.684107897008, 12734.68163295888, 12615.684607884876, 12858.0999330046, 12943.870561294643, 13038.804417933548, 13287.534936277183, 13031.934840326117, 13040.934795326342, 13319.0, 13525.864741352461, 13710.17738935667, 10882.374990629109, 11209.0, 11301.0, 11422.82865757031, 11635.0, 11223.0, 11564.248323858923, 11579.421028948687, 11594.94202528982, 11673.066154707432], "value": 7197.3031561378675, "unit": "score"}], "name": "dromaeo_css", "value": 7393.34115506308, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 113.0, 110.0, 113.0, 112.0, 106.0, 111.0, 109.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 155.0, 173.0, 126.0, 159.0, 153.0, 126.0, 199.0, 127.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 159.0, 162.0, 160.0, 162.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 169.0, 75.0, 76.0, 81.0, 73.0, 169.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 155.0, 98.0, 93.0, 92.0, 143.0, 92.0, 92.0, 150.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 96.0, 94.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0, 72.0, 51.0, 50.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 57.0, 58.0, 57.0, 57.0, 58.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 74.0, 76.0, 81.0, 75.0, 73.0, 73.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 121.0, 113.0, 113.0, 113.0, 110.0, 108.0, 110.0, 130.0, 119.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 158.0, 156.0, 156.0, 157.0, 160.0, 164.0, 160.0, 155.0, 160.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 65.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1509.9, "alertThreshold": 2.0}]} 21:27:58 INFO - Return code: 0 21:27:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:27:58 ERROR - # TBPL SUCCESS # 21:27:58 INFO - Running post-action listener: _resource_record_post_action 21:27:58 INFO - Running post-run listener: _resource_record_post_run 21:27:59 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 500822016; Read time: 32; Write time: 369224 21:27:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249073664; Read time: 0; Write time: 201660 21:27:59 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251748352; Read time: 32; Write time: 167564 21:27:59 INFO - Running post-run listener: _upload_blobber_files 21:27:59 INFO - Blob upload gear active. 21:27:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:27:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:27:59 INFO - (blobuploader) - INFO - Open directory for files ... 21:27:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:27:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:27:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:28:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:28:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:28:02 INFO - (blobuploader) - INFO - Done attempting. 21:28:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:28:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:28:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:28:03 INFO - (blobuploader) - INFO - Done attempting. 21:28:03 INFO - (blobuploader) - INFO - Iteration through files over. 21:28:03 INFO - Return code: 0 21:28:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:28:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:28:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2b648afe283ef0303783dba63be8fe5e91c8c7a03e8176117fb8b4f76b9bbbdc4d1e45c6194d3057d14de97196d32a4ac7510bae483c784f4bd41093fc5e48e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e915b63fdb905f3b92894f4b262eece90784e1b5885c081ff6073c10f807b8249ad76f3c434786b3b39a1309d7dde174edc4483aaabd16960b87f91af1ef966e"} 21:28:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:28:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:28:03 INFO - Contents: 21:28:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2b648afe283ef0303783dba63be8fe5e91c8c7a03e8176117fb8b4f76b9bbbdc4d1e45c6194d3057d14de97196d32a4ac7510bae483c784f4bd41093fc5e48e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e915b63fdb905f3b92894f4b262eece90784e1b5885c081ff6073c10f807b8249ad76f3c434786b3b39a1309d7dde174edc4483aaabd16960b87f91af1ef966e"} 21:28:03 INFO - Running post-run listener: copy_logs_to_upload_dir 21:28:03 INFO - Copying logs to upload dir... 21:28:03 INFO - mkdir: /builds/slave/test/build/upload/logs 21:28:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.079591 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-25 21:28:02.997066) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 21:28:03.001234) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2b648afe283ef0303783dba63be8fe5e91c8c7a03e8176117fb8b4f76b9bbbdc4d1e45c6194d3057d14de97196d32a4ac7510bae483c784f4bd41093fc5e48e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e915b63fdb905f3b92894f4b262eece90784e1b5885c081ff6073c10f807b8249ad76f3c434786b3b39a1309d7dde174edc4483aaabd16960b87f91af1ef966e"} build_url:https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2b648afe283ef0303783dba63be8fe5e91c8c7a03e8176117fb8b4f76b9bbbdc4d1e45c6194d3057d14de97196d32a4ac7510bae483c784f4bd41093fc5e48e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e915b63fdb905f3b92894f4b262eece90784e1b5885c081ff6073c10f807b8249ad76f3c434786b3b39a1309d7dde174edc4483aaabd16960b87f91af1ef966e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 21:28:03.027388) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:28:03.027758) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464235431.240660-1576549091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:28:03.115155) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 21:28:03.115971) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 21:28:03.116663) ========= ========= Total master_lag: 0.18 =========