builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1460786413.43 results: success (0) buildid: 20160415203232 builduid: ece4ea982f834601a2f3f20559df4529 revision: 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.432873) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.433424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.433708) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.455347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.455616) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 23:00:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.1M=0s 2016-04-15 23:00:14 (67.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163841 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.632764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.633102) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015720 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:13.682834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 23:00:13.683198) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 23:00:14,546 truncating revision to first 12 chars 2016-04-15 23:00:14,546 Setting DEBUG logging. 2016-04-15 23:00:14,546 attempt 1/10 2016-04-15 23:00:14,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/42a0a7f409d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 23:00:15,745 unpacking tar archive at: fx-team-42a0a7f409d1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.788852 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 23:00:15.484886) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:15.485231) ========= script_repo_revision: 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:15.485625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:15.485900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 23:00:15.493066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-15 23:00:15.493344) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:00:16 INFO - MultiFileLogger online at 20160415 23:00:16 in /builds/slave/test 23:00:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:00:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:00:16 INFO - {'append_to_log': False, 23:00:16 INFO - 'base_work_dir': '/builds/slave/test', 23:00:16 INFO - 'blob_upload_branch': 'Fx-Team', 23:00:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:00:16 INFO - 'branch': 'Fx-Team', 23:00:16 INFO - 'buildbot_json_path': 'buildprops.json', 23:00:16 INFO - 'config_files': ('talos/linux_config.py',), 23:00:16 INFO - 'default_actions': ('clobber', 23:00:16 INFO - 'read-buildbot-config', 23:00:16 INFO - 'download-and-extract', 23:00:16 INFO - 'populate-webroot', 23:00:16 INFO - 'create-virtualenv', 23:00:16 INFO - 'install', 23:00:16 INFO - 'run-tests'), 23:00:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:00:16 INFO - 'download_minidump_stackwalk': True, 23:00:16 INFO - 'download_symbols': 'ondemand', 23:00:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:00:16 INFO - 'tooltool.py': '/tools/tooltool.py', 23:00:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:00:16 INFO - '/tools/misc-python/virtualenv.py')}, 23:00:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:00:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:00:16 INFO - 'installer_path': 'installer.exe', 23:00:16 INFO - 'log_level': 'info', 23:00:16 INFO - 'log_name': 'talos', 23:00:16 INFO - 'log_to_console': True, 23:00:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:00:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:00:16 INFO - 'opt_config_files': (), 23:00:16 INFO - 'pip_index': False, 23:00:16 INFO - 'sps_profile': False, 23:00:16 INFO - 'sps_profile_interval': 0, 23:00:16 INFO - 'suite': 'dromaeojs', 23:00:16 INFO - 'system_bits': '32', 23:00:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:00:16 INFO - 'title': 'talos-linux64-ix-023', 23:00:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:00:16 INFO - 'use_talos_json': True, 23:00:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:00:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:00:16 INFO - 'work_dir': 'build'} 23:00:16 INFO - ##### 23:00:16 INFO - ##### Running clobber step. 23:00:16 INFO - ##### 23:00:16 INFO - Running pre-action listener: _resource_record_pre_action 23:00:16 INFO - Running main action method: clobber 23:00:16 INFO - rmtree: /builds/slave/test/build 23:00:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:00:17 INFO - Running post-action listener: _resource_record_post_action 23:00:17 INFO - ##### 23:00:17 INFO - ##### Running read-buildbot-config step. 23:00:17 INFO - ##### 23:00:17 INFO - Running pre-action listener: _resource_record_pre_action 23:00:17 INFO - Running main action method: read_buildbot_config 23:00:17 INFO - Using buildbot properties: 23:00:17 INFO - { 23:00:17 INFO - "project": "", 23:00:17 INFO - "product": "firefox", 23:00:17 INFO - "script_repo_revision": "production", 23:00:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:00:17 INFO - "repository": "", 23:00:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:00:17 INFO - "buildid": "20160415203232", 23:00:17 INFO - "pgo_build": "True", 23:00:17 INFO - "basedir": "/builds/slave/test", 23:00:17 INFO - "buildnumber": 34, 23:00:17 INFO - "slavename": "talos-linux64-ix-023", 23:00:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:00:17 INFO - "platform": "ubuntu64_hw", 23:00:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:00:17 INFO - "branch": "fx-team", 23:00:17 INFO - "repo_path": "integration/fx-team", 23:00:17 INFO - "revision": "42a0a7f409d1b9a40770e36a66af6ccf67539cc4", 23:00:17 INFO - "stage_platform": "linux64-pgo", 23:00:17 INFO - "builduid": "ece4ea982f834601a2f3f20559df4529", 23:00:17 INFO - "slavebuilddir": "test" 23:00:17 INFO - } 23:00:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 23:00:17 INFO - Running post-action listener: _resource_record_post_action 23:00:17 INFO - ##### 23:00:17 INFO - ##### Running download-and-extract step. 23:00:17 INFO - ##### 23:00:17 INFO - Running pre-action listener: _resource_record_pre_action 23:00:17 INFO - Running main action method: download_and_extract 23:00:17 INFO - mkdir: /builds/slave/test/build/tests 23:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:17 INFO - https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:00:22 INFO - Downloaded 1361 bytes. 23:00:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:00:22 INFO - Using the following test package requirements: 23:00:22 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:00:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:00:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:22 INFO - u'jsshell-linux-x86_64.zip'], 23:00:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:00:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:00:22 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:00:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:00:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:00:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:22 INFO - https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:00:29 INFO - Downloaded 23775043 bytes. 23:00:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:00:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:00:30 INFO - Return code: 0 23:00:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:30 INFO - https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:00:32 INFO - Downloaded 23775043 bytes. 23:00:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:00:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:00:33 INFO - Return code: 0 23:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:33 INFO - https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:00:34 INFO - Downloaded 10841076 bytes. 23:00:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:00:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:00:34 INFO - Return code: 0 23:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:34 INFO - https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:00:35 INFO - Downloaded 58224720 bytes. 23:00:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:00:35 INFO - mkdir: /builds/slave/test/properties 23:00:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:00:35 INFO - Writing to file /builds/slave/test/properties/build_url 23:00:35 INFO - Contents: 23:00:35 INFO - build_url:https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:00:36 INFO - Running post-action listener: _resource_record_post_action 23:00:36 INFO - Running post-action listener: set_extra_try_arguments 23:00:36 INFO - ##### 23:00:36 INFO - ##### Running populate-webroot step. 23:00:36 INFO - ##### 23:00:36 INFO - Running pre-action listener: _resource_record_pre_action 23:00:36 INFO - Running main action method: populate_webroot 23:00:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:00:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:00:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:00:36 INFO - '--tppagecycles', 23:00:36 INFO - '7'], 23:00:36 INFO - 'tests': ['tsvgm']}}, 23:00:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:00:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:00:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:00:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:00:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:00:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:00:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:36 INFO - 'talos_options': ['--disable-e10s'], 23:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:36 INFO - 'talos_options': ['--disable-e10s'], 23:00:36 INFO - 'tests': ['damp', 'tps']}, 23:00:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:36 INFO - 'tests': ['damp', 'tps']}, 23:00:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:00:36 INFO - 'tests': ['dromaeo_dom']}, 23:00:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:00:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:00:36 INFO - 'tests': ['a11yr', 23:00:36 INFO - 'ts_paint', 23:00:36 INFO - 'tpaint', 23:00:36 INFO - 'sessionrestore', 23:00:36 INFO - 'sessionrestore_no_auto_restore', 23:00:36 INFO - 'tabpaint']}, 23:00:36 INFO - 'other-e10s': {'tests': ['a11yr', 23:00:36 INFO - 'ts_paint', 23:00:36 INFO - 'tpaint', 23:00:36 INFO - 'sessionrestore', 23:00:36 INFO - 'sessionrestore_no_auto_restore', 23:00:36 INFO - 'tabpaint']}, 23:00:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:00:36 INFO - 'ts_paint', 23:00:36 INFO - 'tpaint', 23:00:36 INFO - 'sessionrestore', 23:00:36 INFO - 'sessionrestore_no_auto_restore', 23:00:36 INFO - 'tabpaint']}, 23:00:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:00:36 INFO - 'ts_paint', 23:00:36 INFO - 'tpaint', 23:00:36 INFO - 'sessionrestore', 23:00:36 INFO - 'sessionrestore_no_auto_restore', 23:00:36 INFO - 'tabpaint']}, 23:00:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:00:36 INFO - 'tests': ['a11yr', 23:00:36 INFO - 'ts_paint', 23:00:36 INFO - 'tpaint', 23:00:36 INFO - 'sessionrestore', 23:00:36 INFO - 'sessionrestore_no_auto_restore', 23:00:36 INFO - 'tabpaint']}, 23:00:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:00:36 INFO - 'tests': ['a11yr', 23:00:36 INFO - 'ts_paint', 23:00:36 INFO - 'tpaint', 23:00:36 INFO - 'sessionrestore', 23:00:36 INFO - 'sessionrestore_no_auto_restore', 23:00:36 INFO - 'tabpaint']}, 23:00:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:00:36 INFO - 'tests': ['tsvgx', 23:00:36 INFO - 'tsvgr_opacity', 23:00:36 INFO - 'tart', 23:00:36 INFO - 'tscrollx', 23:00:36 INFO - 'cart']}, 23:00:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:00:36 INFO - 'tsvgr_opacity', 23:00:36 INFO - 'tart', 23:00:36 INFO - 'tscrollx', 23:00:36 INFO - 'cart']}, 23:00:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:36 INFO - 'talos_options': ['--disable-e10s'], 23:00:36 INFO - 'tests': ['tp5o']}, 23:00:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:36 INFO - 'tests': ['tp5o']}, 23:00:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:36 INFO - 'talos_options': ['--disable-e10s', 23:00:36 INFO - '--xperf_path', 23:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:36 INFO - 'tests': ['tp5n']}, 23:00:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:36 INFO - 'talos_options': ['--xperf_path', 23:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:36 INFO - 'tests': ['tp5n']}}, 23:00:36 INFO - 'talos.zip': {'path': '', 23:00:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:00:36 INFO - Running post-action listener: _resource_record_post_action 23:00:36 INFO - ##### 23:00:36 INFO - ##### Running create-virtualenv step. 23:00:36 INFO - ##### 23:00:36 INFO - Running pre-action listener: _resource_record_pre_action 23:00:36 INFO - Running main action method: create_virtualenv 23:00:36 INFO - Creating virtualenv /builds/slave/test/build/venv 23:00:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:00:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:00:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:00:36 INFO - Using real prefix '/usr' 23:00:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:00:37 INFO - Installing distribute.............................................................................................................................................................................................done. 23:00:39 INFO - Installing pip.................done. 23:00:39 INFO - Return code: 0 23:00:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36d720cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19399a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8810>, '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 0x19c9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c9ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:00:39 INFO - Using env: {'DISPLAY': ':0', 23:00:39 INFO - 'HOME': '/home/cltbld', 23:00:39 INFO - 'LANG': 'en_US.UTF-8', 23:00:39 INFO - 'LANGUAGE': 'en_US:en', 23:00:39 INFO - 'LOGNAME': 'cltbld', 23:00:39 INFO - 'MAIL': '/var/mail/cltbld', 23:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:39 INFO - 'MOZ_NO_REMOTE': '1', 23:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:39 INFO - 'NO_EM_RESTART': '1', 23:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:39 INFO - 'PWD': '/builds/slave/test', 23:00:39 INFO - 'SHELL': '/bin/bash', 23:00:39 INFO - 'SHLVL': '1', 23:00:39 INFO - 'TERM': 'linux', 23:00:39 INFO - 'TMOUT': '86400', 23:00:39 INFO - 'USER': 'cltbld', 23:00:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 23:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:39 INFO - '_': '/tools/buildbot/bin/python'} 23:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:00:39 INFO - Cleaning up... 23:00:39 INFO - Return code: 0 23:00:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f36d720cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19399a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8810>, '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 0x19c9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c9ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:00:39 INFO - Using env: {'DISPLAY': ':0', 23:00:39 INFO - 'HOME': '/home/cltbld', 23:00:39 INFO - 'LANG': 'en_US.UTF-8', 23:00:39 INFO - 'LANGUAGE': 'en_US:en', 23:00:39 INFO - 'LOGNAME': 'cltbld', 23:00:39 INFO - 'MAIL': '/var/mail/cltbld', 23:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:39 INFO - 'MOZ_NO_REMOTE': '1', 23:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:39 INFO - 'NO_EM_RESTART': '1', 23:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:39 INFO - 'PWD': '/builds/slave/test', 23:00:39 INFO - 'SHELL': '/bin/bash', 23:00:39 INFO - 'SHLVL': '1', 23:00:39 INFO - 'TERM': 'linux', 23:00:39 INFO - 'TMOUT': '86400', 23:00:39 INFO - 'USER': 'cltbld', 23:00:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 23:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:39 INFO - '_': '/tools/buildbot/bin/python'} 23:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:39 INFO - Downloading/unpacking psutil>=0.7.1 23:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:41 INFO - Installing collected packages: psutil 23:00:41 INFO - Running setup.py install for psutil 23:00:41 INFO - building 'psutil._psutil_linux' extension 23:00:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:00:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:00:42 INFO - building 'psutil._psutil_posix' extension 23:00:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:00:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:00:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:42 INFO - Successfully installed psutil 23:00:42 INFO - Cleaning up... 23:00:42 INFO - Return code: 0 23:00:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36d720cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19399a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8810>, '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 0x19c9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c9ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:00:42 INFO - Using env: {'DISPLAY': ':0', 23:00:42 INFO - 'HOME': '/home/cltbld', 23:00:42 INFO - 'LANG': 'en_US.UTF-8', 23:00:42 INFO - 'LANGUAGE': 'en_US:en', 23:00:42 INFO - 'LOGNAME': 'cltbld', 23:00:42 INFO - 'MAIL': '/var/mail/cltbld', 23:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:42 INFO - 'MOZ_NO_REMOTE': '1', 23:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:42 INFO - 'NO_EM_RESTART': '1', 23:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:42 INFO - 'PWD': '/builds/slave/test', 23:00:42 INFO - 'SHELL': '/bin/bash', 23:00:42 INFO - 'SHLVL': '1', 23:00:42 INFO - 'TERM': 'linux', 23:00:42 INFO - 'TMOUT': '86400', 23:00:42 INFO - 'USER': 'cltbld', 23:00:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 23:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:42 INFO - '_': '/tools/buildbot/bin/python'} 23:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:00:44 INFO - Installing collected packages: mozsystemmonitor 23:00:44 INFO - Running setup.py install for mozsystemmonitor 23:00:44 INFO - Successfully installed mozsystemmonitor 23:00:44 INFO - Cleaning up... 23:00:44 INFO - Return code: 0 23:00:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:44 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 0x7f36d720cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19399a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8810>, '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 0x19c9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c9ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:00:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:00:44 INFO - Using env: {'DISPLAY': ':0', 23:00:44 INFO - 'HOME': '/home/cltbld', 23:00:44 INFO - 'LANG': 'en_US.UTF-8', 23:00:44 INFO - 'LANGUAGE': 'en_US:en', 23:00:44 INFO - 'LOGNAME': 'cltbld', 23:00:44 INFO - 'MAIL': '/var/mail/cltbld', 23:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:44 INFO - 'MOZ_NO_REMOTE': '1', 23:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:44 INFO - 'NO_EM_RESTART': '1', 23:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:44 INFO - 'PWD': '/builds/slave/test', 23:00:44 INFO - 'SHELL': '/bin/bash', 23:00:44 INFO - 'SHLVL': '1', 23:00:44 INFO - 'TERM': 'linux', 23:00:44 INFO - 'TMOUT': '86400', 23:00:44 INFO - 'USER': 'cltbld', 23:00:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 23:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:44 INFO - '_': '/tools/buildbot/bin/python'} 23:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:44 INFO - Downloading/unpacking blobuploader==1.2.4 23:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:46 INFO - Downloading blobuploader-1.2.4.tar.gz 23:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:00:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:00:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:47 INFO - Downloading docopt-0.6.1.tar.gz 23:00:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:00:47 INFO - Installing collected packages: blobuploader, requests, docopt 23:00:47 INFO - Running setup.py install for blobuploader 23:00:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:00:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:00:47 INFO - Running setup.py install for requests 23:00:47 INFO - Running setup.py install for docopt 23:00:47 INFO - Successfully installed blobuploader requests docopt 23:00:47 INFO - Cleaning up... 23:00:48 INFO - Return code: 0 23:00:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:00: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')]} 23:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36d720cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19399a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8810>, '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 0x19c9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c9ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:00:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:00:48 INFO - Using env: {'DISPLAY': ':0', 23:00:48 INFO - 'HOME': '/home/cltbld', 23:00:48 INFO - 'LANG': 'en_US.UTF-8', 23:00:48 INFO - 'LANGUAGE': 'en_US:en', 23:00:48 INFO - 'LOGNAME': 'cltbld', 23:00:48 INFO - 'MAIL': '/var/mail/cltbld', 23:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:48 INFO - 'MOZ_NO_REMOTE': '1', 23:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:48 INFO - 'NO_EM_RESTART': '1', 23:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:48 INFO - 'PWD': '/builds/slave/test', 23:00:48 INFO - 'SHELL': '/bin/bash', 23:00:48 INFO - 'SHLVL': '1', 23:00:48 INFO - 'TERM': 'linux', 23:00:48 INFO - 'TMOUT': '86400', 23:00:48 INFO - 'USER': 'cltbld', 23:00:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 23:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:48 INFO - '_': '/tools/buildbot/bin/python'} 23:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:00:48 INFO - Running setup.py (path:/tmp/pip-DZtetE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:00:48 INFO - Running setup.py (path:/tmp/pip-JOG94k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:00:48 INFO - Running setup.py (path:/tmp/pip-185AaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:00:48 INFO - Running setup.py (path:/tmp/pip-xjIPeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:00:48 INFO - Running setup.py (path:/tmp/pip-hBqtnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:00:48 INFO - Running setup.py (path:/tmp/pip-AVBcTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:00:48 INFO - Running setup.py (path:/tmp/pip-d2oh16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:00:48 INFO - Running setup.py (path:/tmp/pip-4LxZNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:00:48 INFO - Running setup.py (path:/tmp/pip-SWxVqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:00:48 INFO - Running setup.py (path:/tmp/pip-phYfTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:00:48 INFO - Running setup.py (path:/tmp/pip-t3yS4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:00:49 INFO - Running setup.py (path:/tmp/pip-jml_MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:00:49 INFO - Running setup.py (path:/tmp/pip-jAOFfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:00:49 INFO - Running setup.py (path:/tmp/pip-IFHxBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:00:49 INFO - Running setup.py (path:/tmp/pip-PDTvxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:00:49 INFO - Running setup.py (path:/tmp/pip-RNT4K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:00:49 INFO - Running setup.py (path:/tmp/pip-L067m0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:00:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:00:49 INFO - Running setup.py install for manifestparser 23:00:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:00:49 INFO - Running setup.py install for mozcrash 23:00:49 INFO - Running setup.py install for mozdebug 23:00:49 INFO - Running setup.py install for mozdevice 23:00:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:00:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:00:49 INFO - Running setup.py install for mozfile 23:00:49 INFO - Running setup.py install for mozhttpd 23:00:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Running setup.py install for mozinfo 23:00:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Running setup.py install for mozInstall 23:00:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Running setup.py install for mozleak 23:00:50 INFO - Running setup.py install for mozlog 23:00:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Running setup.py install for moznetwork 23:00:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Running setup.py install for mozprocess 23:00:50 INFO - Running setup.py install for mozprofile 23:00:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Running setup.py install for mozrunner 23:00:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:00:50 INFO - Running setup.py install for mozscreenshot 23:00:51 INFO - Running setup.py install for moztest 23:00:51 INFO - Running setup.py install for mozversion 23:00:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:00:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:00:51 INFO - Cleaning up... 23:00:51 INFO - Return code: 0 23:00:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:00: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')]} 23:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36d720cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19399a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8810>, '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 0x19c9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c9ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:00:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:00:51 INFO - Using env: {'DISPLAY': ':0', 23:00:51 INFO - 'HOME': '/home/cltbld', 23:00:51 INFO - 'LANG': 'en_US.UTF-8', 23:00:51 INFO - 'LANGUAGE': 'en_US:en', 23:00:51 INFO - 'LOGNAME': 'cltbld', 23:00:51 INFO - 'MAIL': '/var/mail/cltbld', 23:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:51 INFO - 'MOZ_NO_REMOTE': '1', 23:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:51 INFO - 'NO_EM_RESTART': '1', 23:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:51 INFO - 'PWD': '/builds/slave/test', 23:00:51 INFO - 'SHELL': '/bin/bash', 23:00:51 INFO - 'SHLVL': '1', 23:00:51 INFO - 'TERM': 'linux', 23:00:51 INFO - 'TMOUT': '86400', 23:00:51 INFO - 'USER': 'cltbld', 23:00:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 23:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:51 INFO - '_': '/tools/buildbot/bin/python'} 23:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:00:51 INFO - Running setup.py (path:/tmp/pip-2RVE7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:00:51 INFO - Running setup.py (path:/tmp/pip-prxjDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:00:51 INFO - Running setup.py (path:/tmp/pip-xyLEFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:00:51 INFO - Running setup.py (path:/tmp/pip-UNdZPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:00:51 INFO - Running setup.py (path:/tmp/pip-o0fZtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:00:51 INFO - Running setup.py (path:/tmp/pip-xEoYiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:00:51 INFO - Running setup.py (path:/tmp/pip-Q3NTtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:00:51 INFO - Running setup.py (path:/tmp/pip-QDCdmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:00:52 INFO - Running setup.py (path:/tmp/pip-JpT8sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:00:52 INFO - Running setup.py (path:/tmp/pip-Yr7whi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:00:52 INFO - Running setup.py (path:/tmp/pip-qhGPmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:00:52 INFO - Running setup.py (path:/tmp/pip-nmnsmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:00:52 INFO - Running setup.py (path:/tmp/pip-y2kFJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:00:52 INFO - Running setup.py (path:/tmp/pip-JUFCiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:00:52 INFO - Running setup.py (path:/tmp/pip-RYmMK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:00:52 INFO - Running setup.py (path:/tmp/pip-TFIYn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:00:52 INFO - Running setup.py (path:/tmp/pip-wdiDHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:00:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:54 INFO - Downloading blessings-1.6.tar.gz 23:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:00:54 INFO - Installing collected packages: blessings 23:00:54 INFO - Running setup.py install for blessings 23:00:54 INFO - Successfully installed blessings 23:00:54 INFO - Cleaning up... 23:00:54 INFO - Return code: 0 23:00:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:00:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:00:55 INFO - Reading from file tmpfile_stdout 23:00:55 INFO - Current package versions: 23:00:55 INFO - argparse == 1.2.1 23:00:55 INFO - blessings == 1.6 23:00:55 INFO - blobuploader == 1.2.4 23:00:55 INFO - docopt == 0.6.1 23:00:55 INFO - manifestparser == 1.1 23:00:55 INFO - mozInstall == 1.12 23:00:55 INFO - mozcrash == 0.17 23:00:55 INFO - mozdebug == 0.1 23:00:55 INFO - mozdevice == 0.48 23:00:55 INFO - mozfile == 1.2 23:00:55 INFO - mozhttpd == 0.7 23:00:55 INFO - mozinfo == 0.9 23:00:55 INFO - mozleak == 0.1 23:00:55 INFO - mozlog == 3.1 23:00:55 INFO - moznetwork == 0.27 23:00:55 INFO - mozprocess == 0.22 23:00:55 INFO - mozprofile == 0.28 23:00:55 INFO - mozrunner == 6.11 23:00:55 INFO - mozscreenshot == 0.1 23:00:55 INFO - mozsystemmonitor == 0.0 23:00:55 INFO - moztest == 0.7 23:00:55 INFO - mozversion == 1.4 23:00:55 INFO - psutil == 3.1.1 23:00:55 INFO - requests == 1.2.3 23:00:55 INFO - wsgiref == 0.1.2 23:00:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36d720cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19399a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8810>, '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 0x19c9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c9ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:00:55 INFO - Using env: {'DISPLAY': ':0', 23:00:55 INFO - 'HOME': '/home/cltbld', 23:00:55 INFO - 'LANG': 'en_US.UTF-8', 23:00:55 INFO - 'LANGUAGE': 'en_US:en', 23:00:55 INFO - 'LOGNAME': 'cltbld', 23:00:55 INFO - 'MAIL': '/var/mail/cltbld', 23:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:55 INFO - 'MOZ_NO_REMOTE': '1', 23:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:55 INFO - 'NO_EM_RESTART': '1', 23:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:55 INFO - 'PWD': '/builds/slave/test', 23:00:55 INFO - 'SHELL': '/bin/bash', 23:00:55 INFO - 'SHLVL': '1', 23:00:55 INFO - 'TERM': 'linux', 23:00:55 INFO - 'TMOUT': '86400', 23:00:55 INFO - 'USER': 'cltbld', 23:00:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 23:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:55 INFO - '_': '/tools/buildbot/bin/python'} 23:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:00:55 INFO - Cleaning up... 23:00:55 INFO - Return code: 0 23:00:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36d720cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19399a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8810>, '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 0x19c9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c9ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:00:55 INFO - Using env: {'DISPLAY': ':0', 23:00:55 INFO - 'HOME': '/home/cltbld', 23:00:55 INFO - 'LANG': 'en_US.UTF-8', 23:00:55 INFO - 'LANGUAGE': 'en_US:en', 23:00:55 INFO - 'LOGNAME': 'cltbld', 23:00:55 INFO - 'MAIL': '/var/mail/cltbld', 23:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:55 INFO - 'MOZ_NO_REMOTE': '1', 23:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:55 INFO - 'NO_EM_RESTART': '1', 23:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:55 INFO - 'PWD': '/builds/slave/test', 23:00:55 INFO - 'SHELL': '/bin/bash', 23:00:55 INFO - 'SHLVL': '1', 23:00:55 INFO - 'TERM': 'linux', 23:00:55 INFO - 'TMOUT': '86400', 23:00:55 INFO - 'USER': 'cltbld', 23:00:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 23:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:55 INFO - '_': '/tools/buildbot/bin/python'} 23:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:55 INFO - Downloading/unpacking jsonschema 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:00:58 INFO - Downloading/unpacking functools32 (from jsonschema) 23:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:58 INFO - Downloading functools32-3.2.3-2.tar.gz 23:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:00:58 INFO - warning: no files found matching '*.txt' 23:00:58 INFO - no previously-included directories found matching 'build' 23:00:58 INFO - no previously-included directories found matching 'dist' 23:00:58 INFO - no previously-included directories found matching '.git*' 23:00:58 INFO - Installing collected packages: jsonschema, functools32 23:00:58 INFO - Running setup.py install for functools32 23:00:58 INFO - warning: no files found matching '*.txt' 23:00:58 INFO - no previously-included directories found matching 'build' 23:00:58 INFO - no previously-included directories found matching 'dist' 23:00:58 INFO - no previously-included directories found matching '.git*' 23:00:58 INFO - Successfully installed jsonschema functools32 23:00:58 INFO - Cleaning up... 23:00:58 INFO - Return code: 0 23:00:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36d720cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19399a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8810>, '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 0x19c9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c9ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:00:58 INFO - Using env: {'DISPLAY': ':0', 23:00:58 INFO - 'HOME': '/home/cltbld', 23:00:58 INFO - 'LANG': 'en_US.UTF-8', 23:00:58 INFO - 'LANGUAGE': 'en_US:en', 23:00:58 INFO - 'LOGNAME': 'cltbld', 23:00:58 INFO - 'MAIL': '/var/mail/cltbld', 23:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:58 INFO - 'MOZ_NO_REMOTE': '1', 23:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:58 INFO - 'NO_EM_RESTART': '1', 23:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:58 INFO - 'PWD': '/builds/slave/test', 23:00:58 INFO - 'SHELL': '/bin/bash', 23:00:58 INFO - 'SHLVL': '1', 23:00:58 INFO - 'TERM': 'linux', 23:00:58 INFO - 'TMOUT': '86400', 23:00:58 INFO - 'USER': 'cltbld', 23:00:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 23:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:58 INFO - '_': '/tools/buildbot/bin/python'} 23:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:59 INFO - Downloading/unpacking flake8 23:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:01:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:01:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:01:01 INFO - no previously-included directories found matching 'docs/_build' 23:01:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:01:01 INFO - Running setup.py install for pep8 23:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:01:01 INFO - no previously-included directories found matching 'docs/_build' 23:01:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:01:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:01:01 INFO - Cleaning up... 23:01:01 INFO - Return code: 0 23:01:01 INFO - Running post-action listener: _resource_record_post_action 23:01:01 INFO - Running post-action listener: _start_resource_monitoring 23:01:02 INFO - Starting resource monitoring. 23:01:02 INFO - ##### 23:01:02 INFO - ##### Running install step. 23:01:02 INFO - ##### 23:01:02 INFO - Running pre-action listener: _resource_record_pre_action 23:01:02 INFO - Running main action method: install 23:01:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:02 INFO - Reading from file tmpfile_stdout 23:01:02 INFO - Detecting whether we're running mozinstall >=1.0... 23:01:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:01:02 INFO - Reading from file tmpfile_stdout 23:01:02 INFO - Output received: 23:01:02 INFO - Usage: mozinstall [options] installer 23:01:02 INFO - Options: 23:01:02 INFO - -h, --help show this help message and exit 23:01:02 INFO - -d DEST, --destination=DEST 23:01:02 INFO - Directory to install application into. [default: 23:01:02 INFO - "/builds/slave/test"] 23:01:02 INFO - --app=APP Application being installed. [default: firefox] 23:01:02 INFO - mkdir: /builds/slave/test/build/application 23:01:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:01:18 INFO - Reading from file tmpfile_stdout 23:01:18 INFO - Output received: 23:01:18 INFO - /builds/slave/test/build/application/firefox/firefox 23:01:18 INFO - Running post-action listener: _resource_record_post_action 23:01:18 INFO - ##### 23:01:18 INFO - ##### Running run-tests step. 23:01:18 INFO - ##### 23:01:18 INFO - Running pre-action listener: _resource_record_pre_action 23:01:18 INFO - Running main action method: run_tests 23:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:01:18 INFO - Python 2.7.3 23:01:18 INFO - Return code: 0 23:01:18 INFO - grabbing minidump binary from tooltool 23:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8810>, '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 0x19c9710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c9ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:01:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:01:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:01:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:01:18 INFO - Return code: 0 23:01:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:01:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:01:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:01:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:01:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:01:19 INFO - Return code: 0 23:01:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:01:19 INFO - Using env: {'DISPLAY': ':0', 23:01:19 INFO - 'HOME': '/home/cltbld', 23:01:19 INFO - 'LANG': 'en_US.UTF-8', 23:01:19 INFO - 'LANGUAGE': 'en_US:en', 23:01:19 INFO - 'LOGNAME': 'cltbld', 23:01:19 INFO - 'MAIL': '/var/mail/cltbld', 23:01:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:01:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:19 INFO - 'MOZ_NO_REMOTE': '1', 23:01:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:19 INFO - 'NO_EM_RESTART': '1', 23:01:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:19 INFO - 'PWD': '/builds/slave/test', 23:01:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:01:19 INFO - 'SHELL': '/bin/bash', 23:01:19 INFO - 'SHLVL': '1', 23:01:19 INFO - 'TERM': 'linux', 23:01:19 INFO - 'TMOUT': '86400', 23:01:19 INFO - 'USER': 'cltbld', 23:01:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272', 23:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:19 INFO - '_': '/tools/buildbot/bin/python'} 23:01:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:01:20 INFO - mozversion application_buildid: 20160415203232 23:01:20 INFO - mozversion application_changeset: 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 23:01:20 INFO - mozversion application_display_name: Nightly 23:01:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:01:20 INFO - mozversion application_name: Firefox 23:01:20 INFO - mozversion application_remotingname: firefox 23:01:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:01:20 INFO - mozversion application_vendor: Mozilla 23:01:20 INFO - mozversion application_version: 48.0a1 23:01:20 INFO - mozversion platform_buildid: 20160415203232 23:01:20 INFO - mozversion platform_changeset: 42a0a7f409d1b9a40770e36a66af6ccf67539cc4 23:01:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:01:20 INFO - mozversion platform_version: 48.0a1 23:01:20 INFO - using testdate: 1460786480 23:01:20 INFO - actual date: 1460786480 23:01:20 INFO - starting webserver on 'localhost:46602' 23:01:20 INFO - SUITE-START | Running 2 tests 23:01:20 INFO - TEST-START | dromaeo_css 23:01:20 INFO - operating with platform_type : linux_ 23:01:20 INFO - Initialising browser for dromaeo_css test... 23:01:20 INFO - TEST-INFO | started process 12138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjFlaxM/profile http://localhost:46602/getInfo.html) 23:01:23 INFO - PROCESS | 12138 | __metrics Screen width/height:1600/1200 23:01:23 INFO - PROCESS | 12138 | colorDepth:24 23:01:23 INFO - PROCESS | 12138 | Browser inner width/height: 1024/697 23:01:23 INFO - PROCESS | 12138 | __metrics 23:01:24 ERROR - PROCESS | 12138 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:01:25 INFO - TEST-INFO | 12138: exit 0 23:01:25 INFO - Browser initialized. 23:01:25 INFO - Running cycle 1/1 for dromaeo_css test... 23:01:25 INFO - TEST-INFO | started process 12222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjFlaxM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:37 INFO - PROCESS | 12222 | RSS: Main: 152649728 23:01:37 INFO - PROCESS | 12222 | 23:02:28 INFO - PROCESS | 12222 | 1460786548267 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:04:35 INFO - PROCESS | 12222 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46602/tests/dromaeo/cssquery-ext.html) 23:04:36 INFO - PROCESS | 12222 | RSS: Main: 239271936 23:04:36 INFO - PROCESS | 12222 | 23:07:38 INFO - PROCESS | 12222 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-ext.html (next: http://localhost:46602/tests/dromaeo/cssquery-jquery.html) 23:07:39 INFO - PROCESS | 12222 | RSS: Main: 239841280 23:07:39 INFO - PROCESS | 12222 | 23:10:41 INFO - PROCESS | 12222 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46602/tests/dromaeo/cssquery-mootools.html) 23:10:42 INFO - PROCESS | 12222 | RSS: Main: 235720704 23:10:42 INFO - PROCESS | 12222 | 23:13:44 INFO - PROCESS | 12222 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46602/tests/dromaeo/cssquery-prototype.html) 23:13:44 INFO - PROCESS | 12222 | RSS: Main: 239779840 23:13:44 INFO - PROCESS | 12222 | 23:16:47 INFO - PROCESS | 12222 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46602/tests/dromaeo/cssquery-yui.html) 23:16:47 INFO - PROCESS | 12222 | RSS: Main: 225968128 23:16:47 INFO - PROCESS | 12222 | 23:19:50 INFO - PROCESS | 12222 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-yui.html (next: http://localhost:46602/tests/dromaeo/cssquery-dojo.html) 23:19:50 INFO - PROCESS | 12222 | RSS: Main: 264548352 23:19:50 INFO - PROCESS | 12222 | 23:19:50 INFO - PROCESS | 12222 | __start_tp_report 23:19:50 INFO - PROCESS | 12222 | _x_x_mozilla_page_load 23:19:50 INFO - PROCESS | 12222 | _x_x_mozilla_page_load_details 23:19:50 INFO - PROCESS | 12222 | |i|pagename|runs| 23:19:50 INFO - PROCESS | 12222 | |0;dojo.html;2994.341244926116;3056.5262384330435;3099.5660607514938;3103.7982531135476;3130.5773720547727;5135.255387968742;5208.401033881105;5243.737813109344;5279;5317.707526086068;5301.3108295921575;5314.415414304433;5316.0962636351815;5330.573554115671;5339.706316152619;4592.288195329729;4636.142313671973;4845.37010188675;4859.562639362457;4895.192293271606;4741.478437371887;4819.0602832447685;4847.587955023827;4852.199387101124;4853.708777473345;4737.573618374346;4783.210770222909;4784.497627749071;4785.95214047862;4794.9520504794855;4674.789634466457;4675.485696573374;4677.602403795681;4700.224462963607;4712.670113092085;4649.442066951988;4664.650151238637;4682.742449165295;4717.858464246078;4775.976120119377;5054.494550544953;5070.29015937769;5071.467495912912;5112.897742045138;5132.717700526469;5415.268938693304;5440.4287549807495;5441.401445840955;5465.617406781487;5487.478689524489;5481.808136715196;5521.116621340607;5572.498475137217;5661.801836935688;5731.312242530881;5258.8159414420315;5260.0531904257605;5262.394824595144;5265.104932161504;5301.761420736076;5709.200711900337;5710.857228569319;5712.714364281853;5712.942870571241;5734.139879018097;5297.390800058042;5347.224652425454;5405.837824865261;5423.511883930465;5515.586331025189;5539.390667026624;5543.1685247213245;5543.390227075019;5550.417206193372;5553.750081246354;5493.917591236055;5508.091164957817;5509.614326997072;5513.117901135799;5565.16522521625;5530.640508366943;5537.640053396516;5570.972145139248;5579.525740312119;5621.156826476062;4204;4235.174141042467;4236.915261694749;4239.915201696011;4270.679699022586;3767.698584113264;3788.924221515554;3799.8290076946605;3817.4655548222718;3838.5201849768778;5345.251664766935;5371.194320851825;5405.243265942771;5408.891822163535;5420.4850539198715;5608.887822243532;5665.008623490872;5666.688332141689;5671.773129074873;5675.290588676416;5299.6290259681455;5305.1776974569;5307.761150748149;5326.5206131447585;5408.45915408456;4456.153330867125;4697.365855609517;4761.119192949315;4786.928196077061;4789.066132104206;5759.625624334405;5768.048272035151;5773.451522105393;5773.711314434261;5777.075667893201;5582.637128586629;5583.69289689071;5586.608937374507;5586.86032849182;5589.5807814413265;5586.972065139648;5607.691576963143;5633.521150702072;5682.715864206691;5699.2590963174525;5437.483439073281;5462.317210348707;5467.261919640798;5471.671699698031;5478.945210548003;5528.474794894479;5546.861328466821;5547.2511210986;5561.5272701820795;5593.608447408642;5396.271503347155;5498.120300751861;5529.30883639545;5530.557555395479;5541.3904470509015;5268.81559145428;5271.71005594696;5276.498732620395;5283.5773138149625;5294.470552944675;5190.532852043334;5193.987172501477;5196.298499702643;5245.449227831023;5271.051210782096;5324.920126198188;5359.356877174764;5362.276092727432;5402.324709411324;5406;5142.742862856917;5225.477452254744;5226.268322434938;5232.136697444879;5288.762005709676 23:19:50 INFO - PROCESS | 12222 | |1;ext.html;626.3110578363801;650.2359727320397;655.2301046270633;659.0608383054148;663.0419044480727;29347;29891.701082989162;37093.629063709355;37648.623513764855;38012.809935950354;40113.398299025466;40851.79574102133;40904.59095409045;40919.181616367656;40920;8175.059868115153;8366.665333386687;8376.958115209445;8378.245957863792;8384.8742268866;8448.23965843074;8578.18507241811;8578.656853725843;8579.142085791402;8579.399442039059;8765.386422950396;8851.513166775858;8860.734177974638;8861.556922153899;8862.33532485063;8717.7820554486;8804.515751633657;8824.691135810215;8829.646814127427;8831.381803273742;8669.523176225304;8775;8783.47299162046;8784;8788.077251888588;39905.201895961916;40318.39522407137;40352.39471407931;40489.39265910984;40533.18933621311;3116.2676770958806;3253.235489659928;3261.6901394367496;3326.617438994522;3329.101142691484;30034.549481757793;30194.69805301941;30628.387432251453;30980.845095774603;31078;4228.6617070634275;4259.339802330644;4321.6326612238;4344.956550434486;4362.585554372329;248352;250294;250983;251458;251854;57323;57719;60118.69940650269;60247.39752602505;60816.69591652013;68171.18288171242;69223;69500.30499694939;69567.30432695709;69643.30356696469;15495.14776687293;15560.299786509635;15663.530094097196;15778.289976951064;15818.288177032062;11509.48207330672;12054.156209065457;12410.317432541116;12516.687082823002;12519.43662535188;20143.39569812908;20302.796972030384;20483.28308509195;20634.58730825375;20829.791702082784;7216;7275.818104547428;7410.333070023724;7457.589832559262;7675.53946763196;978.6623614852864;1051.2588625019343;1108.5454963465102;1117.234694234452;1221.9022478201723;32362.190945226557;32462.675373245966;32561.674383256337;33039.50440743391;33487.66512334894;1095.3865835132192;1122.6968718445974;1169.7368092179192;1170.9414529273502;1196.347990345264;16984.40554580584;17191.914040429718;17317.7402338965;17325.826741732675;17545.385911493035;483002;490446;490628;491733;495204;56326;57277.713611431675;57295.713521432124;57343.13985290224;57359;1219.030870457988;1367.5760514240617;1393.665520275147;1404.4171668757351;1413.0603148906068;28520.85739571372;29544.409111817215;29651.851740742022;30105.397892041598;31384.372312553165;46221;46334.53665463437;46677.29984050174;46704;46799.06401872011;289913;289925;290284;291975;293064;37187.88436346914;42535.787321063195;43570.782146090336;43641;45400;45281.54718452905;45672;45934.997832596535;46442;46523.534764653275;38849;38903.41644875272;39256;39309.80345098256;40392.596074038884;39282.214355713295;39816.60183398129;39932.40101398539;39994.40008399818;40290.59709402986;40019.39970900497;40245.59754402535;40546.59453405546;40636.79681601691;40704.796476018615;28448.57327140053;30366.240843979078;30404.69595304107;30440.695593043787;30761;26927;27249;27564.86217568899;27597.724022759514;27780.44439111247 23:19:50 INFO - PROCESS | 12222 | |2;jquery.html;392.5622930432568;396.8095314249162;398.5595916512252;407.89394757363095;409.234731052931;14023.509177178801;14344.426222951095;16840.24218910149;17785.64428711425;17830.375936842214;11284.379359135244;11803.645890623273;17741.201645925932;18113.547161320974;18128.274869005258;5019.171836646958;5100.183970564692;5142.177251639739;5146.819861304855;5168.741562921858;5129.640925135223;5138.794448222066;5645.887082258352;5657.23627310314;5688.772449102031;5627.493525582697;5629.099344104944;5638.069718496464;5640.661560306375;5650.604457687963;5384.542313903323;5688.203651488795;5688.5733569982;5708.600397972144;5729.369769325371;5454.263674403945;5460.945390546083;5464.863378415532;5466;5469.589780766459;12273.509059637603;13068.411921463558;13073;13148.40832162555;13150.276734779583;2336.4509340305017;2523.823332366735;2580.096966061882;2652.4591958054048;2772.50094982903;9660.37207581505;9702.61189552417;9885.406875587487;9935.105840474393;10301.124404425633;1772.2113659421564;1865.2445759467437;1871.9891258720274;1875.3215871794666;1903.3718872771951;72412;74219.25780742231;74746.25253747447;76617;76916.99999999945;10811.675649730521;10904.182186336056;10940.890591093987;10982.341059536293;11183;15343.309551070228;15352.462663806713;15414.229288535753;15485.612859678373;15533.301001454962;7792.259735325135;7969.681212751425;7980.401469889665;8047.83904321922;8049.718259860877;7510.586917719578;7522.252632098013;7522.6614802334025;7619.695212191561;7662.540247585162;4664.207084795593;4682.321063445781;4731.526847315241;4798.136335459651;4842.15262329091;1903.3718872771951;1931.65230258552;1935.9806401936082;1960.578475627747;1991.5220347116588;935.7754139006589;983.5918093991056;1034.4310629153936;1062.744941214103;1084.3331351219101;18584.628307434046;18672.719909201373;19001.42995710131;19028.429147125607;19358.322458713876;976.9120779129912;987.3187500624546;1001.1890368801294;1006.7080546641392;1104.2546281260118;10225.948870255601;10613.257072004886;10760;10814.188935829687;10827.891721082846;172488;507619;530661;535725;539761;86815;90430.54784726034;91920.54039729759;91992;92734;1054.8470471781702;1071.7320669832543;1104.0780947908427;1104.1773878460438;1111.3054341036852;16449.83550164531;16782.58043548921;16844.242009109374;17007.574810629834;17277.56806079858;37655.435168471944;37865.242695146495;38513.614863852126;38657;38924.80537597294;49332.2600161005;51872.221916670525;52197.33272039589;53111.20333195083;54497;8283.461574997606;8296.502209867427;8373.413861029669;8408.83182336362;8522.232999030117;13005.869941300843;13021.414036368576;13073.084884058024;13262.602121936357;13596.11625244356;10969.780604387708;11558.826617600575;11654.88345116538;11695.473703683185;11861;7526.962365188139;7570.712978793728;11483.311001339946;11487.195896287514;11611.6516504505;11672.241304315192;11721.531138754355;11824.231424957694;11962.34207118582;11976.401179941142;8194.139615340542;8265.256126948603;8442.41260008229;8449.915500844912;8460.153984601737;10990.835137473105;11113;11445.713857153638;11684.649460516199;11699.181057325906 23:19:50 INFO - PROCESS | 12222 | |3;mootools.html;1143.0284258380373;1511.4634304821784;1521.2165734646655;1657.635320229549;1779.2438213759149;7775.650095745691;8005.1994800519915;8048.074471435772;8057.1539988301265;8059.032916050068;7949.165337639552;7950.64222110005;7996.520208787477;8005.999250093738;8016.759497215078;2026.2705426046612;2161.211157927357;2200.328899685603;2200.933971980843;2216.8780717060554;2335.824813139013;2362.2676970139228;2363.0429675981254;2364.858108513486;2364.9948771772015;2289.8511596746243;2294.105298933417;2324.2097686786487;2328.1851352026824;2329.9184528541505;1984.7519060117486;2047.9043711614363;2146.1200907627954;2208.823294136473;2217.157480157546;2224.1992882562263;2240.6975058367075;2245.955080898389;2247.449374903159;2248.6402175651815;8188.959055204686;8204.630791614392;8262.710805121853;8264.380171487102;8264.917350826476;5026;5147.845564633029;5177.326947496839;5178.197379406198;5194.71429071401;3219.5492631031675;3285.474324108155;3399.456087026064;3411.3177364527196;3421.1105112670634;1100.0759362135764;1111.183280288987;1116.9273997190157;1124.3759713359163;1126.0766171739176;11976.461059252355;11978.281303121754;11990.940045299805;12022.819657705142;12031.57889473873;4654.488006319302;4664.930026049612;4819.373481447389;4824.782884770194;4844.806207751721;8989.730308090768;9009.324300677476;9027.50348730826;9055.81888362229;9064.909350906539;5192.039472697563;5199.610029247821;5208.895822083613;5233.555147812479;5233.790648374099;4309.439772829513;4658.1848176568965;4718.787654555554;4726.740029298421;4728.952710472851;3763.247350529905;3766.6610005099674;3810.942835857464;3841.615838416136;3902.824372903226;1155.8266260061057;1164.2723297938787;1180.2741314091943;1180.6576092932953;1189.4766302826729;907.682311191091;907.945523268606;926.305271046715;953.7091187187835;958.3148049144895;5441.156620723794;5765.365809760923;5791.391903850035;5874.733880212578;5881.941180588225;410.15712710380456;432.06889153873453;434.23574508864624;445.6768842589097;448.48648297699606;3876.379779235309;3905.6484916357663;3932.7640341579595;3985.4818873546255;4040.2323558523785;10480.109190718722;10850.29473084247;10955.780884382428;10968.396738179317;10984.615538456115;10713.089387402159;10776.29954052984;10799.946000269949;10861.456927153611;10990.230683852054;7513.586752728653;7798.298153166243;7833.529988200727;7858.174891636296;8008.27925486709;5580.441955804549;5659.207710920557;5702.714864256854;5713.257276554022;5875.853103672443;9871.605135794487;9914.950425247827;9948.403095814274;10132.797344053226;10147.695569132939;9780.119789219005;10104.797904042025;10211.7447063824;10247.487625618838;10366.792664146826;6398.968005159944;6597.736090556324;6762.898556521558;7144;7220.241874603091;8236.629351679308;8246.463979841292;8299.29455996247;8315.334773218248;8334.083250842525;7078.256783037707;7188.8921666174;7342.5227360221415;7368.263173682589;7386;7323.560586364835;7336.96331518339;7358.080239970004;7369.336759691653;7404.407647388089;6653.367930046637;6671.266160722414;6722;6724.529282950147;6735.124433823572;4916.287138364989;4916.852494425173;4951.455339912534;5089.821856235014;5202.765875535686;5061.342025536656;5178.97410512945;5180.119379705535;5202.3497062867145;5299.49654782795 23:19:50 INFO - PROCESS | 12222 | |4;prototype.html;331.47082911321866;339.2841105267885;341.3514322786705;344.0092533503511;344.36464722586817;5379.300690910186;5407.783688652459;5463.535599474045;5529.474699903508;5572.498475137242;5379.300690910186;5410.323709536308;5502.477264659861;5514.531264842493;5523.751431185597;4269.402283680295;4294.849680261192;4303.462067241595;4306.2033523798045;4319.50325712544;3963.54419241788;4158.625723684868;4296.205202037618;4301.419308393358;4322.84870029549;4243.151369726052;4272.46594175728;4277.14457108578;4283.528811830696;4284.700070995032;4260.893477663052;4273.572642735733;4282.516140638422;4282.914341713179;4282.993496528314;3681.7790932544135;3789.147441825595;3798.7720736755605;3801.353769859131;3815;5242.449542798027;5301.973490132525;5316.431652662473;5341.412444631087;5347.358317001946;4906.1414252505665;4911.361523001987;4923.483034281385;4928.827491037797;4931.556159945586;5526.640768350045;5765.1928729977835;5779.190913272145;5786.392428794958;5790.884182316372;4133.648639865615;4144.274751918432;4155.319818716941;4164.312888373414;4175.248455278049;5953.077273022688;6014.8496287592725;6033.245844269466;6038.33578306386;6060.939390606081;4111.075008123148;4337.414449049401;4345.196138714348;4347.413099231627;4356.564343565618;4358.259095953696;4366.8034938427845;4388.253996820548;4389.934150987738;4396.868093957187;4950.727709975986;4952.529509696573;4956.256561515729;4961.156603377434;4972.65191436596;5538.778448862081;5847.590668653239;5865.560082993792;5866.472017518444;5872.060470324727;1419.9077059991068;1455.978160327596;1457.890658200639;1482.0588926032046;1515.1742300446283;1029.3463650581784;1042.7497400623947;1046.387863100095;1049.5591851422269;1061.3207547169818;5540.556755459554;5550.084236100998;5556.805511807148;5558.777648893999;5567.359753628303;5874.471297583238;5894.734736936848;5905.379935106838;5913.467787899023;5931.881362372815;5386.8383948481605;5540.252065971043;5550.611457198038;5586.385497595261;5609.775608975677;3126.343467871772;3135.984320078385;3144.7515026755977;3157.163351711798;3160.9367812644077;5940.495057920125;6071.51427885768;6102.420270074336;6111;6123.601965872204;5946.483646670072;6016.1878146450545;6034.125051867454;6046.395360464006;6052.57631965767;6087.117367981707;6102.511799056065;6130.63216207029;6132.448079672851;6135.417135372132;5748.712564371681;5902.793402230901;5905.379935106752;5940.46535811779;5949;5845.941540584539;5849.415058494116;5866.504041469398;5866.67733274674;5875;5879.265091863517;5992.670403127696;6141.723622436912;6146.323904370426;6167.321594624498;4281.1651727914;4287.3140297552245;4288.120935208337;4290.871273861789;4309.159713855768;5673.74468148926;5868.3251426086545;5896.941030589811;5898.1152827076285;5909.85225369352;5637.689927054052;5802.65184088956;5855.238818953509;5855.531557475477;5875.20684707559;5786;5787.768489260551;5810.215620891126;5818.650880947157;5847.44449277318;5456.372517160577;5665.773369065191;5669.4047125051275;5692.715364231854;5736.397678243724;5835.56233282514;5838.357780644211;5865.354810970704;5873.882522349614;5881.264841894763;5526.336839579276;5752.599261564823;5765.740541675718;5766.913496297475;5793.362730099601 23:19:50 INFO - PROCESS | 12222 | |5;yui.html;750.2460027672189;751.9248075192481;780.8594452998458;785.7014334552869;803.7106641609022;13180.670483237924;13194.53819116331;13271.270080145589;13302.866971330295;13349;13080.803787943189;13213.933930330359;13251.867481325184;13259.469621215165;13283.601491955233;519.4545726986668;818.8976377952756;834.4576025583359;836.3225787112428;836.4395854777299;825.4675734151468;832.1886160993043;832.6003518311214;832.862577674686;839.4249938791947;885.1458342699294;885.2210055151457;885.8405487012335;886.4061079077002;892.0499667853715;544.6187668631953;858.4420126917491;868.9956550217272;870.3646338173169;876.3033388456192;638.2373064188297;640.734095350429;643.6170478565247;646.7865604350553;649.6589290622413;13179.406926688227;13193.538226162134;13229.140105893086;13248.20510769357;13272.402741876542;12179.695507612292;12267.141300108997;12420.937895310466;12527.937360313232;12710.42803073864;10395.32430392022;10426.947865260625;10443.738906527322;10478.63324783629;10964.506597203144;3700.4868800468334;3764;3771.41543060826;3836.156045669948;3867.9613203867884;55367;55731.72134139304;58390.70804645992;58914.41085589132;58961.41038589645;10703.090237329914;10743.731406714895;10797.56809727602;10922.672319830417;10946.945265273622;20531.28140515075;20556.58886822285;20627;20670.379888603366;20684.58630827375;8102.270795628422;8271.13153118926;8339.166083391734;8439.282660973764;8595.5702214889;4584.312353147055;4624.930626040612;4630.513796051433;4633.467151277646;4800.975995120002;3140.7016333448287;3234.110619579634;3234.530993006001;3243.918902027421;3267.379197952381;501.372806493969;553.0266730554254;565.191775760658;592.3602509289957;627.2942939193407;608.2609629300333;667.679513833353;672.525869262169;710.1584622222682;710.4423027923056;8938.86591701125;8976.147266009719;9445.291603129794;9567.330286879851;9577.090176433228;683.1835956032593;694.5867209010731;703.2826516952782;708.6598432752307;718.7304760714732;4487.88780280489;4524.7285162889675;4540.273556231054;4540.318952157137;4583.106294272585;52508.21237681438;53524.464755352725;54116;54284.72857635766;69352.65323673349;52358.21462678063;52846.47153528415;52896;53687.89964953323;53829.73085134628;46821.29768053482;47377.05245895063;48522.75738621284;48719.75640121777;49527.50472495301;8610.61252243638;8759.905011873516;8899.644014239617;8979.865302020344;9172.375338537455;33824.15439613931;34089.147771305914;34840.65159348374;34845.303093938484;35519.82240088783;43376;47936.28095578499;48019.51980480151;48504.27243591278;49225.507744923525;11567.248128871597;11696.70758231051;11751.471183796579;11968.102392320785;12054.638360849189;12947.611571652866;12951.805722913976;13040.54358097462;13058.673533161747;13126.671833204246;12232.388380581113;12276.32480213561;12573.245605263714;12580.748385032432;12626.810597841224;12162.574309899112;12274.509019639114;12690.746185076432;12934.288614125937;12975.870241297465;12281.140320177501;12283.38583070825;12714.237145771283;12802.935985320013;12819;10295.236910831985;10300.948495257475;10367.222458315808;10532.789344213226;10695.304805187638;10710.250282480152;10714.303570267908;10761.30051546647;10774.461276935965;10905.34567925927 23:19:50 INFO - PROCESS | 12222 | __end_tp_report 23:19:50 INFO - PROCESS | 12222 | __start_cc_report 23:19:50 INFO - PROCESS | 12222 | _x_x_mozilla_cycle_collect,819 23:19:50 INFO - PROCESS | 12222 | __end_cc_report 23:19:50 INFO - PROCESS | 12222 | __startTimestamp1460787590783__endTimestamp 23:19:50 INFO - PROCESS | 12222 | 23:19:50 INFO - PROCESS | 12222 | ------- Summary: start ------- 23:19:50 INFO - PROCESS | 12222 | Number of tests: 6 23:19:50 INFO - PROCESS | 12222 | 23:19:50 INFO - PROCESS | 12222 | [#0] dojo.html Cycles:165 Average:5159.34 Median:5324.92 stddev:575.07 (10.8%) stddev-sans-first:551.18 23:19:50 INFO - PROCESS | 12222 | Values: 2994.3 3056.5 3099.6 3103.8 3130.6 5135.3 5208.4 5243.7 5279.0 5317.7 5301.3 5314.4 5316.1 5330.6 5339.7 4592.3 4636.1 4845.4 4859.6 4895.2 4741.5 4819.1 4847.6 4852.2 4853.7 4737.6 4783.2 4784.5 4786.0 4795.0 4674.8 4675.5 4677.6 4700.2 4712.7 4649.4 4664.7 4682.7 4717.9 4776.0 5054.5 5070.3 5071.5 5112.9 5132.7 5415.3 5440.4 5441.4 5465.6 5487.5 5481.8 5521.1 5572.5 5661.8 5731.3 5258.8 5260.1 5262.4 5265.1 5301.8 5709.2 5710.9 5712.7 5712.9 5734.1 5297.4 5347.2 5405.8 5423.5 5515.6 5539.4 5543.2 5543.4 5550.4 5553.8 5493.9 5508.1 5509.6 5513.1 5565.2 5530.6 5537.6 5571.0 5579.5 5621.2 4204.0 4235.2 4236.9 4239.9 4270.7 3767.7 3788.9 3799.8 3817.5 3838.5 5345.3 5371.2 5405.2 5408.9 5420.5 5608.9 5665.0 5666.7 5671.8 5675.3 5299.6 5305.2 5307.8 5326.5 5408.5 4456.2 4697.4 4761.1 4786.9 4789.1 5759.6 5768.0 5773.5 5773.7 5777.1 5582.6 5583.7 5586.6 5586.9 5589.6 5587.0 5607.7 5633.5 5682.7 5699.3 5437.5 5462.3 5467.3 5471.7 5478.9 5528.5 5546.9 5547.3 5561.5 5593.6 5396.3 5498.1 5529.3 5530.6 5541.4 5268.8 5271.7 5276.5 5283.6 5294.5 5190.5 5194.0 5196.3 5245.4 5271.1 5324.9 5359.4 5362.3 5402.3 5406.0 5142.7 5225.5 5226.3 5232.1 5288.8 23:19:50 INFO - PROCESS | 12222 | 23:19:50 INFO - PROCESS | 12222 | [#1] ext.html Cycles:180 Average:51842.75 Median:40179.50 stddev:95148.52 (236.8%) stddev-sans-first:95337.73 23:19:50 INFO - PROCESS | 12222 | Values: 626.3 650.2 655.2 659.1 663.0 29347.0 29891.7 37093.6 37648.6 38012.8 40113.4 40851.8 40904.6 40919.2 40920.0 8175.1 8366.7 8377.0 8378.2 8384.9 8448.2 8578.2 8578.7 8579.1 8579.4 8765.4 8851.5 8860.7 8861.6 8862.3 8717.8 8804.5 8824.7 8829.6 8831.4 8669.5 8775.0 8783.5 8784.0 8788.1 39905.2 40318.4 40352.4 40489.4 40533.2 3116.3 3253.2 3261.7 3326.6 3329.1 30034.5 30194.7 30628.4 30980.8 31078.0 4228.7 4259.3 4321.6 4345.0 4362.6 248352.0 250294.0 250983.0 251458.0 251854.0 57323.0 57719.0 60118.7 60247.4 60816.7 68171.2 69223.0 69500.3 69567.3 69643.3 15495.1 15560.3 15663.5 15778.3 15818.3 11509.5 12054.2 12410.3 12516.7 12519.4 20143.4 20302.8 20483.3 20634.6 20829.8 7216.0 7275.8 7410.3 7457.6 7675.5 978.7 1051.3 1108.5 1117.2 1221.9 32362.2 32462.7 32561.7 33039.5 33487.7 1095.4 1122.7 1169.7 1170.9 1196.3 16984.4 17191.9 17317.7 17325.8 17545.4 483002.0 490446.0 490628.0 491733.0 495204.0 56326.0 57277.7 57295.7 57343.1 57359.0 1219.0 1367.6 1393.7 1404.4 1413.1 28520.9 29544.4 29651.9 30105.4 31384.4 46221.0 46334.5 46677.3 46704.0 46799.1 289913.0 289925.0 290284.0 291975.0 293064.0 37187.9 42535.8 43570.8 43641.0 45400.0 45281.5 45672.0 45935.0 46442.0 46523.5 38849.0 38903.4 39256.0 39309.8 40392.6 39282.2 39816.6 39932.4 39994.4 40290.6 40019.4 40245.6 40546.6 40636.8 40704.8 28448.6 30366.2 30404.7 30440.7 30761.0 26927.0 27249.0 27564.9 27597.7 27780.4 23:19:50 INFO - PROCESS | 12222 | 23:19:50 INFO - PROCESS | 12222 | [#2] jquery.html Cycles:180 Average:27025.45 Median:20213.97 stddev:79148.80 (391.6%) stddev-sans-first:79345.57 23:19:50 INFO - PROCESS | 12222 | Values: 392.6 396.8 398.6 407.9 409.2 14023.5 14344.4 16840.2 17785.6 17830.4 11284.4 11803.6 17741.2 18113.5 18128.3 5019.2 5100.2 5142.2 5146.8 5168.7 5129.6 5138.8 5645.9 5657.2 5688.8 5627.5 5629.1 5638.1 5640.7 5650.6 5384.5 5688.2 5688.6 5708.6 5729.4 5454.3 5460.9 5464.9 5466.0 5469.6 12273.5 13068.4 13073.0 13148.4 13150.3 2336.5 2523.8 2580.1 2652.5 2772.5 9660.4 9702.6 9885.4 9935.1 10301.1 1772.2 1865.2 1872.0 1875.3 1903.4 72412.0 74219.3 74746.3 76617.0 76917.0 10811.7 10904.2 10940.9 10982.3 11183.0 15343.3 15352.5 15414.2 15485.6 15533.3 7792.3 7969.7 7980.4 8047.8 8049.7 7510.6 7522.3 7522.7 7619.7 7662.5 4664.2 4682.3 4731.5 4798.1 4842.2 1903.4 1931.7 1936.0 1960.6 1991.5 935.8 983.6 1034.4 1062.7 1084.3 18584.6 18672.7 19001.4 19028.4 19358.3 976.9 987.3 1001.2 1006.7 1104.3 10225.9 10613.3 10760.0 10814.2 10827.9 172488.0 507619.0 530661.0 535725.0 539761.0 86815.0 90430.5 91920.5 91992.0 92734.0 1054.8 1071.7 1104.1 1104.2 1111.3 16449.8 16782.6 16844.2 17007.6 17277.6 37655.4 37865.2 38513.6 38657.0 38924.8 49332.3 51872.2 52197.3 53111.2 54497.0 8283.5 8296.5 8373.4 8408.8 8522.2 13005.9 13021.4 13073.1 13262.6 13596.1 10969.8 11558.8 11654.9 11695.5 11861.0 7527.0 7570.7 11483.3 11487.2 11611.7 11672.2 11721.5 11824.2 11962.3 11976.4 8194.1 8265.3 8442.4 8449.9 8460.2 10990.8 11113.0 11445.7 11684.6 11699.2 23:19:50 INFO - PROCESS | 12222 | 23:19:50 INFO - PROCESS | 12222 | [#3] mootools.html Cycles:180 Average:5561.03 Median:4880.55 stddev:3179.28 (65.1%) stddev-sans-first:3170.86 23:19:50 INFO - PROCESS | 12222 | Values: 1143.0 1511.5 1521.2 1657.6 1779.2 7775.7 8005.2 8048.1 8057.2 8059.0 7949.2 7950.6 7996.5 8006.0 8016.8 2026.3 2161.2 2200.3 2200.9 2216.9 2335.8 2362.3 2363.0 2364.9 2365.0 2289.9 2294.1 2324.2 2328.2 2329.9 1984.8 2047.9 2146.1 2208.8 2217.2 2224.2 2240.7 2246.0 2247.4 2248.6 8189.0 8204.6 8262.7 8264.4 8264.9 5026.0 5147.8 5177.3 5178.2 5194.7 3219.5 3285.5 3399.5 3411.3 3421.1 1100.1 1111.2 1116.9 1124.4 1126.1 11976.5 11978.3 11990.9 12022.8 12031.6 4654.5 4664.9 4819.4 4824.8 4844.8 8989.7 9009.3 9027.5 9055.8 9064.9 5192.0 5199.6 5208.9 5233.6 5233.8 4309.4 4658.2 4718.8 4726.7 4729.0 3763.2 3766.7 3810.9 3841.6 3902.8 1155.8 1164.3 1180.3 1180.7 1189.5 907.7 907.9 926.3 953.7 958.3 5441.2 5765.4 5791.4 5874.7 5881.9 410.2 432.1 434.2 445.7 448.5 3876.4 3905.6 3932.8 3985.5 4040.2 10480.1 10850.3 10955.8 10968.4 10984.6 10713.1 10776.3 10799.9 10861.5 10990.2 7513.6 7798.3 7833.5 7858.2 8008.3 5580.4 5659.2 5702.7 5713.3 5875.9 9871.6 9915.0 9948.4 10132.8 10147.7 9780.1 10104.8 10211.7 10247.5 10366.8 6399.0 6597.7 6762.9 7144.0 7220.2 8236.6 8246.5 8299.3 8315.3 8334.1 7078.3 7188.9 7342.5 7368.3 7386.0 7323.6 7337.0 7358.1 7369.3 7404.4 6653.4 6671.3 6722.0 6724.5 6735.1 4916.3 4916.9 4951.5 5089.8 5202.8 5061.3 5179.0 5180.1 5202.3 5299.5 23:19:50 INFO - PROCESS | 12222 | 23:19:50 INFO - PROCESS | 12222 | [#4] prototype.html Cycles:180 Average:4870.37 Median:5526.49 stddev:1423.37 (25.8%) stddev-sans-first:1386.00 23:19:50 INFO - PROCESS | 12222 | Values: 331.5 339.3 341.4 344.0 344.4 5379.3 5407.8 5463.5 5529.5 5572.5 5379.3 5410.3 5502.5 5514.5 5523.8 4269.4 4294.8 4303.5 4306.2 4319.5 3963.5 4158.6 4296.2 4301.4 4322.8 4243.2 4272.5 4277.1 4283.5 4284.7 4260.9 4273.6 4282.5 4282.9 4283.0 3681.8 3789.1 3798.8 3801.4 3815.0 5242.4 5302.0 5316.4 5341.4 5347.4 4906.1 4911.4 4923.5 4928.8 4931.6 5526.6 5765.2 5779.2 5786.4 5790.9 4133.6 4144.3 4155.3 4164.3 4175.2 5953.1 6014.8 6033.2 6038.3 6060.9 4111.1 4337.4 4345.2 4347.4 4356.6 4358.3 4366.8 4388.3 4389.9 4396.9 4950.7 4952.5 4956.3 4961.2 4972.7 5538.8 5847.6 5865.6 5866.5 5872.1 1419.9 1456.0 1457.9 1482.1 1515.2 1029.3 1042.7 1046.4 1049.6 1061.3 5540.6 5550.1 5556.8 5558.8 5567.4 5874.5 5894.7 5905.4 5913.5 5931.9 5386.8 5540.3 5550.6 5586.4 5609.8 3126.3 3136.0 3144.8 3157.2 3160.9 5940.5 6071.5 6102.4 6111.0 6123.6 5946.5 6016.2 6034.1 6046.4 6052.6 6087.1 6102.5 6130.6 6132.4 6135.4 5748.7 5902.8 5905.4 5940.5 5949.0 5845.9 5849.4 5866.5 5866.7 5875.0 5879.3 5992.7 6141.7 6146.3 6167.3 4281.2 4287.3 4288.1 4290.9 4309.2 5673.7 5868.3 5896.9 5898.1 5909.9 5637.7 5802.7 5855.2 5855.5 5875.2 5786.0 5787.8 5810.2 5818.7 5847.4 5456.4 5665.8 5669.4 5692.7 5736.4 5835.6 5838.4 5865.4 5873.9 5881.3 5526.3 5752.6 5765.7 5766.9 5793.4 23:19:50 INFO - PROCESS | 12222 | 23:19:50 INFO - PROCESS | 12222 | [#5] yui.html Cycles:180 Average:14576.85 Median:4583.71 stddev:16848.12 (367.6%) stddev-sans-first:16863.38 23:19:50 INFO - PROCESS | 12222 | Values: 750.2 751.9 780.9 785.7 803.7 13180.7 13194.5 13271.3 13302.9 13349.0 13080.8 13213.9 13251.9 13259.5 13283.6 519.5 818.9 834.5 836.3 836.4 825.5 832.2 832.6 832.9 839.4 885.1 885.2 885.8 886.4 892.0 544.6 858.4 869.0 870.4 876.3 638.2 640.7 643.6 646.8 649.7 13179.4 13193.5 13229.1 13248.2 13272.4 12179.7 12267.1 12420.9 12527.9 12710.4 10395.3 10426.9 10443.7 10478.6 10964.5 3700.5 3764.0 3771.4 3836.2 3868.0 55367.0 55731.7 58390.7 58914.4 58961.4 10703.1 10743.7 10797.6 10922.7 10946.9 20531.3 20556.6 20627.0 20670.4 20684.6 8102.3 8271.1 8339.2 8439.3 8595.6 4584.3 4624.9 4630.5 4633.5 4801.0 3140.7 3234.1 3234.5 3243.9 3267.4 501.4 553.0 565.2 592.4 627.3 608.3 667.7 672.5 710.2 710.4 8938.9 8976.1 9445.3 9567.3 9577.1 683.2 694.6 703.3 708.7 718.7 4487.9 4524.7 4540.3 4540.3 4583.1 52508.2 53524.5 54116.0 54284.7 69352.7 52358.2 52846.5 52896.0 53687.9 53829.7 46821.3 47377.1 48522.8 48719.8 49527.5 8610.6 8759.9 8899.6 8979.9 9172.4 33824.2 34089.1 34840.7 34845.3 35519.8 43376.0 47936.3 48019.5 48504.3 49225.5 11567.2 11696.7 11751.5 11968.1 12054.6 12947.6 12951.8 13040.5 13058.7 13126.7 12232.4 12276.3 12573.2 12580.7 12626.8 12162.6 12274.5 12690.7 12934.3 12975.9 12281.1 12283.4 12714.2 12802.9 12819.0 10295.2 10300.9 10367.2 10532.8 10695.3 10710.3 10714.3 10761.3 10774.5 10905.3 23:19:50 INFO - PROCESS | 12222 | -------- Summary: end -------- 23:19:50 INFO - PROCESS | 12222 | 23:19:51 INFO - TEST-INFO | 12222: exit 0 23:19:51 INFO - TEST-OK | dromaeo_css | took 1111389ms 23:19:51 INFO - TEST-START | kraken 23:19:51 INFO - operating with platform_type : linux_ 23:19:51 INFO - Initialising browser for kraken test... 23:19:51 INFO - TEST-INFO | started process 12403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4m20Qj/profile http://localhost:46602/getInfo.html) 23:19:55 INFO - PROCESS | 12403 | __metrics Screen width/height:1600/1200 23:19:55 INFO - PROCESS | 12403 | colorDepth:24 23:19:55 INFO - PROCESS | 12403 | Browser inner width/height: 1024/697 23:19:55 INFO - PROCESS | 12403 | __metrics 23:19:56 ERROR - PROCESS | 12403 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:19:56 INFO - TEST-INFO | 12403: exit 0 23:19:56 INFO - Browser initialized. 23:19:56 INFO - Running cycle 1/1 for kraken test... 23:19:56 INFO - TEST-INFO | started process 12484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4m20Qj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:08 INFO - PROCESS | 12484 | RSS: Main: 152600576 23:20:08 INFO - PROCESS | 12484 | 23:20:11 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46602/tests/kraken/driver.html?testName=audio-beat-detection) 23:20:12 INFO - PROCESS | 12484 | RSS: Main: 207892480 23:20:12 INFO - PROCESS | 12484 | 23:20:14 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46602/tests/kraken/driver.html?testName=audio-dft) 23:20:15 INFO - PROCESS | 12484 | RSS: Main: 194039808 23:20:15 INFO - PROCESS | 12484 | 23:20:18 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46602/tests/kraken/driver.html?testName=audio-fft) 23:20:19 INFO - PROCESS | 12484 | RSS: Main: 264536064 23:20:19 INFO - PROCESS | 12484 | 23:20:21 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46602/tests/kraken/driver.html?testName=audio-oscillator) 23:20:21 INFO - PROCESS | 12484 | RSS: Main: 172036096 23:20:21 INFO - PROCESS | 12484 | 23:20:23 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46602/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:20:24 INFO - PROCESS | 12484 | RSS: Main: 176717824 23:20:24 INFO - PROCESS | 12484 | 23:20:27 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46602/tests/kraken/driver.html?testName=imaging-darkroom) 23:20:28 INFO - PROCESS | 12484 | RSS: Main: 212799488 23:20:28 INFO - PROCESS | 12484 | 23:20:31 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46602/tests/kraken/driver.html?testName=imaging-desaturate) 23:20:32 INFO - PROCESS | 12484 | RSS: Main: 213635072 23:20:32 INFO - PROCESS | 12484 | 23:20:34 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46602/tests/kraken/driver.html?testName=json-parse-financial) 23:20:35 INFO - PROCESS | 12484 | RSS: Main: 213905408 23:20:35 INFO - PROCESS | 12484 | 23:20:36 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46602/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:20:37 INFO - PROCESS | 12484 | RSS: Main: 200351744 23:20:37 INFO - PROCESS | 12484 | 23:20:39 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:20:39 INFO - PROCESS | 12484 | RSS: Main: 202006528 23:20:39 INFO - PROCESS | 12484 | 23:20:41 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:20:42 INFO - PROCESS | 12484 | RSS: Main: 217456640 23:20:42 INFO - PROCESS | 12484 | 23:20:45 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:20:45 INFO - PROCESS | 12484 | RSS: Main: 222093312 23:20:45 INFO - PROCESS | 12484 | 23:20:48 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:20:49 INFO - PROCESS | 12484 | RSS: Main: 218406912 23:20:49 INFO - PROCESS | 12484 | 23:20:50 INFO - PROCESS | 12484 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46602/tests/kraken/driver.html?testName=ai-astar) 23:20:51 INFO - PROCESS | 12484 | RSS: Main: 282648576 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | __start_tp_report 23:20:51 INFO - PROCESS | 12484 | _x_x_mozilla_page_load 23:20:51 INFO - PROCESS | 12484 | _x_x_mozilla_page_load_details 23:20:51 INFO - PROCESS | 12484 | |i|pagename|runs| 23:20:51 INFO - PROCESS | 12484 | |0;ai-astar;112;111;107;114;113;111;101;112;112;111 23:20:51 INFO - PROCESS | 12484 | |1;audio-beat-detection;155;129;160;193;125;159;151;132;195;129 23:20:51 INFO - PROCESS | 12484 | |2;audio-dft;162;161;161;162;161;159;162;163;161;162 23:20:51 INFO - PROCESS | 12484 | |3;audio-fft;75;73;102;115;74;72;74;132;99;77 23:20:51 INFO - PROCESS | 12484 | |4;audio-oscillator;93;92;147;94;93;93;150;93;92;151 23:20:51 INFO - PROCESS | 12484 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;119 23:20:51 INFO - PROCESS | 12484 | |6;imaging-darkroom;146;146;146;145;146;145;144;146;145;145 23:20:51 INFO - PROCESS | 12484 | |7;imaging-desaturate;95;95;94;95;95;96;96;96;94;95 23:20:51 INFO - PROCESS | 12484 | |8;json-parse-financial;57;55;55;55;55;55;56;82;52;53 23:20:51 INFO - PROCESS | 12484 | |9;json-stringify-tinderbox;61;62;60;61;61;61;61;61;61;62 23:20:51 INFO - PROCESS | 12484 | |10;stanford-crypto-aes;76;76;76;76;83;79;78;77;80;86 23:20:51 INFO - PROCESS | 12484 | |11;stanford-crypto-ccm;127;126;124;121;120;119;123;122;156;122 23:20:51 INFO - PROCESS | 12484 | |12;stanford-crypto-pbkdf2;172;168;163;166;165;167;165;164;164;165 23:20:51 INFO - PROCESS | 12484 | |13;stanford-crypto-sha256-iterative;68;67;69;69;71;72;67;68;66;66 23:20:51 INFO - PROCESS | 12484 | __end_tp_report 23:20:51 INFO - PROCESS | 12484 | __start_cc_report 23:20:51 INFO - PROCESS | 12484 | _x_x_mozilla_cycle_collect,1629 23:20:51 INFO - PROCESS | 12484 | __end_cc_report 23:20:51 INFO - PROCESS | 12484 | __startTimestamp1460787651047__endTimestamp 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | ------- Summary: start ------- 23:20:51 INFO - PROCESS | 12484 | Number of tests: 14 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.78 (3.4%) stddev-sans-first:3.96 23:20:51 INFO - PROCESS | 12484 | Values: 112.0 111.0 107.0 114.0 113.0 111.0 101.0 112.0 112.0 111.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:157.00 stddev:25.46 (16.2%) stddev-sans-first:26.99 23:20:51 INFO - PROCESS | 12484 | Values: 155.0 129.0 160.0 193.0 125.0 159.0 151.0 132.0 195.0 129.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 23:20:51 INFO - PROCESS | 12484 | Values: 162.0 161.0 161.0 162.0 161.0 159.0 162.0 163.0 161.0 162.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#3] audio-fft Cycles:10 Average:89.30 Median:74.00 stddev:21.42 (28.9%) stddev-sans-first:22.08 23:20:51 INFO - PROCESS | 12484 | Values: 75.0 73.0 102.0 115.0 74.0 72.0 74.0 132.0 99.0 77.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.00 stddev:27.30 (29.4%) stddev-sans-first:28.28 23:20:51 INFO - PROCESS | 12484 | Values: 93.0 92.0 147.0 94.0 93.0 93.0 150.0 93.0 92.0 151.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 23:20:51 INFO - PROCESS | 12484 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 23:20:51 INFO - PROCESS | 12484 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 144.0 146.0 145.0 145.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 23:20:51 INFO - PROCESS | 12484 | Values: 95.0 95.0 94.0 95.0 95.0 96.0 96.0 96.0 94.0 95.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:55.00 stddev:8.72 (15.9%) stddev-sans-first:9.25 23:20:51 INFO - PROCESS | 12484 | Values: 57.0 55.0 55.0 55.0 55.0 55.0 56.0 82.0 52.0 53.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 23:20:51 INFO - PROCESS | 12484 | Values: 61.0 62.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.50 stddev:3.43 (4.4%) stddev-sans-first:3.50 23:20:51 INFO - PROCESS | 12484 | Values: 76.0 76.0 76.0 76.0 83.0 79.0 78.0 77.0 80.0 86.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:123.50 stddev:10.83 (8.8%) stddev-sans-first:11.48 23:20:51 INFO - PROCESS | 12484 | Values: 127.0 126.0 124.0 121.0 120.0 119.0 123.0 122.0 156.0 122.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:165.50 stddev:2.60 (1.6%) stddev-sans-first:1.56 23:20:51 INFO - PROCESS | 12484 | Values: 172.0 168.0 163.0 166.0 165.0 167.0 165.0 164.0 164.0 165.0 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - PROCESS | 12484 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.00 (2.9%) stddev-sans-first:2.12 23:20:51 INFO - PROCESS | 12484 | Values: 68.0 67.0 69.0 69.0 71.0 72.0 67.0 68.0 66.0 66.0 23:20:51 INFO - PROCESS | 12484 | -------- Summary: end -------- 23:20:51 INFO - PROCESS | 12484 | 23:20:51 INFO - TEST-INFO | 12484: exit 0 23:20:51 INFO - TEST-OK | kraken | took 60500ms 23:20:51 INFO - SUITE-END | took 1171s 23:20:52 INFO - Completed test suite (00:19:32) 23:20:52 INFO - javascript benchmark 23:20:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2994.341244926116, 3056.5262384330435, 3099.5660607514938, 3103.7982531135476, 3130.5773720547727, 5135.255387968742, 5208.401033881105, 5243.737813109344, 5279.0, 5317.707526086068, 5301.3108295921575, 5314.415414304433, 5316.0962636351815, 5330.573554115671, 5339.706316152619, 4592.288195329729, 4636.142313671973, 4845.37010188675, 4859.562639362457, 4895.192293271606, 4741.478437371887, 4819.0602832447685, 4847.587955023827, 4852.199387101124, 4853.708777473345, 4737.573618374346, 4783.210770222909, 4784.497627749071, 4785.95214047862, 4794.9520504794855, 4674.789634466457, 4675.485696573374, 4677.602403795681, 4700.224462963607, 4712.670113092085, 4649.442066951988, 4664.650151238637, 4682.742449165295, 4717.858464246078, 4775.976120119377, 5054.494550544953, 5070.29015937769, 5071.467495912912, 5112.897742045138, 5132.717700526469, 5415.268938693304, 5440.4287549807495, 5441.401445840955, 5465.617406781487, 5487.478689524489, 5481.808136715196, 5521.116621340607, 5572.498475137217, 5661.801836935688, 5731.312242530881, 5258.8159414420315, 5260.0531904257605, 5262.394824595144, 5265.104932161504, 5301.761420736076, 5709.200711900337, 5710.857228569319, 5712.714364281853, 5712.942870571241, 5734.139879018097, 5297.390800058042, 5347.224652425454, 5405.837824865261, 5423.511883930465, 5515.586331025189, 5539.390667026624, 5543.1685247213245, 5543.390227075019, 5550.417206193372, 5553.750081246354, 5493.917591236055, 5508.091164957817, 5509.614326997072, 5513.117901135799, 5565.16522521625, 5530.640508366943, 5537.640053396516, 5570.972145139248, 5579.525740312119, 5621.156826476062, 4204.0, 4235.174141042467, 4236.915261694749, 4239.915201696011, 4270.679699022586, 3767.698584113264, 3788.924221515554, 3799.8290076946605, 3817.4655548222718, 3838.5201849768778, 5345.251664766935, 5371.194320851825, 5405.243265942771, 5408.891822163535, 5420.4850539198715, 5608.887822243532, 5665.008623490872, 5666.688332141689, 5671.773129074873, 5675.290588676416, 5299.6290259681455, 5305.1776974569, 5307.761150748149, 5326.5206131447585, 5408.45915408456, 4456.153330867125, 4697.365855609517, 4761.119192949315, 4786.928196077061, 4789.066132104206, 5759.625624334405, 5768.048272035151, 5773.451522105393, 5773.711314434261, 5777.075667893201, 5582.637128586629, 5583.69289689071, 5586.608937374507, 5586.86032849182, 5589.5807814413265, 5586.972065139648, 5607.691576963143, 5633.521150702072, 5682.715864206691, 5699.2590963174525, 5437.483439073281, 5462.317210348707, 5467.261919640798, 5471.671699698031, 5478.945210548003, 5528.474794894479, 5546.861328466821, 5547.2511210986, 5561.5272701820795, 5593.608447408642, 5396.271503347155, 5498.120300751861, 5529.30883639545, 5530.557555395479, 5541.3904470509015, 5268.81559145428, 5271.71005594696, 5276.498732620395, 5283.5773138149625, 5294.470552944675, 5190.532852043334, 5193.987172501477, 5196.298499702643, 5245.449227831023, 5271.051210782096, 5324.920126198188, 5359.356877174764, 5362.276092727432, 5402.324709411324, 5406.0, 5142.742862856917, 5225.477452254744, 5226.268322434938, 5232.136697444879, 5288.762005709676], "value": 5121.574856191858, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.3110578363801, 650.2359727320397, 655.2301046270633, 659.0608383054148, 663.0419044480727, 29347.0, 29891.701082989162, 37093.629063709355, 37648.623513764855, 38012.809935950354, 40113.398299025466, 40851.79574102133, 40904.59095409045, 40919.181616367656, 40920.0, 8175.059868115153, 8366.665333386687, 8376.958115209445, 8378.245957863792, 8384.8742268866, 8448.23965843074, 8578.18507241811, 8578.656853725843, 8579.142085791402, 8579.399442039059, 8765.386422950396, 8851.513166775858, 8860.734177974638, 8861.556922153899, 8862.33532485063, 8717.7820554486, 8804.515751633657, 8824.691135810215, 8829.646814127427, 8831.381803273742, 8669.523176225304, 8775.0, 8783.47299162046, 8784.0, 8788.077251888588, 39905.201895961916, 40318.39522407137, 40352.39471407931, 40489.39265910984, 40533.18933621311, 3116.2676770958806, 3253.235489659928, 3261.6901394367496, 3326.617438994522, 3329.101142691484, 30034.549481757793, 30194.69805301941, 30628.387432251453, 30980.845095774603, 31078.0, 4228.6617070634275, 4259.339802330644, 4321.6326612238, 4344.956550434486, 4362.585554372329, 248352.0, 250294.0, 250983.0, 251458.0, 251854.0, 57323.0, 57719.0, 60118.69940650269, 60247.39752602505, 60816.69591652013, 68171.18288171242, 69223.0, 69500.30499694939, 69567.30432695709, 69643.30356696469, 15495.14776687293, 15560.299786509635, 15663.530094097196, 15778.289976951064, 15818.288177032062, 11509.48207330672, 12054.156209065457, 12410.317432541116, 12516.687082823002, 12519.43662535188, 20143.39569812908, 20302.796972030384, 20483.28308509195, 20634.58730825375, 20829.791702082784, 7216.0, 7275.818104547428, 7410.333070023724, 7457.589832559262, 7675.53946763196, 978.6623614852864, 1051.2588625019343, 1108.5454963465102, 1117.234694234452, 1221.9022478201723, 32362.190945226557, 32462.675373245966, 32561.674383256337, 33039.50440743391, 33487.66512334894, 1095.3865835132192, 1122.6968718445974, 1169.7368092179192, 1170.9414529273502, 1196.347990345264, 16984.40554580584, 17191.914040429718, 17317.7402338965, 17325.826741732675, 17545.385911493035, 483002.0, 490446.0, 490628.0, 491733.0, 495204.0, 56326.0, 57277.713611431675, 57295.713521432124, 57343.13985290224, 57359.0, 1219.030870457988, 1367.5760514240617, 1393.665520275147, 1404.4171668757351, 1413.0603148906068, 28520.85739571372, 29544.409111817215, 29651.851740742022, 30105.397892041598, 31384.372312553165, 46221.0, 46334.53665463437, 46677.29984050174, 46704.0, 46799.06401872011, 289913.0, 289925.0, 290284.0, 291975.0, 293064.0, 37187.88436346914, 42535.787321063195, 43570.782146090336, 43641.0, 45400.0, 45281.54718452905, 45672.0, 45934.997832596535, 46442.0, 46523.534764653275, 38849.0, 38903.41644875272, 39256.0, 39309.80345098256, 40392.596074038884, 39282.214355713295, 39816.60183398129, 39932.40101398539, 39994.40008399818, 40290.59709402986, 40019.39970900497, 40245.59754402535, 40546.59453405546, 40636.79681601691, 40704.796476018615, 28448.57327140053, 30366.240843979078, 30404.69595304107, 30440.695593043787, 30761.0, 26927.0, 27249.0, 27564.86217568899, 27597.724022759514, 27780.44439111247], "value": 19461.44540317797, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.5622930432568, 396.8095314249162, 398.5595916512252, 407.89394757363095, 409.234731052931, 14023.509177178801, 14344.426222951095, 16840.24218910149, 17785.64428711425, 17830.375936842214, 11284.379359135244, 11803.645890623273, 17741.201645925932, 18113.547161320974, 18128.274869005258, 5019.171836646958, 5100.183970564692, 5142.177251639739, 5146.819861304855, 5168.741562921858, 5129.640925135223, 5138.794448222066, 5645.887082258352, 5657.23627310314, 5688.772449102031, 5627.493525582697, 5629.099344104944, 5638.069718496464, 5640.661560306375, 5650.604457687963, 5384.542313903323, 5688.203651488795, 5688.5733569982, 5708.600397972144, 5729.369769325371, 5454.263674403945, 5460.945390546083, 5464.863378415532, 5466.0, 5469.589780766459, 12273.509059637603, 13068.411921463558, 13073.0, 13148.40832162555, 13150.276734779583, 2336.4509340305017, 2523.823332366735, 2580.096966061882, 2652.4591958054048, 2772.50094982903, 9660.37207581505, 9702.61189552417, 9885.406875587487, 9935.105840474393, 10301.124404425633, 1772.2113659421564, 1865.2445759467437, 1871.9891258720274, 1875.3215871794666, 1903.3718872771951, 72412.0, 74219.25780742231, 74746.25253747447, 76617.0, 76916.99999999945, 10811.675649730521, 10904.182186336056, 10940.890591093987, 10982.341059536293, 11183.0, 15343.309551070228, 15352.462663806713, 15414.229288535753, 15485.612859678373, 15533.301001454962, 7792.259735325135, 7969.681212751425, 7980.401469889665, 8047.83904321922, 8049.718259860877, 7510.586917719578, 7522.252632098013, 7522.6614802334025, 7619.695212191561, 7662.540247585162, 4664.207084795593, 4682.321063445781, 4731.526847315241, 4798.136335459651, 4842.15262329091, 1903.3718872771951, 1931.65230258552, 1935.9806401936082, 1960.578475627747, 1991.5220347116588, 935.7754139006589, 983.5918093991056, 1034.4310629153936, 1062.744941214103, 1084.3331351219101, 18584.628307434046, 18672.719909201373, 19001.42995710131, 19028.429147125607, 19358.322458713876, 976.9120779129912, 987.3187500624546, 1001.1890368801294, 1006.7080546641392, 1104.2546281260118, 10225.948870255601, 10613.257072004886, 10760.0, 10814.188935829687, 10827.891721082846, 172488.0, 507619.0, 530661.0, 535725.0, 539761.0, 86815.0, 90430.54784726034, 91920.54039729759, 91992.0, 92734.0, 1054.8470471781702, 1071.7320669832543, 1104.0780947908427, 1104.1773878460438, 1111.3054341036852, 16449.83550164531, 16782.58043548921, 16844.242009109374, 17007.574810629834, 17277.56806079858, 37655.435168471944, 37865.242695146495, 38513.614863852126, 38657.0, 38924.80537597294, 49332.2600161005, 51872.221916670525, 52197.33272039589, 53111.20333195083, 54497.0, 8283.461574997606, 8296.502209867427, 8373.413861029669, 8408.83182336362, 8522.232999030117, 13005.869941300843, 13021.414036368576, 13073.084884058024, 13262.602121936357, 13596.11625244356, 10969.780604387708, 11558.826617600575, 11654.88345116538, 11695.473703683185, 11861.0, 7526.962365188139, 7570.712978793728, 11483.311001339946, 11487.195896287514, 11611.6516504505, 11672.241304315192, 11721.531138754355, 11824.231424957694, 11962.34207118582, 11976.401179941142, 8194.139615340542, 8265.256126948603, 8442.41260008229, 8449.915500844912, 8460.153984601737, 10990.835137473105, 11113.0, 11445.713857153638, 11684.649460516199, 11699.181057325906], "value": 8788.399946297555, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1143.0284258380373, 1511.4634304821784, 1521.2165734646655, 1657.635320229549, 1779.2438213759149, 7775.650095745691, 8005.1994800519915, 8048.074471435772, 8057.1539988301265, 8059.032916050068, 7949.165337639552, 7950.64222110005, 7996.520208787477, 8005.999250093738, 8016.759497215078, 2026.2705426046612, 2161.211157927357, 2200.328899685603, 2200.933971980843, 2216.8780717060554, 2335.824813139013, 2362.2676970139228, 2363.0429675981254, 2364.858108513486, 2364.9948771772015, 2289.8511596746243, 2294.105298933417, 2324.2097686786487, 2328.1851352026824, 2329.9184528541505, 1984.7519060117486, 2047.9043711614363, 2146.1200907627954, 2208.823294136473, 2217.157480157546, 2224.1992882562263, 2240.6975058367075, 2245.955080898389, 2247.449374903159, 2248.6402175651815, 8188.959055204686, 8204.630791614392, 8262.710805121853, 8264.380171487102, 8264.917350826476, 5026.0, 5147.845564633029, 5177.326947496839, 5178.197379406198, 5194.71429071401, 3219.5492631031675, 3285.474324108155, 3399.456087026064, 3411.3177364527196, 3421.1105112670634, 1100.0759362135764, 1111.183280288987, 1116.9273997190157, 1124.3759713359163, 1126.0766171739176, 11976.461059252355, 11978.281303121754, 11990.940045299805, 12022.819657705142, 12031.57889473873, 4654.488006319302, 4664.930026049612, 4819.373481447389, 4824.782884770194, 4844.806207751721, 8989.730308090768, 9009.324300677476, 9027.50348730826, 9055.81888362229, 9064.909350906539, 5192.039472697563, 5199.610029247821, 5208.895822083613, 5233.555147812479, 5233.790648374099, 4309.439772829513, 4658.1848176568965, 4718.787654555554, 4726.740029298421, 4728.952710472851, 3763.247350529905, 3766.6610005099674, 3810.942835857464, 3841.615838416136, 3902.824372903226, 1155.8266260061057, 1164.2723297938787, 1180.2741314091943, 1180.6576092932953, 1189.4766302826729, 907.682311191091, 907.945523268606, 926.305271046715, 953.7091187187835, 958.3148049144895, 5441.156620723794, 5765.365809760923, 5791.391903850035, 5874.733880212578, 5881.941180588225, 410.15712710380456, 432.06889153873453, 434.23574508864624, 445.6768842589097, 448.48648297699606, 3876.379779235309, 3905.6484916357663, 3932.7640341579595, 3985.4818873546255, 4040.2323558523785, 10480.109190718722, 10850.29473084247, 10955.780884382428, 10968.396738179317, 10984.615538456115, 10713.089387402159, 10776.29954052984, 10799.946000269949, 10861.456927153611, 10990.230683852054, 7513.586752728653, 7798.298153166243, 7833.529988200727, 7858.174891636296, 8008.27925486709, 5580.441955804549, 5659.207710920557, 5702.714864256854, 5713.257276554022, 5875.853103672443, 9871.605135794487, 9914.950425247827, 9948.403095814274, 10132.797344053226, 10147.695569132939, 9780.119789219005, 10104.797904042025, 10211.7447063824, 10247.487625618838, 10366.792664146826, 6398.968005159944, 6597.736090556324, 6762.898556521558, 7144.0, 7220.241874603091, 8236.629351679308, 8246.463979841292, 8299.29455996247, 8315.334773218248, 8334.083250842525, 7078.256783037707, 7188.8921666174, 7342.5227360221415, 7368.263173682589, 7386.0, 7323.560586364835, 7336.96331518339, 7358.080239970004, 7369.336759691653, 7404.407647388089, 6653.367930046637, 6671.266160722414, 6722.0, 6724.529282950147, 6735.124433823572, 4916.287138364989, 4916.852494425173, 4951.455339912534, 5089.821856235014, 5202.765875535686, 5061.342025536656, 5178.97410512945, 5180.119379705535, 5202.3497062867145, 5299.49654782795], "value": 4379.9718868761365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.47082911321866, 339.2841105267885, 341.3514322786705, 344.0092533503511, 344.36464722586817, 5379.300690910186, 5407.783688652459, 5463.535599474045, 5529.474699903508, 5572.498475137242, 5379.300690910186, 5410.323709536308, 5502.477264659861, 5514.531264842493, 5523.751431185597, 4269.402283680295, 4294.849680261192, 4303.462067241595, 4306.2033523798045, 4319.50325712544, 3963.54419241788, 4158.625723684868, 4296.205202037618, 4301.419308393358, 4322.84870029549, 4243.151369726052, 4272.46594175728, 4277.14457108578, 4283.528811830696, 4284.700070995032, 4260.893477663052, 4273.572642735733, 4282.516140638422, 4282.914341713179, 4282.993496528314, 3681.7790932544135, 3789.147441825595, 3798.7720736755605, 3801.353769859131, 3815.0, 5242.449542798027, 5301.973490132525, 5316.431652662473, 5341.412444631087, 5347.358317001946, 4906.1414252505665, 4911.361523001987, 4923.483034281385, 4928.827491037797, 4931.556159945586, 5526.640768350045, 5765.1928729977835, 5779.190913272145, 5786.392428794958, 5790.884182316372, 4133.648639865615, 4144.274751918432, 4155.319818716941, 4164.312888373414, 4175.248455278049, 5953.077273022688, 6014.8496287592725, 6033.245844269466, 6038.33578306386, 6060.939390606081, 4111.075008123148, 4337.414449049401, 4345.196138714348, 4347.413099231627, 4356.564343565618, 4358.259095953696, 4366.8034938427845, 4388.253996820548, 4389.934150987738, 4396.868093957187, 4950.727709975986, 4952.529509696573, 4956.256561515729, 4961.156603377434, 4972.65191436596, 5538.778448862081, 5847.590668653239, 5865.560082993792, 5866.472017518444, 5872.060470324727, 1419.9077059991068, 1455.978160327596, 1457.890658200639, 1482.0588926032046, 1515.1742300446283, 1029.3463650581784, 1042.7497400623947, 1046.387863100095, 1049.5591851422269, 1061.3207547169818, 5540.556755459554, 5550.084236100998, 5556.805511807148, 5558.777648893999, 5567.359753628303, 5874.471297583238, 5894.734736936848, 5905.379935106838, 5913.467787899023, 5931.881362372815, 5386.8383948481605, 5540.252065971043, 5550.611457198038, 5586.385497595261, 5609.775608975677, 3126.343467871772, 3135.984320078385, 3144.7515026755977, 3157.163351711798, 3160.9367812644077, 5940.495057920125, 6071.51427885768, 6102.420270074336, 6111.0, 6123.601965872204, 5946.483646670072, 6016.1878146450545, 6034.125051867454, 6046.395360464006, 6052.57631965767, 6087.117367981707, 6102.511799056065, 6130.63216207029, 6132.448079672851, 6135.417135372132, 5748.712564371681, 5902.793402230901, 5905.379935106752, 5940.46535811779, 5949.0, 5845.941540584539, 5849.415058494116, 5866.504041469398, 5866.67733274674, 5875.0, 5879.265091863517, 5992.670403127696, 6141.723622436912, 6146.323904370426, 6167.321594624498, 4281.1651727914, 4287.3140297552245, 4288.120935208337, 4290.871273861789, 4309.159713855768, 5673.74468148926, 5868.3251426086545, 5896.941030589811, 5898.1152827076285, 5909.85225369352, 5637.689927054052, 5802.65184088956, 5855.238818953509, 5855.531557475477, 5875.20684707559, 5786.0, 5787.768489260551, 5810.215620891126, 5818.650880947157, 5847.44449277318, 5456.372517160577, 5665.773369065191, 5669.4047125051275, 5692.715364231854, 5736.397678243724, 5835.56233282514, 5838.357780644211, 5865.354810970704, 5873.882522349614, 5881.264841894763, 5526.336839579276, 5752.599261564823, 5765.740541675718, 5766.913496297475, 5793.362730099601], "value": 4418.190678159977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2460027672189, 751.9248075192481, 780.8594452998458, 785.7014334552869, 803.7106641609022, 13180.670483237924, 13194.53819116331, 13271.270080145589, 13302.866971330295, 13349.0, 13080.803787943189, 13213.933930330359, 13251.867481325184, 13259.469621215165, 13283.601491955233, 519.4545726986668, 818.8976377952756, 834.4576025583359, 836.3225787112428, 836.4395854777299, 825.4675734151468, 832.1886160993043, 832.6003518311214, 832.862577674686, 839.4249938791947, 885.1458342699294, 885.2210055151457, 885.8405487012335, 886.4061079077002, 892.0499667853715, 544.6187668631953, 858.4420126917491, 868.9956550217272, 870.3646338173169, 876.3033388456192, 638.2373064188297, 640.734095350429, 643.6170478565247, 646.7865604350553, 649.6589290622413, 13179.406926688227, 13193.538226162134, 13229.140105893086, 13248.20510769357, 13272.402741876542, 12179.695507612292, 12267.141300108997, 12420.937895310466, 12527.937360313232, 12710.42803073864, 10395.32430392022, 10426.947865260625, 10443.738906527322, 10478.63324783629, 10964.506597203144, 3700.4868800468334, 3764.0, 3771.41543060826, 3836.156045669948, 3867.9613203867884, 55367.0, 55731.72134139304, 58390.70804645992, 58914.41085589132, 58961.41038589645, 10703.090237329914, 10743.731406714895, 10797.56809727602, 10922.672319830417, 10946.945265273622, 20531.28140515075, 20556.58886822285, 20627.0, 20670.379888603366, 20684.58630827375, 8102.270795628422, 8271.13153118926, 8339.166083391734, 8439.282660973764, 8595.5702214889, 4584.312353147055, 4624.930626040612, 4630.513796051433, 4633.467151277646, 4800.975995120002, 3140.7016333448287, 3234.110619579634, 3234.530993006001, 3243.918902027421, 3267.379197952381, 501.372806493969, 553.0266730554254, 565.191775760658, 592.3602509289957, 627.2942939193407, 608.2609629300333, 667.679513833353, 672.525869262169, 710.1584622222682, 710.4423027923056, 8938.86591701125, 8976.147266009719, 9445.291603129794, 9567.330286879851, 9577.090176433228, 683.1835956032593, 694.5867209010731, 703.2826516952782, 708.6598432752307, 718.7304760714732, 4487.88780280489, 4524.7285162889675, 4540.273556231054, 4540.318952157137, 4583.106294272585, 52508.21237681438, 53524.464755352725, 54116.0, 54284.72857635766, 69352.65323673349, 52358.21462678063, 52846.47153528415, 52896.0, 53687.89964953323, 53829.73085134628, 46821.29768053482, 47377.05245895063, 48522.75738621284, 48719.75640121777, 49527.50472495301, 8610.61252243638, 8759.905011873516, 8899.644014239617, 8979.865302020344, 9172.375338537455, 33824.15439613931, 34089.147771305914, 34840.65159348374, 34845.303093938484, 35519.82240088783, 43376.0, 47936.28095578499, 48019.51980480151, 48504.27243591278, 49225.507744923525, 11567.248128871597, 11696.70758231051, 11751.471183796579, 11968.102392320785, 12054.638360849189, 12947.611571652866, 12951.805722913976, 13040.54358097462, 13058.673533161747, 13126.671833204246, 12232.388380581113, 12276.32480213561, 12573.245605263714, 12580.748385032432, 12626.810597841224, 12162.574309899112, 12274.509019639114, 12690.746185076432, 12934.288614125937, 12975.870241297465, 12281.140320177501, 12283.38583070825, 12714.237145771283, 12802.935985320013, 12819.0, 10295.236910831985, 10300.948495257475, 10367.222458315808, 10532.789344213226, 10695.304805187638, 10710.250282480152, 10714.303570267908, 10761.30051546647, 10774.461276935965, 10905.34567925927], "value": 6616.125835954255, "unit": "score"}], "name": "dromaeo_css", "value": 6944.517203344844, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 107.0, 114.0, 113.0, 111.0, 101.0, 112.0, 112.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 160.0, 193.0, 125.0, 159.0, 151.0, 132.0, 195.0, 129.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 159.0, 162.0, 163.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 102.0, 115.0, 74.0, 72.0, 74.0, 132.0, 99.0, 77.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 147.0, 94.0, 93.0, 93.0, 150.0, 93.0, 92.0, 151.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 144.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 96.0, 96.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 82.0, 52.0, 53.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 83.0, 79.0, 78.0, 77.0, 80.0, 86.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 124.0, 121.0, 120.0, 119.0, 123.0, 122.0, 156.0, 122.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 163.0, 166.0, 165.0, 167.0, 165.0, 164.0, 164.0, 165.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 69.0, 71.0, 72.0, 67.0, 68.0, 66.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1538.9, "alertThreshold": 2.0}]} 23:20:52 INFO - Return code: 0 23:20:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:20:52 ERROR - # TBPL SUCCESS # 23:20:52 INFO - Running post-action listener: _resource_record_post_action 23:20:52 INFO - Running post-run listener: _resource_record_post_run 23:20:53 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536195072; Read time: 8; Write time: 482568 23:20:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244080640; Read time: 0; Write time: 245496 23:20:53 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292114432; Read time: 8; Write time: 237072 23:20:53 INFO - Running post-run listener: _upload_blobber_files 23:20:53 INFO - Blob upload gear active. 23:20:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:20:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:20:53 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:20:53 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:20:53 INFO - (blobuploader) - INFO - Open directory for files ... 23:20:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:20:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:20:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:20:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:20:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:20:54 INFO - (blobuploader) - INFO - Done attempting. 23:20:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:20:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:20:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:20:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:20:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:20:55 INFO - (blobuploader) - INFO - Done attempting. 23:20:55 INFO - (blobuploader) - INFO - Iteration through files over. 23:20:55 INFO - Return code: 0 23:20:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:20:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:20:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97b5821fde9f4398df804c4e3246a7903da4dde106871170004c11953da7c955752d6d7db4b7521d428c166053c73f1c56a6b7b6ad5355ede3168863c4a5a4a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82ba39394fce658d7331d50c37c0044c627039c600b42ca07f2fd9da3411137e6a018b55b50105705af8a0ac6639c438fd9185fc5a91cdfa754ad3e23ee395a5"} 23:20:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:20:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:20:55 INFO - Contents: 23:20:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97b5821fde9f4398df804c4e3246a7903da4dde106871170004c11953da7c955752d6d7db4b7521d428c166053c73f1c56a6b7b6ad5355ede3168863c4a5a4a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82ba39394fce658d7331d50c37c0044c627039c600b42ca07f2fd9da3411137e6a018b55b50105705af8a0ac6639c438fd9185fc5a91cdfa754ad3e23ee395a5"} 23:20:55 INFO - Running post-run listener: copy_logs_to_upload_dir 23:20:55 INFO - Copying logs to upload dir... 23:20:55 INFO - mkdir: /builds/slave/test/build/upload/logs 23:20:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.999371 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-15 23:20:54.506358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 23:20:54.509641) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97b5821fde9f4398df804c4e3246a7903da4dde106871170004c11953da7c955752d6d7db4b7521d428c166053c73f1c56a6b7b6ad5355ede3168863c4a5a4a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82ba39394fce658d7331d50c37c0044c627039c600b42ca07f2fd9da3411137e6a018b55b50105705af8a0ac6639c438fd9185fc5a91cdfa754ad3e23ee395a5"} build_url:https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/dYf2KNaYQqORKNmhDNWifA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97b5821fde9f4398df804c4e3246a7903da4dde106871170004c11953da7c955752d6d7db4b7521d428c166053c73f1c56a6b7b6ad5355ede3168863c4a5a4a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82ba39394fce658d7331d50c37c0044c627039c600b42ca07f2fd9da3411137e6a018b55b50105705af8a0ac6639c438fd9185fc5a91cdfa754ad3e23ee395a5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 23:20:54.542566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:20:54.543403) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1460778681.968709-127494272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 23:20:54.624979) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 23:20:54.625731) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 23:20:54.626470) ========= ========= Total master_lag: 0.17 =========