builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1461845527.95 results: success (0) buildid: 20160428023032 builduid: 67a8eaa1d4c8492389f8efa4482b7e3d revision: 53765e008b97622b5c7e26d22b2db016b0e53dc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:07.948362) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:07.948804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:07.949135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:07.980993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:07.981358) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 05:12:08-- 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% 211M=0s 2016-04-28 05:12:08 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095450 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.091348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.092793) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016814 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.144492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.144811) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 53765e008b97622b5c7e26d22b2db016b0e53dc1 --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 53765e008b97622b5c7e26d22b2db016b0e53dc1 --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=aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 05:12:08,302 truncating revision to first 12 chars 2016-04-28 05:12:08,302 Setting DEBUG logging. 2016-04-28 05:12:08,302 attempt 1/10 2016-04-28 05:12:08,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/53765e008b97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 05:12:08,550 unpacking tar archive at: fx-team-53765e008b97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.697261) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.697569) ========= script_repo_revision: 53765e008b97622b5c7e26d22b2db016b0e53dc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.697988) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.698256) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:08.707276) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-28 05:12:08.707551) ========= /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=aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:12:08 INFO - MultiFileLogger online at 20160428 05:12:08 in /builds/slave/test 05:12:08 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 05:12:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:12:08 INFO - {'append_to_log': False, 05:12:08 INFO - 'base_work_dir': '/builds/slave/test', 05:12:08 INFO - 'blob_upload_branch': 'Fx-Team', 05:12:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:12:08 INFO - 'branch': 'Fx-Team', 05:12:08 INFO - 'buildbot_json_path': 'buildprops.json', 05:12:08 INFO - 'config_files': ('talos/linux_config.py',), 05:12:08 INFO - 'default_actions': ('clobber', 05:12:08 INFO - 'read-buildbot-config', 05:12:08 INFO - 'download-and-extract', 05:12:08 INFO - 'populate-webroot', 05:12:08 INFO - 'create-virtualenv', 05:12:08 INFO - 'install', 05:12:08 INFO - 'run-tests'), 05:12:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:12:08 INFO - 'download_minidump_stackwalk': True, 05:12:08 INFO - 'download_symbols': 'ondemand', 05:12:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:12:08 INFO - 'tooltool.py': '/tools/tooltool.py', 05:12:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:12:08 INFO - '/tools/misc-python/virtualenv.py')}, 05:12:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:12:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:12:08 INFO - 'installer_path': 'installer.exe', 05:12:08 INFO - 'log_level': 'info', 05:12:08 INFO - 'log_name': 'talos', 05:12:08 INFO - 'log_to_console': True, 05:12:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:12:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:12:08 INFO - 'opt_config_files': (), 05:12:08 INFO - 'pip_index': False, 05:12:08 INFO - 'sps_profile': False, 05:12:08 INFO - 'sps_profile_interval': 0, 05:12:08 INFO - 'suite': 'dromaeojs', 05:12:08 INFO - 'system_bits': '32', 05:12:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:12:08 INFO - 'title': 'talos-linux64-ix-037', 05:12:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:12:08 INFO - 'use_talos_json': True, 05:12:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:12:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:12:08 INFO - 'work_dir': 'build'} 05:12:08 INFO - ##### 05:12:08 INFO - ##### Running clobber step. 05:12:08 INFO - ##### 05:12:08 INFO - Running pre-action listener: _resource_record_pre_action 05:12:08 INFO - Running main action method: clobber 05:12:08 INFO - rmtree: /builds/slave/test/build 05:12:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:12:09 INFO - Running post-action listener: _resource_record_post_action 05:12:09 INFO - ##### 05:12:09 INFO - ##### Running read-buildbot-config step. 05:12:09 INFO - ##### 05:12:09 INFO - Running pre-action listener: _resource_record_pre_action 05:12:09 INFO - Running main action method: read_buildbot_config 05:12:09 INFO - Using buildbot properties: 05:12:09 INFO - { 05:12:09 INFO - "project": "", 05:12:09 INFO - "product": "firefox", 05:12:09 INFO - "script_repo_revision": "production", 05:12:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:12:09 INFO - "repository": "", 05:12:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:12:09 INFO - "buildid": "20160428023032", 05:12:09 INFO - "pgo_build": "True", 05:12:09 INFO - "basedir": "/builds/slave/test", 05:12:09 INFO - "buildnumber": 619, 05:12:09 INFO - "slavename": "talos-linux64-ix-037", 05:12:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:12:09 INFO - "platform": "ubuntu64_hw", 05:12:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:12:09 INFO - "branch": "fx-team", 05:12:09 INFO - "repo_path": "integration/fx-team", 05:12:09 INFO - "revision": "53765e008b97622b5c7e26d22b2db016b0e53dc1", 05:12:09 INFO - "stage_platform": "linux64-pgo", 05:12:09 INFO - "builduid": "67a8eaa1d4c8492389f8efa4482b7e3d", 05:12:09 INFO - "slavebuilddir": "test" 05:12:09 INFO - } 05:12:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:12:09 INFO - Running post-action listener: _resource_record_post_action 05:12:09 INFO - ##### 05:12:09 INFO - ##### Running download-and-extract step. 05:12:09 INFO - ##### 05:12:09 INFO - Running pre-action listener: _resource_record_pre_action 05:12:09 INFO - Running main action method: download_and_extract 05:12:09 INFO - mkdir: /builds/slave/test/build/tests 05:12:09 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')]} 05:12:09 INFO - https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:12:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:12:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:12:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:12:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:12:16 INFO - Downloaded 1361 bytes. 05:12:16 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:12:16 INFO - Using the following test package requirements: 05:12:16 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:16 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:12:16 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:12:16 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:16 INFO - u'jsshell-linux-x86_64.zip'], 05:12:16 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:12:16 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:16 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:12:16 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:12:16 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:12:16 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:12:16 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:16 INFO - https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:12:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:12:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:12:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:12:26 INFO - Downloaded 23865705 bytes. 05:12:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:12:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:12:27 INFO - Return code: 0 05:12:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:27 INFO - https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:12:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:12:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:12:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:12:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:12:35 INFO - Downloaded 23865705 bytes. 05:12:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:12:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:12:36 INFO - Return code: 0 05:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:36 INFO - https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:12:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:12:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:12:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:12:37 INFO - Downloaded 10840145 bytes. 05:12:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:12:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:12:37 INFO - Return code: 0 05:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:37 INFO - https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:12:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:12:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:12:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:12:39 INFO - Downloaded 58384183 bytes. 05:12:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:12:39 INFO - mkdir: /builds/slave/test/properties 05:12:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:12:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:12:39 INFO - Contents: 05:12:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:12:40 INFO - Running post-action listener: _resource_record_post_action 05:12:40 INFO - Running post-action listener: set_extra_try_arguments 05:12:40 INFO - ##### 05:12:40 INFO - ##### Running populate-webroot step. 05:12:40 INFO - ##### 05:12:40 INFO - Running pre-action listener: _resource_record_pre_action 05:12:40 INFO - Running main action method: populate_webroot 05:12:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:12:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:12:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:12:40 INFO - '--tppagecycles', 05:12:40 INFO - '7'], 05:12:40 INFO - 'tests': ['tsvgm']}}, 05:12:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:12:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:12:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:12:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:12:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:12:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:12:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:40 INFO - 'talos_options': ['--disable-e10s'], 05:12:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:40 INFO - 'talos_options': ['--disable-e10s'], 05:12:40 INFO - 'tests': ['damp', 'tps']}, 05:12:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:40 INFO - 'tests': ['damp', 'tps']}, 05:12:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:12:40 INFO - 'tests': ['dromaeo_dom']}, 05:12:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:12:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:12:40 INFO - 'tests': ['a11yr', 05:12:40 INFO - 'ts_paint', 05:12:40 INFO - 'tpaint', 05:12:40 INFO - 'sessionrestore', 05:12:40 INFO - 'sessionrestore_no_auto_restore', 05:12:40 INFO - 'tabpaint']}, 05:12:40 INFO - 'other-e10s': {'tests': ['a11yr', 05:12:40 INFO - 'ts_paint', 05:12:40 INFO - 'tpaint', 05:12:40 INFO - 'sessionrestore', 05:12:40 INFO - 'sessionrestore_no_auto_restore', 05:12:40 INFO - 'tabpaint']}, 05:12:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:12:40 INFO - 'ts_paint', 05:12:40 INFO - 'tpaint', 05:12:40 INFO - 'sessionrestore', 05:12:40 INFO - 'sessionrestore_no_auto_restore', 05:12:40 INFO - 'tabpaint']}, 05:12:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:12:40 INFO - 'ts_paint', 05:12:40 INFO - 'tpaint', 05:12:40 INFO - 'sessionrestore', 05:12:40 INFO - 'sessionrestore_no_auto_restore', 05:12:40 INFO - 'tabpaint']}, 05:12:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:12:40 INFO - 'tests': ['a11yr', 05:12:40 INFO - 'ts_paint', 05:12:40 INFO - 'tpaint', 05:12:40 INFO - 'sessionrestore', 05:12:40 INFO - 'sessionrestore_no_auto_restore', 05:12:40 INFO - 'tabpaint']}, 05:12:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:12:40 INFO - 'tests': ['a11yr', 05:12:40 INFO - 'ts_paint', 05:12:40 INFO - 'tpaint', 05:12:40 INFO - 'sessionrestore', 05:12:40 INFO - 'sessionrestore_no_auto_restore', 05:12:40 INFO - 'tabpaint']}, 05:12:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:12:40 INFO - 'tests': ['tsvgx', 05:12:40 INFO - 'tsvgr_opacity', 05:12:40 INFO - 'tart', 05:12:40 INFO - 'tscrollx', 05:12:40 INFO - 'cart']}, 05:12:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:12:40 INFO - 'tsvgr_opacity', 05:12:40 INFO - 'tart', 05:12:40 INFO - 'tscrollx', 05:12:40 INFO - 'cart']}, 05:12:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:40 INFO - 'talos_options': ['--disable-e10s'], 05:12:40 INFO - 'tests': ['tp5o']}, 05:12:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:40 INFO - 'tests': ['tp5o']}, 05:12:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:40 INFO - 'talos_options': ['--disable-e10s', 05:12:40 INFO - '--xperf_path', 05:12:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:40 INFO - 'tests': ['tp5n']}, 05:12:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:40 INFO - 'talos_options': ['--xperf_path', 05:12:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:40 INFO - 'tests': ['tp5n']}}, 05:12:40 INFO - 'talos.zip': {'path': '', 05:12:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:12:40 INFO - Running post-action listener: _resource_record_post_action 05:12:40 INFO - ##### 05:12:40 INFO - ##### Running create-virtualenv step. 05:12:40 INFO - ##### 05:12:40 INFO - Running pre-action listener: _resource_record_pre_action 05:12:40 INFO - Running main action method: create_virtualenv 05:12:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:12:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:12:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:12:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:12:40 INFO - Using real prefix '/usr' 05:12:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:12:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:12:43 INFO - Installing pip.................done. 05:12:43 INFO - Return code: 0 05:12:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975d36df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12409a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf810>, '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 0x12d0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0ba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', '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 05:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:12:43 INFO - Using env: {'DISPLAY': ':0', 05:12:43 INFO - 'HOME': '/home/cltbld', 05:12:43 INFO - 'LANG': 'en_US.UTF-8', 05:12:43 INFO - 'LANGUAGE': 'en_US:en', 05:12:43 INFO - 'LOGNAME': 'cltbld', 05:12:43 INFO - 'MAIL': '/var/mail/cltbld', 05:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:43 INFO - 'MOZ_NO_REMOTE': '1', 05:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:43 INFO - 'NO_EM_RESTART': '1', 05:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:43 INFO - 'PWD': '/builds/slave/test', 05:12:43 INFO - 'SHELL': '/bin/bash', 05:12:43 INFO - 'SHLVL': '1', 05:12:43 INFO - 'TERM': 'linux', 05:12:43 INFO - 'TMOUT': '86400', 05:12:43 INFO - 'USER': 'cltbld', 05:12:43 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', 05:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:43 INFO - '_': '/tools/buildbot/bin/python'} 05:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:12:43 INFO - Cleaning up... 05:12:43 INFO - Return code: 0 05:12:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975d36df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12409a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf810>, '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 0x12d0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0ba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', '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 05:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:12:43 INFO - Using env: {'DISPLAY': ':0', 05:12:43 INFO - 'HOME': '/home/cltbld', 05:12:43 INFO - 'LANG': 'en_US.UTF-8', 05:12:43 INFO - 'LANGUAGE': 'en_US:en', 05:12:43 INFO - 'LOGNAME': 'cltbld', 05:12:43 INFO - 'MAIL': '/var/mail/cltbld', 05:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:43 INFO - 'MOZ_NO_REMOTE': '1', 05:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:43 INFO - 'NO_EM_RESTART': '1', 05:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:43 INFO - 'PWD': '/builds/slave/test', 05:12:43 INFO - 'SHELL': '/bin/bash', 05:12:43 INFO - 'SHLVL': '1', 05:12:43 INFO - 'TERM': 'linux', 05:12:43 INFO - 'TMOUT': '86400', 05:12:43 INFO - 'USER': 'cltbld', 05:12:43 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', 05:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:43 INFO - '_': '/tools/buildbot/bin/python'} 05:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:43 INFO - Downloading/unpacking psutil>=0.7.1 05:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:12:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:45 INFO - Installing collected packages: psutil 05:12:45 INFO - Running setup.py install for psutil 05:12:45 INFO - building 'psutil._psutil_linux' extension 05:12:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:12:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:12:45 INFO - building 'psutil._psutil_posix' extension 05:12:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:12:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:12:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:45 INFO - Successfully installed psutil 05:12:45 INFO - Cleaning up... 05:12:46 INFO - Return code: 0 05:12:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975d36df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12409a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf810>, '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 0x12d0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0ba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', '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 05:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:12:46 INFO - Using env: {'DISPLAY': ':0', 05:12:46 INFO - 'HOME': '/home/cltbld', 05:12:46 INFO - 'LANG': 'en_US.UTF-8', 05:12:46 INFO - 'LANGUAGE': 'en_US:en', 05:12:46 INFO - 'LOGNAME': 'cltbld', 05:12:46 INFO - 'MAIL': '/var/mail/cltbld', 05:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:46 INFO - 'MOZ_NO_REMOTE': '1', 05:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:46 INFO - 'NO_EM_RESTART': '1', 05:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:46 INFO - 'PWD': '/builds/slave/test', 05:12:46 INFO - 'SHELL': '/bin/bash', 05:12:46 INFO - 'SHLVL': '1', 05:12:46 INFO - 'TERM': 'linux', 05:12:46 INFO - 'TMOUT': '86400', 05:12:46 INFO - 'USER': 'cltbld', 05:12:46 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', 05:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:46 INFO - '_': '/tools/buildbot/bin/python'} 05:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:12: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 05:12: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 05:12: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 05:12: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 05:12: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 05:12: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 05:12:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:12:48 INFO - Installing collected packages: mozsystemmonitor 05:12:48 INFO - Running setup.py install for mozsystemmonitor 05:12:48 INFO - Successfully installed mozsystemmonitor 05:12:48 INFO - Cleaning up... 05:12:48 INFO - Return code: 0 05:12:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:12: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')]} 05:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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')]} 05:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975d36df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12409a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf810>, '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 0x12d0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0ba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', '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 05:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:12:48 INFO - Using env: {'DISPLAY': ':0', 05:12:48 INFO - 'HOME': '/home/cltbld', 05:12:48 INFO - 'LANG': 'en_US.UTF-8', 05:12:48 INFO - 'LANGUAGE': 'en_US:en', 05:12:48 INFO - 'LOGNAME': 'cltbld', 05:12:48 INFO - 'MAIL': '/var/mail/cltbld', 05:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:48 INFO - 'MOZ_NO_REMOTE': '1', 05:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:48 INFO - 'NO_EM_RESTART': '1', 05:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:48 INFO - 'PWD': '/builds/slave/test', 05:12:48 INFO - 'SHELL': '/bin/bash', 05:12:48 INFO - 'SHLVL': '1', 05:12:48 INFO - 'TERM': 'linux', 05:12:48 INFO - 'TMOUT': '86400', 05:12:48 INFO - 'USER': 'cltbld', 05:12:48 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', 05:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:48 INFO - '_': '/tools/buildbot/bin/python'} 05:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:12:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:12:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:51 INFO - Downloading docopt-0.6.1.tar.gz 05:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:12:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:12:51 INFO - Running setup.py install for blobuploader 05:12:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:12:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:12:51 INFO - Running setup.py install for requests 05:12:51 INFO - Running setup.py install for docopt 05:12:51 INFO - Successfully installed blobuploader requests docopt 05:12:51 INFO - Cleaning up... 05:12:51 INFO - Return code: 0 05:12:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12: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')]} 05:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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')]} 05:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975d36df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12409a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf810>, '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 0x12d0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0ba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', '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 05:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:12:51 INFO - Using env: {'DISPLAY': ':0', 05:12:51 INFO - 'HOME': '/home/cltbld', 05:12:51 INFO - 'LANG': 'en_US.UTF-8', 05:12:51 INFO - 'LANGUAGE': 'en_US:en', 05:12:51 INFO - 'LOGNAME': 'cltbld', 05:12:51 INFO - 'MAIL': '/var/mail/cltbld', 05:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:51 INFO - 'MOZ_NO_REMOTE': '1', 05:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:51 INFO - 'NO_EM_RESTART': '1', 05:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:51 INFO - 'PWD': '/builds/slave/test', 05:12:51 INFO - 'SHELL': '/bin/bash', 05:12:51 INFO - 'SHLVL': '1', 05:12:51 INFO - 'TERM': 'linux', 05:12:51 INFO - 'TMOUT': '86400', 05:12:51 INFO - 'USER': 'cltbld', 05:12:51 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', 05:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:51 INFO - '_': '/tools/buildbot/bin/python'} 05:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:51 INFO - Running setup.py (path:/tmp/pip-6KWe41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:51 INFO - Running setup.py (path:/tmp/pip-4Gi_an-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:52 INFO - Running setup.py (path:/tmp/pip-Mz3A9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:52 INFO - Running setup.py (path:/tmp/pip-gGOZV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:52 INFO - Running setup.py (path:/tmp/pip-LXqKAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:52 INFO - Running setup.py (path:/tmp/pip-z3SO_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:52 INFO - Running setup.py (path:/tmp/pip-hQgOF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:52 INFO - Running setup.py (path:/tmp/pip-fDBPYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:52 INFO - Running setup.py (path:/tmp/pip-VRquH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:52 INFO - Running setup.py (path:/tmp/pip-TCA4qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:52 INFO - Running setup.py (path:/tmp/pip-cguhU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:52 INFO - Running setup.py (path:/tmp/pip-laPg1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:52 INFO - Running setup.py (path:/tmp/pip-wggsVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:52 INFO - Running setup.py (path:/tmp/pip-PmPLsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:52 INFO - Running setup.py (path:/tmp/pip-ChfdBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:53 INFO - Running setup.py (path:/tmp/pip-RxF6te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:53 INFO - Running setup.py (path:/tmp/pip-Arv100-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:12:53 INFO - Running setup.py install for manifestparser 05:12:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:12:53 INFO - Running setup.py install for mozcrash 05:12:53 INFO - Running setup.py install for mozdebug 05:12:53 INFO - Running setup.py install for mozdevice 05:12:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:12:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:12:53 INFO - Running setup.py install for mozfile 05:12:53 INFO - Running setup.py install for mozhttpd 05:12:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:12:53 INFO - Running setup.py install for mozinfo 05:12:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:12:53 INFO - Running setup.py install for mozInstall 05:12:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:12:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:12:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:12:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:12:53 INFO - Running setup.py install for mozleak 05:12:54 INFO - Running setup.py install for mozlog 05:12:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:12:54 INFO - Running setup.py install for moznetwork 05:12:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:12:54 INFO - Running setup.py install for mozprocess 05:12:54 INFO - Running setup.py install for mozprofile 05:12:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:12:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:12:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:12:54 INFO - Running setup.py install for mozrunner 05:12:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:12:54 INFO - Running setup.py install for mozscreenshot 05:12:54 INFO - Running setup.py install for moztest 05:12:54 INFO - Running setup.py install for mozversion 05:12:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:12:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:54 INFO - Cleaning up... 05:12:54 INFO - Return code: 0 05:12:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:54 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 0x7f975d36df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12409a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf810>, '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 0x12d0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0ba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', '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 05:12:54 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 05:12:54 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 05:12:54 INFO - Using env: {'DISPLAY': ':0', 05:12:54 INFO - 'HOME': '/home/cltbld', 05:12:54 INFO - 'LANG': 'en_US.UTF-8', 05:12:54 INFO - 'LANGUAGE': 'en_US:en', 05:12:54 INFO - 'LOGNAME': 'cltbld', 05:12:54 INFO - 'MAIL': '/var/mail/cltbld', 05:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:54 INFO - 'MOZ_NO_REMOTE': '1', 05:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:54 INFO - 'NO_EM_RESTART': '1', 05:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:54 INFO - 'PWD': '/builds/slave/test', 05:12:54 INFO - 'SHELL': '/bin/bash', 05:12:54 INFO - 'SHLVL': '1', 05:12:54 INFO - 'TERM': 'linux', 05:12:54 INFO - 'TMOUT': '86400', 05:12:54 INFO - 'USER': 'cltbld', 05:12:54 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', 05:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:54 INFO - '_': '/tools/buildbot/bin/python'} 05:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:55 INFO - Running setup.py (path:/tmp/pip-IyGwJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:55 INFO - Running setup.py (path:/tmp/pip-Ssjhdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:55 INFO - Running setup.py (path:/tmp/pip-PW2eYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:55 INFO - Running setup.py (path:/tmp/pip-rZOIgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:55 INFO - Running setup.py (path:/tmp/pip-dXv1jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:55 INFO - Running setup.py (path:/tmp/pip-xK7bVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:55 INFO - Running setup.py (path:/tmp/pip-aYVk50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:55 INFO - Running setup.py (path:/tmp/pip-m57Dxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:55 INFO - Running setup.py (path:/tmp/pip-Dqgqw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:55 INFO - Running setup.py (path:/tmp/pip-A3LKZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:55 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)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:55 INFO - Running setup.py (path:/tmp/pip-f_OQS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:55 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)) 05:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:55 INFO - Running setup.py (path:/tmp/pip-8kOLDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:56 INFO - Running setup.py (path:/tmp/pip-linJb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:56 INFO - Running setup.py (path:/tmp/pip-XTBj3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:56 INFO - Running setup.py (path:/tmp/pip-6OGnxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:56 INFO - Running setup.py (path:/tmp/pip-BjCnky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:56 INFO - Running setup.py (path:/tmp/pip-NVeMeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:58 INFO - Downloading blessings-1.6.tar.gz 05:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:58 INFO - Installing collected packages: blessings 05:12:58 INFO - Running setup.py install for blessings 05:12:58 INFO - Successfully installed blessings 05:12:58 INFO - Cleaning up... 05:12:58 INFO - Return code: 0 05:12:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:12:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:58 INFO - Reading from file tmpfile_stdout 05:12:58 INFO - Current package versions: 05:12:58 INFO - argparse == 1.2.1 05:12:58 INFO - blessings == 1.6 05:12:58 INFO - blobuploader == 1.2.4 05:12:58 INFO - docopt == 0.6.1 05:12:58 INFO - manifestparser == 1.1 05:12:58 INFO - mozInstall == 1.12 05:12:58 INFO - mozcrash == 0.17 05:12:58 INFO - mozdebug == 0.1 05:12:58 INFO - mozdevice == 0.48 05:12:58 INFO - mozfile == 1.2 05:12:58 INFO - mozhttpd == 0.7 05:12:58 INFO - mozinfo == 0.9 05:12:58 INFO - mozleak == 0.1 05:12:58 INFO - mozlog == 3.1 05:12:58 INFO - moznetwork == 0.27 05:12:58 INFO - mozprocess == 0.22 05:12:58 INFO - mozprofile == 0.28 05:12:58 INFO - mozrunner == 6.11 05:12:58 INFO - mozscreenshot == 0.1 05:12:58 INFO - mozsystemmonitor == 0.0 05:12:58 INFO - moztest == 0.7 05:12:58 INFO - mozversion == 1.4 05:12:58 INFO - psutil == 3.1.1 05:12:58 INFO - requests == 1.2.3 05:12:58 INFO - wsgiref == 0.1.2 05:12:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12: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')]} 05:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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')]} 05:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975d36df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12409a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf810>, '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 0x12d0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0ba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', '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 05:12:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:12:58 INFO - Using env: {'DISPLAY': ':0', 05:12:58 INFO - 'HOME': '/home/cltbld', 05:12:58 INFO - 'LANG': 'en_US.UTF-8', 05:12:58 INFO - 'LANGUAGE': 'en_US:en', 05:12:58 INFO - 'LOGNAME': 'cltbld', 05:12:58 INFO - 'MAIL': '/var/mail/cltbld', 05:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:58 INFO - 'MOZ_NO_REMOTE': '1', 05:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:58 INFO - 'NO_EM_RESTART': '1', 05:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:58 INFO - 'PWD': '/builds/slave/test', 05:12:58 INFO - 'SHELL': '/bin/bash', 05:12:58 INFO - 'SHLVL': '1', 05:12:58 INFO - 'TERM': 'linux', 05:12:58 INFO - 'TMOUT': '86400', 05:12:58 INFO - 'USER': 'cltbld', 05:12:58 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', 05:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:58 INFO - '_': '/tools/buildbot/bin/python'} 05:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:58 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)) 05:12:58 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)) 05:12:58 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)) 05:12:58 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)) 05:12:58 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)) 05:12:58 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)) 05:12:58 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)) 05:12:58 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)) 05:12:58 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)) 05:12:58 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)) 05:12:58 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)) 05:12:58 INFO - Cleaning up... 05:12:58 INFO - Return code: 0 05:12:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:12: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')]} 05:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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')]} 05:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975d36df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12409a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf810>, '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 0x12d0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0ba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', '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 05:12: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', 'jsonschema'] in /builds/slave/test/build 05:12: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 jsonschema 05:12:58 INFO - Using env: {'DISPLAY': ':0', 05:12:58 INFO - 'HOME': '/home/cltbld', 05:12:58 INFO - 'LANG': 'en_US.UTF-8', 05:12:58 INFO - 'LANGUAGE': 'en_US:en', 05:12:58 INFO - 'LOGNAME': 'cltbld', 05:12:58 INFO - 'MAIL': '/var/mail/cltbld', 05:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:58 INFO - 'MOZ_NO_REMOTE': '1', 05:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:58 INFO - 'NO_EM_RESTART': '1', 05:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:58 INFO - 'PWD': '/builds/slave/test', 05:12:58 INFO - 'SHELL': '/bin/bash', 05:12:58 INFO - 'SHLVL': '1', 05:12:58 INFO - 'TERM': 'linux', 05:12:58 INFO - 'TMOUT': '86400', 05:12:58 INFO - 'USER': 'cltbld', 05:12:58 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', 05:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:58 INFO - '_': '/tools/buildbot/bin/python'} 05:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:59 INFO - Downloading/unpacking jsonschema 05:12: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 05:12: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 05:12: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 05:12: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 05:12: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 05:12: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 05:13:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:13:01 INFO - Downloading/unpacking functools32 (from jsonschema) 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:13:01 INFO - warning: no files found matching '*.txt' 05:13:01 INFO - no previously-included directories found matching 'build' 05:13:01 INFO - no previously-included directories found matching 'dist' 05:13:01 INFO - no previously-included directories found matching '.git*' 05:13:01 INFO - Installing collected packages: jsonschema, functools32 05:13:01 INFO - Running setup.py install for functools32 05:13:01 INFO - warning: no files found matching '*.txt' 05:13:01 INFO - no previously-included directories found matching 'build' 05:13:01 INFO - no previously-included directories found matching 'dist' 05:13:01 INFO - no previously-included directories found matching '.git*' 05:13:01 INFO - Successfully installed jsonschema functools32 05:13:01 INFO - Cleaning up... 05:13:01 INFO - Return code: 0 05:13:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975d36df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12409a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf810>, '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 0x12d0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0ba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', '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 05:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:13:01 INFO - Using env: {'DISPLAY': ':0', 05:13:01 INFO - 'HOME': '/home/cltbld', 05:13:01 INFO - 'LANG': 'en_US.UTF-8', 05:13:01 INFO - 'LANGUAGE': 'en_US:en', 05:13:01 INFO - 'LOGNAME': 'cltbld', 05:13:01 INFO - 'MAIL': '/var/mail/cltbld', 05:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:01 INFO - 'MOZ_NO_REMOTE': '1', 05:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:01 INFO - 'NO_EM_RESTART': '1', 05:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:01 INFO - 'PWD': '/builds/slave/test', 05:13:01 INFO - 'SHELL': '/bin/bash', 05:13:01 INFO - 'SHLVL': '1', 05:13:01 INFO - 'TERM': 'linux', 05:13:01 INFO - 'TMOUT': '86400', 05:13:01 INFO - 'USER': 'cltbld', 05:13:01 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', 05:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:01 INFO - '_': '/tools/buildbot/bin/python'} 05:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:01 INFO - Downloading/unpacking flake8 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:13:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:13:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:13:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:04 INFO - no previously-included directories found matching 'docs/_build' 05:13:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:13:04 INFO - Running setup.py install for pep8 05:13:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:04 INFO - no previously-included directories found matching 'docs/_build' 05:13:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:13:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:13:04 INFO - Cleaning up... 05:13:04 INFO - Return code: 0 05:13:04 INFO - Running post-action listener: _resource_record_post_action 05:13:04 INFO - Running post-action listener: _start_resource_monitoring 05:13:04 INFO - Starting resource monitoring. 05:13:04 INFO - ##### 05:13:04 INFO - ##### Running install step. 05:13:04 INFO - ##### 05:13:04 INFO - Running pre-action listener: _resource_record_pre_action 05:13:04 INFO - Running main action method: install 05:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:04 INFO - Reading from file tmpfile_stdout 05:13:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:13:04 INFO - Reading from file tmpfile_stdout 05:13:04 INFO - Output received: 05:13:04 INFO - Usage: mozinstall [options] installer 05:13:04 INFO - Options: 05:13:04 INFO - -h, --help show this help message and exit 05:13:04 INFO - -d DEST, --destination=DEST 05:13:04 INFO - Directory to install application into. [default: 05:13:04 INFO - "/builds/slave/test"] 05:13:04 INFO - --app=APP Application being installed. [default: firefox] 05:13:04 INFO - mkdir: /builds/slave/test/build/application 05:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:13:21 INFO - Reading from file tmpfile_stdout 05:13:21 INFO - Output received: 05:13:21 INFO - /builds/slave/test/build/application/firefox/firefox 05:13:21 INFO - Running post-action listener: _resource_record_post_action 05:13:21 INFO - ##### 05:13:21 INFO - ##### Running run-tests step. 05:13:21 INFO - ##### 05:13:21 INFO - Running pre-action listener: _resource_record_pre_action 05:13:21 INFO - Running main action method: run_tests 05:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:13:21 INFO - Python 2.7.3 05:13:21 INFO - Return code: 0 05:13:21 INFO - grabbing minidump binary from tooltool 05:13:21 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')]} 05:13:21 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 0x12cf810>, '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 0x12d0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:13:21 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 05:13:21 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 05:13:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:13:21 INFO - Return code: 0 05:13:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:13:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:13:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:13:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:13:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:13:22 INFO - Return code: 0 05:13:22 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/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:13:22 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/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 05:13:22 INFO - Using env: {'DISPLAY': ':0', 05:13:22 INFO - 'HOME': '/home/cltbld', 05:13:22 INFO - 'LANG': 'en_US.UTF-8', 05:13:22 INFO - 'LANGUAGE': 'en_US:en', 05:13:22 INFO - 'LOGNAME': 'cltbld', 05:13:22 INFO - 'MAIL': '/var/mail/cltbld', 05:13:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:13:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:22 INFO - 'MOZ_NO_REMOTE': '1', 05:13:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:22 INFO - 'NO_EM_RESTART': '1', 05:13:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:22 INFO - 'PWD': '/builds/slave/test', 05:13:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:13:22 INFO - 'SHELL': '/bin/bash', 05:13:22 INFO - 'SHLVL': '1', 05:13:22 INFO - 'TERM': 'linux', 05:13:22 INFO - 'TMOUT': '86400', 05:13:22 INFO - 'USER': 'cltbld', 05:13:22 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960', 05:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:22 INFO - '_': '/tools/buildbot/bin/python'} 05:13:22 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/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:13:22 INFO - mozversion application_buildid: 20160428023032 05:13:22 INFO - mozversion application_changeset: 53765e008b97622b5c7e26d22b2db016b0e53dc1 05:13:22 INFO - mozversion application_display_name: Nightly 05:13:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:13:22 INFO - mozversion application_name: Firefox 05:13:22 INFO - mozversion application_remotingname: firefox 05:13:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:13:22 INFO - mozversion application_vendor: Mozilla 05:13:22 INFO - mozversion application_version: 49.0a1 05:13:22 INFO - mozversion platform_buildid: 20160428023032 05:13:22 INFO - mozversion platform_changeset: 53765e008b97622b5c7e26d22b2db016b0e53dc1 05:13:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:13:22 INFO - mozversion platform_version: 49.0a1 05:13:22 INFO - using testdate: 1461845602 05:13:22 INFO - actual date: 1461845602 05:13:22 INFO - starting webserver on 'localhost:59553' 05:13:22 INFO - SUITE-START | Running 2 tests 05:13:22 INFO - TEST-START | dromaeo_css 05:13:22 INFO - operating with platform_type : linux_ 05:13:22 INFO - Initialising browser for dromaeo_css test... 05:13:22 INFO - TEST-INFO | started process 27610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFVsmB5/profile http://localhost:59553/getInfo.html) 05:13:27 INFO - PROCESS | 27610 | __metrics Screen width/height:1600/1200 05:13:27 INFO - PROCESS | 27610 | colorDepth:24 05:13:27 INFO - PROCESS | 27610 | Browser inner width/height: 1024/697 05:13:27 INFO - PROCESS | 27610 | __metrics 05:13:28 ERROR - PROCESS | 27610 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:13:28 INFO - TEST-INFO | 27610: exit 0 05:13:28 INFO - Browser initialized. 05:13:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:13:28 INFO - TEST-INFO | started process 27691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFVsmB5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:40 INFO - PROCESS | 27691 | RSS: Main: 154546176 05:13:40 INFO - PROCESS | 27691 | 05:14:31 INFO - PROCESS | 27691 | 1461845671723 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] 05:16:39 INFO - PROCESS | 27691 | Cycle 1(1): loaded http://localhost:59553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59553/tests/dromaeo/cssquery-ext.html) 05:16:40 INFO - PROCESS | 27691 | RSS: Main: 253927424 05:16:40 INFO - PROCESS | 27691 | 05:19:42 INFO - PROCESS | 27691 | Cycle 1(1): loaded http://localhost:59553/tests/dromaeo/cssquery-ext.html (next: http://localhost:59553/tests/dromaeo/cssquery-jquery.html) 05:19:43 INFO - PROCESS | 27691 | RSS: Main: 230129664 05:19:43 INFO - PROCESS | 27691 | 05:22:45 INFO - PROCESS | 27691 | Cycle 1(1): loaded http://localhost:59553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59553/tests/dromaeo/cssquery-mootools.html) 05:22:45 INFO - PROCESS | 27691 | RSS: Main: 243048448 05:22:45 INFO - PROCESS | 27691 | 05:25:47 INFO - PROCESS | 27691 | Cycle 1(1): loaded http://localhost:59553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59553/tests/dromaeo/cssquery-prototype.html) 05:25:48 INFO - PROCESS | 27691 | RSS: Main: 230621184 05:25:48 INFO - PROCESS | 27691 | 05:28:50 INFO - PROCESS | 27691 | Cycle 1(1): loaded http://localhost:59553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59553/tests/dromaeo/cssquery-yui.html) 05:28:51 INFO - PROCESS | 27691 | RSS: Main: 222662656 05:28:51 INFO - PROCESS | 27691 | 05:31:54 INFO - PROCESS | 27691 | Cycle 1(1): loaded http://localhost:59553/tests/dromaeo/cssquery-yui.html (next: http://localhost:59553/tests/dromaeo/cssquery-dojo.html) 05:31:54 INFO - PROCESS | 27691 | RSS: Main: 260435968 05:31:54 INFO - PROCESS | 27691 | 05:31:54 INFO - PROCESS | 27691 | __start_tp_report 05:31:54 INFO - PROCESS | 27691 | _x_x_mozilla_page_load 05:31:54 INFO - PROCESS | 27691 | _x_x_mozilla_page_load_details 05:31:54 INFO - PROCESS | 27691 | |i|pagename|runs| 05:31:54 INFO - PROCESS | 27691 | |0;dojo.html;3059.7705172112096;3083.6607973122955;3091.5208142737883;3096.9535456968133;3132.169974956636;5149.047426226141;5196.090684130271;5205.609579281555;5222.060029194743;5268.209768534722;5187.325647665808;5189.351331083614;5248.212768084789;5262.131748261532;5295.443978382272;4726.480087190406;4729.858104256878;4739.0048089901165;4766.165920963835;4833.854984350475;4786.473487916326;4786.688865223749;4810.518948105179;4835.661503694742;4861.927071093936;4614.5385461453925;4703.835365762182;4724.503927087675;4758.690685105457;4783.976080119594;4740.668153229275;4748.833790817304;4756.6432517561325;4763.333133361332;4789.568938795525;4696.319033740088;4721.740304283263;4736.6447516436065;4740.762961851928;4790.784414701347;5105.719185444799;5131.948680513222;5149.588032957355;5186.40356359016;5190.558802501791;5447.6731396115965;5451.64564303319;5466.590005749585;5471.23402723619;5476.452354764531;5481.205225242357;5504.724763761836;5512.834614961557;5518.117101263819;5569.526590239834;5204.843854684365;5209.166533354645;5227.764750586232;5240.371155461331;5277.6305658603915;5653;5660.122680984454;5666.546676265889;5666.886662266732;5686.232358631614;5404.135338345845;5455.318085239345;5458.536024437967;5473.480019398151;5521;5449.673019618756;5472.753726082336;5475.397706252309;5475.698836563947;5492.598060731882;5432.639649507182;5436.619436639477;5443.972780136074;5449.209864569615;5486.972565137228;5389.973050134724;5460.290162278958;5577.553795696415;5620.016497112989;5633.57748168889;4195.49654041517;4202.285611446062;4205.873823785291;4206.158768246363;4238.427812245307;3765.4351847223134;3767.585565587783;3781.829817658212;3789.791561464146;3793.525809273841;5156.948430515647;5234.92147617786;5272.657277276965;5309.070912590359;5337.946620533745;5606.747696353674;5609;5621.381648018714;5626.156076588462;5628.746706398222;5173.948260517422;5279.709615971082;5303.920441193385;5307.522322990872;5317.654352467154;4774.212254977959;4778.1638213312535;4788.11419887322;4833.081714474309;4837.588804951619;5709.486146246858;5710.543156547466;5713.942860571424;5715.714214289269;5765.88468230633;5481.3970463248215;5517.944820551743;5521.282233309805;5529.861753456195;5619.297587801525;5763.740631671669;5767.884642307215;5784.2769653793275;5803.941960580509;5831.096180092092;5388.272583201375;5448;5454.3454785426;5458.4814442627885;5460.563154947674;5448.564114870722;5556.16657501378;5558.777648894161;5565.7217139143695;5603.2155498231095;5416.83749487516;5421.512063914267;5421.783128674809;5423.403425623257;5453.754581043783;5405.270288511001;5405.78376864921;5409.269748584048;5411.242426060433;5460.972695136499;5208.817691380784;5318.255444237732;5366.570674345965;5411.1883217516115;5456.809011684572;5462.153366228082;5465.480779325958;5499.752511136929;5499.890002199853;5503.064479038653;5380.650257733391;5380.811671591476;5383.273258110105;5388.973055134699;5389.353277606712 05:31:54 INFO - PROCESS | 27691 | |1;ext.html;598.1267349669482;644.764660898772;657.6645910585602;658.2923357390803;669.6383952665561;33378.33243335135;34041.31917361651;34067.14832129195;34121.976340709785;37550;42048.78975605118;42751.14497710044;42883.35674964878;43100;43187.56812431875;8611.224989750906;8838.823223535526;8840.160184782435;8844.73465796027;8848.46909185451;7633.694652213905;7811.140774514799;8653.783655408602;9871.506424678737;10133.645322413717;10183.33808302458;10313.07182353588;10313.896861031406;10319.742006449862;10328.58685652573;7655.387568994523;10382.480875956171;10449;10457.4771261437;10458.163346932228;9910.20718342531;10084.69745907624;10087.243456740774;10091.49542522871;10093.495325233782;35957.64042359595;36456.817715911515;36603;36664.816675916714;36755;3667.559892812853;3681.5582130144285;3726.6646001859963;3744.7378683492166;3788.469614253979;30995.380092398253;31650.36699266025;31799.682003179903;32063.51904721408;32177.356452871045;4298.20483210607;4316.223079845627;4347.130573885235;4366.956330436687;4423.5576442355505;274677;279768;279989;280058;280536;59552.70223648854;60797.696011520544;60879.69560152171;60955.39044609586;60957;61664.69167654133;63380.68309658515;63468.682656586425;63707.681461592394;63880.361196388374;16837.663246734995;17135.400260990806;17151.142442877805;17164.828351716573;17178.055206963738;13073.084884058024;13213.207207567577;13216;13220.33898305081;13226.801597976038;19307.613847722965;19525.511862203275;19790.901045494968;19829.20683172657;19845.900770496344;7477.289657482531;7576.204498527685;7587.2412758723685;7593.6582853771715;7671.309582137635;1024.8718910136233;1043.9373637581618;1045.994770026145;1117.044926587772;1122.7754449110212;30665.84667076695;31090.68909310923;31206.843965780026;31307.686923130932;31749.365012699618;1113.9443027848574;1119.468252580018;1137.4653912661036;1139.641013080877;1148.2995372822572;15783.368665253261;16298.67402651964;16513.752293715603;16701.415450459175;16738.66522669564;372318;375686;376718;376955;377071;53787;54365.45634543683;54433.72783136059;54452.45547544553;54528;1306.6667999660026;1401.2783416540285;1427.8857691384665;1448.9420423182955;1479.8002269693668;25757.35606609775;26578;26920.192394228205;27277;27407;37831;38085.80957095197;38429.4235586472;38441;38590.228195436495;192417;194107;194487;194732;195032;23311.18410855612;25918.222453325678;26282.60576091322;26293.948242070866;26314.736852631228;41525;44994.3250851244;45768.31347529723;45821.4798186103;46048.76975615101;38481.615183848924;38898;39151.608483914795;40085.19829603333;40236.59763402329;37674;38488.26802793937;38500.42249366318;38602;39289.41065884071;36083.278334433686;37070.8146459266;37564.62435375611;38034;38748.41877371785;31435.84282078575;32068.19829504188;32664.020079397655;32690.34619307553;33054.669453305156;25478.617820733074;25671.614925775753;25733;25792.226233213034;25809.870950645127 05:31:54 INFO - PROCESS | 27691 | |2;jquery.html;386.312363992094;390.43192155413857;390.8456159816872;394.03181110353785;401.289717200555;13856.099353542013;14162.64593385166;17042.91478542607;17471.563210919718;17547.03491307979;16770.329186832543;17538.649227015452;17581.29674813009;18700.345487907925;19480.34417074547;6039.72821223045;6186.659733714644;6200.87598248037;6226;6229.532785041118;4437.489688685794;6185.56701030928;6228.941080016385;6573.211214654249;6899.793006209797;6856.691448884812;6879.346462086119;6905.309469053104;6909.412699920513;6912.792616221522;6857.828554286133;6929.653517324164;6943.375096241362;6955.374016338528;6957.930420695779;6393.584417012926;6489.870202595969;6687.097241872382;6687.364700353459;6699.497537684644;23832.76167238323;24114.638280425806;24131.879340603362;24144.034238630433;24597.754022459903;2451.705795304575;2493.800495960319;3074.369754200406;3207.3585282943504;3273.099897528175;14234.003619746622;14263.286835658279;14725.926370368186;14729.92635036818;14737.778933316009;2082.5730725201297;2107.4309936317263;2133.6586146216687;2147.076756994492;2211.7788221177916;53102.73448632771;59076.40923590795;63474.68262658703;81509.59245203795;84431.15568844356;15986.440474583567;16887.831121688625;16948.864460074925;17140.571485712706;17208.827911720724;29654.258643534085;29707.851460742557;30009.849950750107;30091.849540752155;30195;9663.03369663028;9976.201903847676;10043.347182433119;10117.494125293853;10225.94887025575;8393.412461127784;8412.116727743622;8595.054544000155;8694.826103477895;8703.651853925772;8523.786905327417;8661.65744309633;8724.78188045304;8847.557622118868;8938.329625278131;3205.6954589313978;3279.67173294816;3290.5393244945726;3337.7496687748517;3471.218975730491;941.1764705882352;998.1066945084254;1022.197574903697;1030.4281123976116;1049.0296475759892;17767.555811104827;18040;18073;18287.177077031567;18437.7234341485;994.229472159068;998.5157198758596;1005.1657124586576;1028.7890982348601;1048.5072016152396;9058.456492610465;10461.895381046244;10481.266311358284;10540.367577945348;10613.9469302653;439057.7598594915;444740;455323;457747;461009;73765;75530.62234688901;76775;78043.60978195073;78071.60964195142;892.6206362296128;974.0892265731563;1024.9231307651955;1031.51003273446;1033.4109557552124;15922;16148.031118132949;16275.674486509966;16679.332826686797;16690.16549172561;26494.86752566225;28213.858930705213;32625.836870816445;34831.30337393289;35210.8239458801;43252.56747432611;44888.10223795571;47819.28271075867;49428.752856235486;49960.500394995586;8441.451305665112;8447.155284471504;8470.745877623682;8696.608652610521;8801.691940782042;10503.579856805642;12666.493340266286;12835.229886206858;12852.421641026363;12942.352882355655;10849.403282819205;11170.888291116984;11185.944070279596;11306.773864522827;11601.709957251136;11006.119510439306;11145.777084458428;11332.546698131982;11351.943240283746;11380;11477.94261028723;11500.884991149982;11550.88449115498;11559.884401155881;11648.650540483799;8430.199131082538;8475.480009766967;8559.786005349915;8578.571071446278;8675.30597552207;8767.079456657215;10739.838902416313;11452.713682158013;11594.88405115938;11617.47721352558 05:31:54 INFO - PROCESS | 27691 | |3;mootools.html;1344.4958140697238;1492.9477468288605;1502.6994601079784;1637.35324546804;1721.5093698295989;7115.146182458106;7852.725154619589;8037.437379383431;8046.235607617267;8056.63745131469;7736.883946740803;7881;7896.684132634702;7898.249666281708;7898.328642065431;1954.15971132413;2187.4203336115943;2211.513467037249;2233.0955962834996;2243.1251811793413;2205.52581195043;2207.7902599253043;2227.94430139247;2228.0864845413385;2229.843910926236;2172.804447599716;2192.199847055821;2197.099189332374;2202.284257616273;2210.546837898235;1904.476269026022;2153.12798316682;2163.3401812447196;2214.534947660993;2217.5343177932655;2215.6233440315186;2231.263682984611;2238.5746708125403;2240.574290884743;2241.081156725751;7858.921410785876;7874.094479134916;7902.881456778153;7906.090799558009;7909.169537198569;4602.217623004098;4768.475467698585;4793.400824896888;4794.544518270759;4800;3069.217349575844;3105.161606366291;3257.1205774441005;3261.1357990132633;3265.1184180271193;1083.9295445796;1120.8542889424405;1128.949197286124;1130.4573804573768;1142.5601143559707;11239.100871930308;11240.831387529193;11263.098952083814;11268.718282042933;11273.830892536618;4288.721233119837;4390.1878152541885;4415.536368681306;4455.554444555583;4459.509453960061;9448.433094014381;9555;9566.330356874952;9580.377275477073;9584.233261339215;4734.715917044989;4843.685160464559;4849.442314133919;4851.58761505276;4853.150698627726;3981.3629819229363;4387.605115539617;4485.887852803706;4490.955090449119;4495.325701144789;3582;3630.43728222126;3645.5989841117457;3647.361711700442;3710.573284072312;1167.4512978899904;1170.3855475875234;1174.565410797993;1178.4814681540095;1186.187461588797;889.9644014239358;977.9926675524222;986.6546708651914;1019.2966852871494;1023.0536753503129;5507.366652834895;5660.29246344207;5673.234113394721;5719.28508936383;5844.766209351664;1010.6361709784471;1031.5564307347763;1053.546974800843;1091.3615534912008;1093.1855767453299;3912.4326972588815;3937.7243592948794;3948.9210215796097;3968.900777480586;3985;9789.46157961319;10143.543540540693;10250.794984100276;10277.794444111076;10287.125594324567;10052.145567626834;10091.545880435398;10145.03622155894;10154.441505717257;10169.491525423848;7577.962110189414;7796.064472263365;7820.843583128306;7823.647935842901;7825.591393549102;5702.7718891243885;5762.539505298951;5780.277465316835;5896.823095307148;5916.26046744157;9320.813583728423;9423.811523769624;9463.952680236554;9466.05339466048;9490.715278541655;8908.064653211579;9274.907250927405;9286.582103805209;9299.72100836976;9306.953465232631;6610.206775187008;6914.723411063501;7059.964700176466;7098.716051357887;7294.489385742947;7821.648025838965;7844.803879903048;7906.52560846351;7920.405969552422;7941.047074351115;7073.469489788184;7306.086739157606;7323.560586364835;7340.853182936418;7474.850502990019;6998.860022799414;7118.394936430254;7136.393406560501;7169.426445884421;7260.128784545888;6521.152250207443;6570.375814297634;6609.768658096944;6624.966875165594;6625.834354141185;4952.925706114339;4988.251762235548;5055.646104772631;5076.847694569169;5135.486451354835;5015.899682006412;5079.238114282887;5107.770150343169;5168.3797944246935;5274 05:31:54 INFO - PROCESS | 27691 | |4;prototype.html;328.1010032510921;334.0512943241195;334.1762555301183;339.2942679227208;339.8691503771049;5305.018571564264;5357.785688572458;5387.138057910735;5394.219907430548;5408.5943554233445;5268.920966185501;5278.6568873023225;5325.3077099976945;5331.600129990256;5349.679019258847;3964.235915017818;3997.5202975642965;4082.8979275518054;4130.442390277319;4149.813258403364;4134.359174327984;4140.958590414088;4141.358089496133;4144.21259960608;4150.418941348214;3946.6645335146545;4100.2209580179815;4102.733322334054;4116.567760385146;4125.391097471988;3884.2520865610586;3979.149336234174;4047.392891066349;4095.8566450174103;4096.160287141129;3585.8386372613295;3588.1209103769484;3589.838457269429;3602.2795440911923;3602.5676918769655;5083.440821509631;5105.285260063594;5113.39216999333;5115.974420127875;5156.432792392834;4600.539946005372;4680.742559159245;4687.10944920464;4691.920858202632;4692.389989301403;5491.972540137273;5496.6701997880255;5503.257060296889;5511.12621708617;5548.72256387179;3955.655077273712;3958.485396898385;3970.5433875104445;3978.4430179774854;3985.621365970228;5680.8863822723315;5752;5766.913496297559;5769.913451298234;5776.6534007959235;4077.5922407758985;4090.9386359204636;4102.174532333083;4109.712320137562;4130.173965206971;4161.500619925568;4167.1040726244;4167.666586673059;4168.374743788396;4171.478565179353;4609.861704148881;4696.225122854759;4703.6942598730975;4708.505606911225;4746.1456937750845;5533.00405926937;5567.715048121628;5570.498655121059;5578;5603.187537807076;1511.8866085043446;1523.1927078648334;1533.1874106723455;1533.984660153384;1537.3005282596391;968.2883080935507;1009.9192064634811;1010.8433192855119;1031.2626472072504;1056.392574269798;5327.413984461706;5456.836294911159;5457.208704737791;5459.642319973188;5489.533389661844;5763;5776.942230577641;5803.7968671096305;5804.158397032406;5804.158397032491;5254.894902101936;5463.48096930791;5472.753726082336;5479.232907392969;5483.670979741229;3262.6411094779555;3298.1919429739387;3302.7119423424883;3308.983455082709;3310.3117410121013;5746.913796293059;6430.131932189188;6443.581167224115;6461.19235095613;6461.353864613501;5937.7921772737745;5943.851403714855;5963.19496867926;5978.622078525619;6009.399060093956;6033.7586496540525;6047.909281360783;6086.269647642312;6094.177286066324;6098.207233059674;5630.718464076862;5770.480656740746;5781.94218057814;5819.854503637443;5867;5750.568707346882;5753.424657534213;5772.971135144466;5796.333421656564;5798.507126894261;5940.762369505172;6051.394860513913;6064.0291905130125;6075.513958883367;6094.39056094387;4158.584141585818;4159.251334759772;4205.705600607928;4207;4234.661227101763;5711.572581652698;5747.655140691572;5755.366909639853;5784.623999440023;5798.59409841307;5471.917921231265;5593.8321850344555;5644.88710225785;5669.801556945487;5687.317521897398;5506.174073888948;5529.806456774155;5538.501534861882;5568;5576.498115169654;5289.841304760709;5461.644993075437;5470.343558772973;5479.547919801176;5539.556835453073;5274.855242084514;5526.55787536988;5529.861753456195;5548.167774833646;5567.610267281251;5464.508194262536;5522.66863988162;5530.6128570999645;5545.7781688732;5562.415946325577 05:31:54 INFO - PROCESS | 27691 | |5;yui.html;759.1156302907111;804.0552350987589;822.3667775812625;833.2167762303438;851.0383266908397;14569.344379502922;14976.775348369756;14995.700085998273;15002;15015.699686006274;12745;13785.897128229743;13821;13906.58280251594;14006.29968501576;680.7855525509474;690.278658801551;779.4037561265636;804.2038382001834;818.4925346285312;808.6239898447221;810.9837803243931;816.3265306122443;816.4937738602075;818.0469752738082;709.1702707831823;855.8758979947904;862.8403745307107;863.9934476335094;865.5672163918041;828.0849661124461;844.957752112395;848.719922425598;849.8385306791752;850.3494826457764;620.4632992461488;620.525298146918;620.5625034350771;621.1149112514694;621.1924498152384;14104.365303561364;14142.787858182135;14170.504032358922;14191.148531088167;14214.289285535682;13387.531436399679;13841.792373114411;14007.369668364847;14526.636834079127;14683.706325873529;11553.422328883522;11634.243774154738;11693.649190524298;11827.112966527546;11835.644930652094;3778.244351129785;3784.2620688965662;3788.9810550947345;3810.12367155553;3873.4770805941403;55859.162112568345;55911.44088559144;57317.42682573163;57566.42433575694;57772.71113644405;10833.483312336279;11022.338659680445;11155.776884462266;11173.944130279297;11197.664070077748;18076;18084.18621162051;18101.637967240582;18133.27466901309;18192.363267285582;8026.9966254218225;8292.59352819094;8328.292095171979;8438.198371154731;8479.745607631781;4574.679772415899;4597.172508948354;4616.584507394284;4625.953740462553;4717.740524271198;3150.401423729484;3204.599425071866;3211.5985501812274;3219.114743445571;3223.2747631782663;545.5989847462113;554.919536667181;564.7007086244297;589.8849724303719;656.7734131724548;629.3580547841176;643.6749441531996;664.6078813499962;701.7263267325746;753.1150897695186;8935.419197752126;9359.485228312507;9459.290553208399;9653.46905920181;9776.071273229032;665.311402698205;685.7867718470671;763.0902180753332;771.1016665584643;782.338923609549;4551.180787458223;4578.267477203632;4649.302604609268;4694.342792009122;4747.192977193886;58640;60431.69784151051;60831.39168608346;61134.694326528086;69084;55447;58128.70935645295;58474.7076264616;59355.703221483614;59935.400645993854;53956.46043539514;54817;55011.72494137584;55728.72135639377;56444;9938.552765125442;9972;10010.299279050396;10093.848592270975;10100.494975251355;31122.68877311198;32922.5061624071;36276.29849194441;36619.81690091533;37470.43794343033;46991;47159.764201178776;47368.763156183995;47458.52541474679;48331.27503087386;12188.634340969786;12300.200486968677;12791.616251512469;12961.09272350964;13040.739185216433;13269.933650331686;14311;14658.926705366404;15013.624659383602;15169.08985460876;13577.253251071286;13584.117032392864;13721.534159009429;14053.156810591398;14383;12914;13069.15050521713;13383.799243011168;13647.931760341135;14196.574102776933;13602.319884005563;13770.724585508435;14148.43406263779;14368.13791172533;14427.42290308418;11191.216614836883;11388.487518061873;11448.255863368855;11486.425678716198;11596.88403115958;11289.7742045157;11309.377984210947;11538.134639901873;11544;11578.884211157781 05:31:54 INFO - PROCESS | 27691 | __end_tp_report 05:31:54 INFO - PROCESS | 27691 | __start_cc_report 05:31:54 INFO - PROCESS | 27691 | _x_x_mozilla_cycle_collect,870 05:31:54 INFO - PROCESS | 27691 | __end_cc_report 05:31:54 INFO - PROCESS | 27691 | __startTimestamp1461846714361__endTimestamp 05:31:54 INFO - PROCESS | 27691 | 05:31:54 INFO - PROCESS | 27691 | ------- Summary: start ------- 05:31:54 INFO - PROCESS | 27691 | Number of tests: 6 05:31:54 INFO - PROCESS | 27691 | 05:31:54 INFO - PROCESS | 27691 | [#0] dojo.html Cycles:165 Average:5161.63 Median:5388.97 stddev:569.15 (10.6%) stddev-sans-first:546.49 05:31:54 INFO - PROCESS | 27691 | Values: 3059.8 3083.7 3091.5 3097.0 3132.2 5149.0 5196.1 5205.6 5222.1 5268.2 5187.3 5189.4 5248.2 5262.1 5295.4 4726.5 4729.9 4739.0 4766.2 4833.9 4786.5 4786.7 4810.5 4835.7 4861.9 4614.5 4703.8 4724.5 4758.7 4784.0 4740.7 4748.8 4756.6 4763.3 4789.6 4696.3 4721.7 4736.6 4740.8 4790.8 5105.7 5131.9 5149.6 5186.4 5190.6 5447.7 5451.6 5466.6 5471.2 5476.5 5481.2 5504.7 5512.8 5518.1 5569.5 5204.8 5209.2 5227.8 5240.4 5277.6 5653.0 5660.1 5666.5 5666.9 5686.2 5404.1 5455.3 5458.5 5473.5 5521.0 5449.7 5472.8 5475.4 5475.7 5492.6 5432.6 5436.6 5444.0 5449.2 5487.0 5390.0 5460.3 5577.6 5620.0 5633.6 4195.5 4202.3 4205.9 4206.2 4238.4 3765.4 3767.6 3781.8 3789.8 3793.5 5156.9 5234.9 5272.7 5309.1 5337.9 5606.7 5609.0 5621.4 5626.2 5628.7 5173.9 5279.7 5303.9 5307.5 5317.7 4774.2 4778.2 4788.1 4833.1 4837.6 5709.5 5710.5 5713.9 5715.7 5765.9 5481.4 5517.9 5521.3 5529.9 5619.3 5763.7 5767.9 5784.3 5803.9 5831.1 5388.3 5448.0 5454.3 5458.5 5460.6 5448.6 5556.2 5558.8 5565.7 5603.2 5416.8 5421.5 5421.8 5423.4 5453.8 5405.3 5405.8 5409.3 5411.2 5461.0 5208.8 5318.3 5366.6 5411.2 5456.8 5462.2 5465.5 5499.8 5499.9 5503.1 5380.7 5380.8 5383.3 5389.0 5389.4 05:31:54 INFO - PROCESS | 27691 | 05:31:54 INFO - PROCESS | 27691 | [#1] ext.html Cycles:180 Average:45750.44 Median:34054.23 stddev:76778.30 (225.5%) stddev-sans-first:76918.83 05:31:54 INFO - PROCESS | 27691 | Values: 598.1 644.8 657.7 658.3 669.6 33378.3 34041.3 34067.1 34122.0 37550.0 42048.8 42751.1 42883.4 43100.0 43187.6 8611.2 8838.8 8840.2 8844.7 8848.5 7633.7 7811.1 8653.8 9871.5 10133.6 10183.3 10313.1 10313.9 10319.7 10328.6 7655.4 10382.5 10449.0 10457.5 10458.2 9910.2 10084.7 10087.2 10091.5 10093.5 35957.6 36456.8 36603.0 36664.8 36755.0 3667.6 3681.6 3726.7 3744.7 3788.5 30995.4 31650.4 31799.7 32063.5 32177.4 4298.2 4316.2 4347.1 4367.0 4423.6 274677.0 279768.0 279989.0 280058.0 280536.0 59552.7 60797.7 60879.7 60955.4 60957.0 61664.7 63380.7 63468.7 63707.7 63880.4 16837.7 17135.4 17151.1 17164.8 17178.1 13073.1 13213.2 13216.0 13220.3 13226.8 19307.6 19525.5 19790.9 19829.2 19845.9 7477.3 7576.2 7587.2 7593.7 7671.3 1024.9 1043.9 1046.0 1117.0 1122.8 30665.8 31090.7 31206.8 31307.7 31749.4 1113.9 1119.5 1137.5 1139.6 1148.3 15783.4 16298.7 16513.8 16701.4 16738.7 372318.0 375686.0 376718.0 376955.0 377071.0 53787.0 54365.5 54433.7 54452.5 54528.0 1306.7 1401.3 1427.9 1448.9 1479.8 25757.4 26578.0 26920.2 27277.0 27407.0 37831.0 38085.8 38429.4 38441.0 38590.2 192417.0 194107.0 194487.0 194732.0 195032.0 23311.2 25918.2 26282.6 26293.9 26314.7 41525.0 44994.3 45768.3 45821.5 46048.8 38481.6 38898.0 39151.6 40085.2 40236.6 37674.0 38488.3 38500.4 38602.0 39289.4 36083.3 37070.8 37564.6 38034.0 38748.4 31435.8 32068.2 32664.0 32690.3 33054.7 25478.6 25671.6 25733.0 25792.2 25809.9 05:31:54 INFO - PROCESS | 27691 | 05:31:54 INFO - PROCESS | 27691 | [#2] jquery.html Cycles:180 Average:27364.28 Median:3206.53 stddev:73894.42 (2304.5%) stddev-sans-first:74073.95 05:31:54 INFO - PROCESS | 27691 | Values: 386.3 390.4 390.8 394.0 401.3 13856.1 14162.6 17042.9 17471.6 17547.0 16770.3 17538.6 17581.3 18700.3 19480.3 6039.7 6186.7 6200.9 6226.0 6229.5 4437.5 6185.6 6228.9 6573.2 6899.8 6856.7 6879.3 6905.3 6909.4 6912.8 6857.8 6929.7 6943.4 6955.4 6957.9 6393.6 6489.9 6687.1 6687.4 6699.5 23832.8 24114.6 24131.9 24144.0 24597.8 2451.7 2493.8 3074.4 3207.4 3273.1 14234.0 14263.3 14725.9 14729.9 14737.8 2082.6 2107.4 2133.7 2147.1 2211.8 53102.7 59076.4 63474.7 81509.6 84431.2 15986.4 16887.8 16948.9 17140.6 17208.8 29654.3 29707.9 30009.8 30091.8 30195.0 9663.0 9976.2 10043.3 10117.5 10225.9 8393.4 8412.1 8595.1 8694.8 8703.7 8523.8 8661.7 8724.8 8847.6 8938.3 3205.7 3279.7 3290.5 3337.7 3471.2 941.2 998.1 1022.2 1030.4 1049.0 17767.6 18040.0 18073.0 18287.2 18437.7 994.2 998.5 1005.2 1028.8 1048.5 9058.5 10461.9 10481.3 10540.4 10613.9 439057.8 444740.0 455323.0 457747.0 461009.0 73765.0 75530.6 76775.0 78043.6 78071.6 892.6 974.1 1024.9 1031.5 1033.4 15922.0 16148.0 16275.7 16679.3 16690.2 26494.9 28213.9 32625.8 34831.3 35210.8 43252.6 44888.1 47819.3 49428.8 49960.5 8441.5 8447.2 8470.7 8696.6 8801.7 10503.6 12666.5 12835.2 12852.4 12942.4 10849.4 11170.9 11185.9 11306.8 11601.7 11006.1 11145.8 11332.5 11351.9 11380.0 11477.9 11500.9 11550.9 11559.9 11648.7 8430.2 8475.5 8559.8 8578.6 8675.3 8767.1 10739.8 11452.7 11594.9 11617.5 05:31:54 INFO - PROCESS | 27691 | 05:31:54 INFO - PROCESS | 27691 | [#3] mootools.html Cycles:180 Average:5405.41 Median:4797.27 stddev:3001.36 (62.6%) stddev-sans-first:2994.26 05:31:54 INFO - PROCESS | 27691 | Values: 1344.5 1492.9 1502.7 1637.4 1721.5 7115.1 7852.7 8037.4 8046.2 8056.6 7736.9 7881.0 7896.7 7898.2 7898.3 1954.2 2187.4 2211.5 2233.1 2243.1 2205.5 2207.8 2227.9 2228.1 2229.8 2172.8 2192.2 2197.1 2202.3 2210.5 1904.5 2153.1 2163.3 2214.5 2217.5 2215.6 2231.3 2238.6 2240.6 2241.1 7858.9 7874.1 7902.9 7906.1 7909.2 4602.2 4768.5 4793.4 4794.5 4800.0 3069.2 3105.2 3257.1 3261.1 3265.1 1083.9 1120.9 1128.9 1130.5 1142.6 11239.1 11240.8 11263.1 11268.7 11273.8 4288.7 4390.2 4415.5 4455.6 4459.5 9448.4 9555.0 9566.3 9580.4 9584.2 4734.7 4843.7 4849.4 4851.6 4853.2 3981.4 4387.6 4485.9 4491.0 4495.3 3582.0 3630.4 3645.6 3647.4 3710.6 1167.5 1170.4 1174.6 1178.5 1186.2 890.0 978.0 986.7 1019.3 1023.1 5507.4 5660.3 5673.2 5719.3 5844.8 1010.6 1031.6 1053.5 1091.4 1093.2 3912.4 3937.7 3948.9 3968.9 3985.0 9789.5 10143.5 10250.8 10277.8 10287.1 10052.1 10091.5 10145.0 10154.4 10169.5 7578.0 7796.1 7820.8 7823.6 7825.6 5702.8 5762.5 5780.3 5896.8 5916.3 9320.8 9423.8 9464.0 9466.1 9490.7 8908.1 9274.9 9286.6 9299.7 9307.0 6610.2 6914.7 7060.0 7098.7 7294.5 7821.6 7844.8 7906.5 7920.4 7941.0 7073.5 7306.1 7323.6 7340.9 7474.9 6998.9 7118.4 7136.4 7169.4 7260.1 6521.2 6570.4 6609.8 6625.0 6625.8 4952.9 4988.3 5055.6 5076.8 5135.5 5015.9 5079.2 5107.8 5168.4 5274.0 05:31:54 INFO - PROCESS | 27691 | 05:31:54 INFO - PROCESS | 27691 | [#4] prototype.html Cycles:180 Average:4735.46 Median:5390.68 stddev:1393.25 (25.8%) stddev-sans-first:1357.32 05:31:54 INFO - PROCESS | 27691 | Values: 328.1 334.1 334.2 339.3 339.9 5305.0 5357.8 5387.1 5394.2 5408.6 5268.9 5278.7 5325.3 5331.6 5349.7 3964.2 3997.5 4082.9 4130.4 4149.8 4134.4 4141.0 4141.4 4144.2 4150.4 3946.7 4100.2 4102.7 4116.6 4125.4 3884.3 3979.1 4047.4 4095.9 4096.2 3585.8 3588.1 3589.8 3602.3 3602.6 5083.4 5105.3 5113.4 5116.0 5156.4 4600.5 4680.7 4687.1 4691.9 4692.4 5492.0 5496.7 5503.3 5511.1 5548.7 3955.7 3958.5 3970.5 3978.4 3985.6 5680.9 5752.0 5766.9 5769.9 5776.7 4077.6 4090.9 4102.2 4109.7 4130.2 4161.5 4167.1 4167.7 4168.4 4171.5 4609.9 4696.2 4703.7 4708.5 4746.1 5533.0 5567.7 5570.5 5578.0 5603.2 1511.9 1523.2 1533.2 1534.0 1537.3 968.3 1009.9 1010.8 1031.3 1056.4 5327.4 5456.8 5457.2 5459.6 5489.5 5763.0 5776.9 5803.8 5804.2 5804.2 5254.9 5463.5 5472.8 5479.2 5483.7 3262.6 3298.2 3302.7 3309.0 3310.3 5746.9 6430.1 6443.6 6461.2 6461.4 5937.8 5943.9 5963.2 5978.6 6009.4 6033.8 6047.9 6086.3 6094.2 6098.2 5630.7 5770.5 5781.9 5819.9 5867.0 5750.6 5753.4 5773.0 5796.3 5798.5 5940.8 6051.4 6064.0 6075.5 6094.4 4158.6 4159.3 4205.7 4207.0 4234.7 5711.6 5747.7 5755.4 5784.6 5798.6 5471.9 5593.8 5644.9 5669.8 5687.3 5506.2 5529.8 5538.5 5568.0 5576.5 5289.8 5461.6 5470.3 5479.5 5539.6 5274.9 5526.6 5529.9 5548.2 5567.6 5464.5 5522.7 5530.6 5545.8 5562.4 05:31:54 INFO - PROCESS | 27691 | 05:31:54 INFO - PROCESS | 27691 | [#5] yui.html Cycles:180 Average:15404.07 Median:4587.72 stddev:17849.31 (389.1%) stddev-sans-first:17865.50 05:31:54 INFO - PROCESS | 27691 | Values: 759.1 804.1 822.4 833.2 851.0 14569.3 14976.8 14995.7 15002.0 15015.7 12745.0 13785.9 13821.0 13906.6 14006.3 680.8 690.3 779.4 804.2 818.5 808.6 811.0 816.3 816.5 818.0 709.2 855.9 862.8 864.0 865.6 828.1 845.0 848.7 849.8 850.3 620.5 620.5 620.6 621.1 621.2 14104.4 14142.8 14170.5 14191.1 14214.3 13387.5 13841.8 14007.4 14526.6 14683.7 11553.4 11634.2 11693.6 11827.1 11835.6 3778.2 3784.3 3789.0 3810.1 3873.5 55859.2 55911.4 57317.4 57566.4 57772.7 10833.5 11022.3 11155.8 11173.9 11197.7 18076.0 18084.2 18101.6 18133.3 18192.4 8027.0 8292.6 8328.3 8438.2 8479.7 4574.7 4597.2 4616.6 4626.0 4717.7 3150.4 3204.6 3211.6 3219.1 3223.3 545.6 554.9 564.7 589.9 656.8 629.4 643.7 664.6 701.7 753.1 8935.4 9359.5 9459.3 9653.5 9776.1 665.3 685.8 763.1 771.1 782.3 4551.2 4578.3 4649.3 4694.3 4747.2 58640.0 60431.7 60831.4 61134.7 69084.0 55447.0 58128.7 58474.7 59355.7 59935.4 53956.5 54817.0 55011.7 55728.7 56444.0 9938.6 9972.0 10010.3 10093.8 10100.5 31122.7 32922.5 36276.3 36619.8 37470.4 46991.0 47159.8 47368.8 47458.5 48331.3 12188.6 12300.2 12791.6 12961.1 13040.7 13269.9 14311.0 14658.9 15013.6 15169.1 13577.3 13584.1 13721.5 14053.2 14383.0 12914.0 13069.2 13383.8 13647.9 14196.6 13602.3 13770.7 14148.4 14368.1 14427.4 11191.2 11388.5 11448.3 11486.4 11596.9 11289.8 11309.4 11538.1 11544.0 11578.9 05:31:54 INFO - PROCESS | 27691 | -------- Summary: end -------- 05:31:54 INFO - PROCESS | 27691 | 05:31:55 INFO - TEST-INFO | 27691: exit 0 05:31:55 INFO - TEST-OK | dromaeo_css | took 1112437ms 05:31:55 INFO - TEST-START | kraken 05:31:55 INFO - operating with platform_type : linux_ 05:31:55 INFO - Initialising browser for kraken test... 05:31:55 INFO - TEST-INFO | started process 27876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm6nVFB/profile http://localhost:59553/getInfo.html) 05:31:59 INFO - PROCESS | 27876 | __metrics Screen width/height:1600/1200 05:31:59 INFO - PROCESS | 27876 | colorDepth:24 05:31:59 INFO - PROCESS | 27876 | Browser inner width/height: 1024/697 05:31:59 INFO - PROCESS | 27876 | __metrics 05:32:00 ERROR - PROCESS | 27876 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:32:00 INFO - TEST-INFO | 27876: exit 0 05:32:00 INFO - Browser initialized. 05:32:00 INFO - Running cycle 1/1 for kraken test... 05:32:00 INFO - TEST-INFO | started process 27957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm6nVFB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:12 INFO - PROCESS | 27957 | RSS: Main: 154529792 05:32:12 INFO - PROCESS | 27957 | 05:32:15 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59553/tests/kraken/driver.html?testName=audio-beat-detection) 05:32:16 INFO - PROCESS | 27957 | RSS: Main: 208855040 05:32:16 INFO - PROCESS | 27957 | 05:32:18 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59553/tests/kraken/driver.html?testName=audio-dft) 05:32:19 INFO - PROCESS | 27957 | RSS: Main: 194686976 05:32:19 INFO - PROCESS | 27957 | 05:32:22 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59553/tests/kraken/driver.html?testName=audio-fft) 05:32:22 INFO - PROCESS | 27957 | RSS: Main: 264249344 05:32:22 INFO - PROCESS | 27957 | 05:32:24 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59553/tests/kraken/driver.html?testName=audio-oscillator) 05:32:25 INFO - PROCESS | 27957 | RSS: Main: 173768704 05:32:25 INFO - PROCESS | 27957 | 05:32:27 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:32:28 INFO - PROCESS | 27957 | RSS: Main: 178626560 05:32:28 INFO - PROCESS | 27957 | 05:32:31 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59553/tests/kraken/driver.html?testName=imaging-darkroom) 05:32:31 INFO - PROCESS | 27957 | RSS: Main: 214126592 05:32:31 INFO - PROCESS | 27957 | 05:32:35 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59553/tests/kraken/driver.html?testName=imaging-desaturate) 05:32:35 INFO - PROCESS | 27957 | RSS: Main: 214618112 05:32:35 INFO - PROCESS | 27957 | 05:32:38 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59553/tests/kraken/driver.html?testName=json-parse-financial) 05:32:39 INFO - PROCESS | 27957 | RSS: Main: 215502848 05:32:39 INFO - PROCESS | 27957 | 05:32:40 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:32:41 INFO - PROCESS | 27957 | RSS: Main: 201424896 05:32:41 INFO - PROCESS | 27957 | 05:32:43 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59553/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:32:43 INFO - PROCESS | 27957 | RSS: Main: 204533760 05:32:43 INFO - PROCESS | 27957 | 05:32:45 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:32:46 INFO - PROCESS | 27957 | RSS: Main: 215490560 05:32:46 INFO - PROCESS | 27957 | 05:32:48 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:32:49 INFO - PROCESS | 27957 | RSS: Main: 223817728 05:32:49 INFO - PROCESS | 27957 | 05:32:52 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:32:53 INFO - PROCESS | 27957 | RSS: Main: 220274688 05:32:53 INFO - PROCESS | 27957 | 05:32:54 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:59553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59553/tests/kraken/driver.html?testName=ai-astar) 05:32:55 INFO - PROCESS | 27957 | RSS: Main: 284262400 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | __start_tp_report 05:32:55 INFO - PROCESS | 27957 | _x_x_mozilla_page_load 05:32:55 INFO - PROCESS | 27957 | _x_x_mozilla_page_load_details 05:32:55 INFO - PROCESS | 27957 | |i|pagename|runs| 05:32:55 INFO - PROCESS | 27957 | |0;ai-astar;111;112;106;110;112;113;101;111;110;110 05:32:55 INFO - PROCESS | 27957 | |1;audio-beat-detection;156;129;153;180;133;149;157;128;185;128 05:32:55 INFO - PROCESS | 27957 | |2;audio-dft;162;161;159;159;160;160;161;162;162;161 05:32:55 INFO - PROCESS | 27957 | |3;audio-fft;73;74;113;111;73;72;74;132;100;74 05:32:55 INFO - PROCESS | 27957 | |4;audio-oscillator;92;93;153;92;93;92;148;93;91;161 05:32:55 INFO - PROCESS | 27957 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;117;116 05:32:55 INFO - PROCESS | 27957 | |6;imaging-darkroom;146;145;145;144;145;145;145;145;145;145 05:32:55 INFO - PROCESS | 27957 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;95;95 05:32:55 INFO - PROCESS | 27957 | |8;json-parse-financial;56;57;57;57;56;57;55;76;54;56 05:32:55 INFO - PROCESS | 27957 | |9;json-stringify-tinderbox;60;62;61;61;61;61;62;62;64;61 05:32:55 INFO - PROCESS | 27957 | |10;stanford-crypto-aes;76;76;77;76;76;76;76;77;77;76 05:32:55 INFO - PROCESS | 27957 | |11;stanford-crypto-ccm;130;125;125;127;124;136;124;125;166;126 05:32:55 INFO - PROCESS | 27957 | |12;stanford-crypto-pbkdf2;197;201;195;194;195;191;200;195;197;199 05:32:55 INFO - PROCESS | 27957 | |13;stanford-crypto-sha256-iterative;73;69;70;69;69;70;68;70;68;67 05:32:55 INFO - PROCESS | 27957 | __end_tp_report 05:32:55 INFO - PROCESS | 27957 | __start_cc_report 05:32:55 INFO - PROCESS | 27957 | _x_x_mozilla_cycle_collect,1650 05:32:55 INFO - PROCESS | 27957 | __end_cc_report 05:32:55 INFO - PROCESS | 27957 | __startTimestamp1461846775102__endTimestamp 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | ------- Summary: start ------- 05:32:55 INFO - PROCESS | 27957 | Number of tests: 14 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.57 (3.2%) stddev-sans-first:3.75 05:32:55 INFO - PROCESS | 27957 | Values: 111.0 112.0 106.0 110.0 112.0 113.0 101.0 111.0 110.0 110.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.50 stddev:20.86 (13.5%) stddev-sans-first:22.01 05:32:55 INFO - PROCESS | 27957 | Values: 156.0 129.0 153.0 180.0 133.0 149.0 157.0 128.0 185.0 128.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 05:32:55 INFO - PROCESS | 27957 | Values: 162.0 161.0 159.0 159.0 160.0 160.0 161.0 162.0 162.0 161.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#3] audio-fft Cycles:10 Average:89.60 Median:73.00 stddev:22.37 (30.6%) stddev-sans-first:22.90 05:32:55 INFO - PROCESS | 27957 | Values: 73.0 74.0 113.0 111.0 73.0 72.0 74.0 132.0 100.0 74.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:92.00 stddev:29.98 (32.6%) stddev-sans-first:31.01 05:32:55 INFO - PROCESS | 27957 | Values: 92.0 93.0 153.0 92.0 93.0 92.0 148.0 93.0 91.0 161.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:32:55 INFO - PROCESS | 27957 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 05:32:55 INFO - PROCESS | 27957 | Values: 146.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:32:55 INFO - PROCESS | 27957 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.00 stddev:6.37 (11.2%) stddev-sans-first:6.71 05:32:55 INFO - PROCESS | 27957 | Values: 56.0 57.0 57.0 57.0 56.0 57.0 55.0 76.0 54.0 56.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:1.08 (1.8%) stddev-sans-first:1.00 05:32:55 INFO - PROCESS | 27957 | Values: 60.0 62.0 61.0 61.0 61.0 61.0 62.0 62.0 64.0 61.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 05:32:55 INFO - PROCESS | 27957 | Values: 76.0 76.0 77.0 76.0 76.0 76.0 76.0 77.0 77.0 76.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:126.50 stddev:12.90 (10.2%) stddev-sans-first:13.68 05:32:55 INFO - PROCESS | 27957 | Values: 130.0 125.0 125.0 127.0 124.0 136.0 124.0 125.0 166.0 126.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.40 Median:197.00 stddev:3.03 (1.5%) stddev-sans-first:3.20 05:32:55 INFO - PROCESS | 27957 | Values: 197.0 201.0 195.0 194.0 195.0 191.0 200.0 195.0 197.0 199.0 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - PROCESS | 27957 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.64 (2.4%) stddev-sans-first:1.05 05:32:55 INFO - PROCESS | 27957 | Values: 73.0 69.0 70.0 69.0 69.0 70.0 68.0 70.0 68.0 67.0 05:32:55 INFO - PROCESS | 27957 | -------- Summary: end -------- 05:32:55 INFO - PROCESS | 27957 | 05:32:55 INFO - TEST-INFO | 27957: exit 0 05:32:56 INFO - TEST-OK | kraken | took 61006ms 05:32:56 INFO - SUITE-END | took 1173s 05:32:56 INFO - Completed test suite (00:19:33) 05:32:56 INFO - javascript benchmark 05:32:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.7705172112096, 3083.6607973122955, 3091.5208142737883, 3096.9535456968133, 3132.169974956636, 5149.047426226141, 5196.090684130271, 5205.609579281555, 5222.060029194743, 5268.209768534722, 5187.325647665808, 5189.351331083614, 5248.212768084789, 5262.131748261532, 5295.443978382272, 4726.480087190406, 4729.858104256878, 4739.0048089901165, 4766.165920963835, 4833.854984350475, 4786.473487916326, 4786.688865223749, 4810.518948105179, 4835.661503694742, 4861.927071093936, 4614.5385461453925, 4703.835365762182, 4724.503927087675, 4758.690685105457, 4783.976080119594, 4740.668153229275, 4748.833790817304, 4756.6432517561325, 4763.333133361332, 4789.568938795525, 4696.319033740088, 4721.740304283263, 4736.6447516436065, 4740.762961851928, 4790.784414701347, 5105.719185444799, 5131.948680513222, 5149.588032957355, 5186.40356359016, 5190.558802501791, 5447.6731396115965, 5451.64564303319, 5466.590005749585, 5471.23402723619, 5476.452354764531, 5481.205225242357, 5504.724763761836, 5512.834614961557, 5518.117101263819, 5569.526590239834, 5204.843854684365, 5209.166533354645, 5227.764750586232, 5240.371155461331, 5277.6305658603915, 5653.0, 5660.122680984454, 5666.546676265889, 5666.886662266732, 5686.232358631614, 5404.135338345845, 5455.318085239345, 5458.536024437967, 5473.480019398151, 5521.0, 5449.673019618756, 5472.753726082336, 5475.397706252309, 5475.698836563947, 5492.598060731882, 5432.639649507182, 5436.619436639477, 5443.972780136074, 5449.209864569615, 5486.972565137228, 5389.973050134724, 5460.290162278958, 5577.553795696415, 5620.016497112989, 5633.57748168889, 4195.49654041517, 4202.285611446062, 4205.873823785291, 4206.158768246363, 4238.427812245307, 3765.4351847223134, 3767.585565587783, 3781.829817658212, 3789.791561464146, 3793.525809273841, 5156.948430515647, 5234.92147617786, 5272.657277276965, 5309.070912590359, 5337.946620533745, 5606.747696353674, 5609.0, 5621.381648018714, 5626.156076588462, 5628.746706398222, 5173.948260517422, 5279.709615971082, 5303.920441193385, 5307.522322990872, 5317.654352467154, 4774.212254977959, 4778.1638213312535, 4788.11419887322, 4833.081714474309, 4837.588804951619, 5709.486146246858, 5710.543156547466, 5713.942860571424, 5715.714214289269, 5765.88468230633, 5481.3970463248215, 5517.944820551743, 5521.282233309805, 5529.861753456195, 5619.297587801525, 5763.740631671669, 5767.884642307215, 5784.2769653793275, 5803.941960580509, 5831.096180092092, 5388.272583201375, 5448.0, 5454.3454785426, 5458.4814442627885, 5460.563154947674, 5448.564114870722, 5556.16657501378, 5558.777648894161, 5565.7217139143695, 5603.2155498231095, 5416.83749487516, 5421.512063914267, 5421.783128674809, 5423.403425623257, 5453.754581043783, 5405.270288511001, 5405.78376864921, 5409.269748584048, 5411.242426060433, 5460.972695136499, 5208.817691380784, 5318.255444237732, 5366.570674345965, 5411.1883217516115, 5456.809011684572, 5462.153366228082, 5465.480779325958, 5499.752511136929, 5499.890002199853, 5503.064479038653, 5380.650257733391, 5380.811671591476, 5383.273258110105, 5388.973055134699, 5389.353277606712], "value": 5124.457207144486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.1267349669482, 644.764660898772, 657.6645910585602, 658.2923357390803, 669.6383952665561, 33378.33243335135, 34041.31917361651, 34067.14832129195, 34121.976340709785, 37550.0, 42048.78975605118, 42751.14497710044, 42883.35674964878, 43100.0, 43187.56812431875, 8611.224989750906, 8838.823223535526, 8840.160184782435, 8844.73465796027, 8848.46909185451, 7633.694652213905, 7811.140774514799, 8653.783655408602, 9871.506424678737, 10133.645322413717, 10183.33808302458, 10313.07182353588, 10313.896861031406, 10319.742006449862, 10328.58685652573, 7655.387568994523, 10382.480875956171, 10449.0, 10457.4771261437, 10458.163346932228, 9910.20718342531, 10084.69745907624, 10087.243456740774, 10091.49542522871, 10093.495325233782, 35957.64042359595, 36456.817715911515, 36603.0, 36664.816675916714, 36755.0, 3667.559892812853, 3681.5582130144285, 3726.6646001859963, 3744.7378683492166, 3788.469614253979, 30995.380092398253, 31650.36699266025, 31799.682003179903, 32063.51904721408, 32177.356452871045, 4298.20483210607, 4316.223079845627, 4347.130573885235, 4366.956330436687, 4423.5576442355505, 274677.0, 279768.0, 279989.0, 280058.0, 280536.0, 59552.70223648854, 60797.696011520544, 60879.69560152171, 60955.39044609586, 60957.0, 61664.69167654133, 63380.68309658515, 63468.682656586425, 63707.681461592394, 63880.361196388374, 16837.663246734995, 17135.400260990806, 17151.142442877805, 17164.828351716573, 17178.055206963738, 13073.084884058024, 13213.207207567577, 13216.0, 13220.33898305081, 13226.801597976038, 19307.613847722965, 19525.511862203275, 19790.901045494968, 19829.20683172657, 19845.900770496344, 7477.289657482531, 7576.204498527685, 7587.2412758723685, 7593.6582853771715, 7671.309582137635, 1024.8718910136233, 1043.9373637581618, 1045.994770026145, 1117.044926587772, 1122.7754449110212, 30665.84667076695, 31090.68909310923, 31206.843965780026, 31307.686923130932, 31749.365012699618, 1113.9443027848574, 1119.468252580018, 1137.4653912661036, 1139.641013080877, 1148.2995372822572, 15783.368665253261, 16298.67402651964, 16513.752293715603, 16701.415450459175, 16738.66522669564, 372318.0, 375686.0, 376718.0, 376955.0, 377071.0, 53787.0, 54365.45634543683, 54433.72783136059, 54452.45547544553, 54528.0, 1306.6667999660026, 1401.2783416540285, 1427.8857691384665, 1448.9420423182955, 1479.8002269693668, 25757.35606609775, 26578.0, 26920.192394228205, 27277.0, 27407.0, 37831.0, 38085.80957095197, 38429.4235586472, 38441.0, 38590.228195436495, 192417.0, 194107.0, 194487.0, 194732.0, 195032.0, 23311.18410855612, 25918.222453325678, 26282.60576091322, 26293.948242070866, 26314.736852631228, 41525.0, 44994.3250851244, 45768.31347529723, 45821.4798186103, 46048.76975615101, 38481.615183848924, 38898.0, 39151.608483914795, 40085.19829603333, 40236.59763402329, 37674.0, 38488.26802793937, 38500.42249366318, 38602.0, 39289.41065884071, 36083.278334433686, 37070.8146459266, 37564.62435375611, 38034.0, 38748.41877371785, 31435.84282078575, 32068.19829504188, 32664.020079397655, 32690.34619307553, 33054.669453305156, 25478.617820733074, 25671.614925775753, 25733.0, 25792.226233213034, 25809.870950645127], "value": 18954.311105715376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.312363992094, 390.43192155413857, 390.8456159816872, 394.03181110353785, 401.289717200555, 13856.099353542013, 14162.64593385166, 17042.91478542607, 17471.563210919718, 17547.03491307979, 16770.329186832543, 17538.649227015452, 17581.29674813009, 18700.345487907925, 19480.34417074547, 6039.72821223045, 6186.659733714644, 6200.87598248037, 6226.0, 6229.532785041118, 4437.489688685794, 6185.56701030928, 6228.941080016385, 6573.211214654249, 6899.793006209797, 6856.691448884812, 6879.346462086119, 6905.309469053104, 6909.412699920513, 6912.792616221522, 6857.828554286133, 6929.653517324164, 6943.375096241362, 6955.374016338528, 6957.930420695779, 6393.584417012926, 6489.870202595969, 6687.097241872382, 6687.364700353459, 6699.497537684644, 23832.76167238323, 24114.638280425806, 24131.879340603362, 24144.034238630433, 24597.754022459903, 2451.705795304575, 2493.800495960319, 3074.369754200406, 3207.3585282943504, 3273.099897528175, 14234.003619746622, 14263.286835658279, 14725.926370368186, 14729.92635036818, 14737.778933316009, 2082.5730725201297, 2107.4309936317263, 2133.6586146216687, 2147.076756994492, 2211.7788221177916, 53102.73448632771, 59076.40923590795, 63474.68262658703, 81509.59245203795, 84431.15568844356, 15986.440474583567, 16887.831121688625, 16948.864460074925, 17140.571485712706, 17208.827911720724, 29654.258643534085, 29707.851460742557, 30009.849950750107, 30091.849540752155, 30195.0, 9663.03369663028, 9976.201903847676, 10043.347182433119, 10117.494125293853, 10225.94887025575, 8393.412461127784, 8412.116727743622, 8595.054544000155, 8694.826103477895, 8703.651853925772, 8523.786905327417, 8661.65744309633, 8724.78188045304, 8847.557622118868, 8938.329625278131, 3205.6954589313978, 3279.67173294816, 3290.5393244945726, 3337.7496687748517, 3471.218975730491, 941.1764705882352, 998.1066945084254, 1022.197574903697, 1030.4281123976116, 1049.0296475759892, 17767.555811104827, 18040.0, 18073.0, 18287.177077031567, 18437.7234341485, 994.229472159068, 998.5157198758596, 1005.1657124586576, 1028.7890982348601, 1048.5072016152396, 9058.456492610465, 10461.895381046244, 10481.266311358284, 10540.367577945348, 10613.9469302653, 439057.7598594915, 444740.0, 455323.0, 457747.0, 461009.0, 73765.0, 75530.62234688901, 76775.0, 78043.60978195073, 78071.60964195142, 892.6206362296128, 974.0892265731563, 1024.9231307651955, 1031.51003273446, 1033.4109557552124, 15922.0, 16148.031118132949, 16275.674486509966, 16679.332826686797, 16690.16549172561, 26494.86752566225, 28213.858930705213, 32625.836870816445, 34831.30337393289, 35210.8239458801, 43252.56747432611, 44888.10223795571, 47819.28271075867, 49428.752856235486, 49960.500394995586, 8441.451305665112, 8447.155284471504, 8470.745877623682, 8696.608652610521, 8801.691940782042, 10503.579856805642, 12666.493340266286, 12835.229886206858, 12852.421641026363, 12942.352882355655, 10849.403282819205, 11170.888291116984, 11185.944070279596, 11306.773864522827, 11601.709957251136, 11006.119510439306, 11145.777084458428, 11332.546698131982, 11351.943240283746, 11380.0, 11477.94261028723, 11500.884991149982, 11550.88449115498, 11559.884401155881, 11648.650540483799, 8430.199131082538, 8475.480009766967, 8559.786005349915, 8578.571071446278, 8675.30597552207, 8767.079456657215, 10739.838902416313, 11452.713682158013, 11594.88405115938, 11617.47721352558], "value": 9840.78748032826, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.4958140697238, 1492.9477468288605, 1502.6994601079784, 1637.35324546804, 1721.5093698295989, 7115.146182458106, 7852.725154619589, 8037.437379383431, 8046.235607617267, 8056.63745131469, 7736.883946740803, 7881.0, 7896.684132634702, 7898.249666281708, 7898.328642065431, 1954.15971132413, 2187.4203336115943, 2211.513467037249, 2233.0955962834996, 2243.1251811793413, 2205.52581195043, 2207.7902599253043, 2227.94430139247, 2228.0864845413385, 2229.843910926236, 2172.804447599716, 2192.199847055821, 2197.099189332374, 2202.284257616273, 2210.546837898235, 1904.476269026022, 2153.12798316682, 2163.3401812447196, 2214.534947660993, 2217.5343177932655, 2215.6233440315186, 2231.263682984611, 2238.5746708125403, 2240.574290884743, 2241.081156725751, 7858.921410785876, 7874.094479134916, 7902.881456778153, 7906.090799558009, 7909.169537198569, 4602.217623004098, 4768.475467698585, 4793.400824896888, 4794.544518270759, 4800.0, 3069.217349575844, 3105.161606366291, 3257.1205774441005, 3261.1357990132633, 3265.1184180271193, 1083.9295445796, 1120.8542889424405, 1128.949197286124, 1130.4573804573768, 1142.5601143559707, 11239.100871930308, 11240.831387529193, 11263.098952083814, 11268.718282042933, 11273.830892536618, 4288.721233119837, 4390.1878152541885, 4415.536368681306, 4455.554444555583, 4459.509453960061, 9448.433094014381, 9555.0, 9566.330356874952, 9580.377275477073, 9584.233261339215, 4734.715917044989, 4843.685160464559, 4849.442314133919, 4851.58761505276, 4853.150698627726, 3981.3629819229363, 4387.605115539617, 4485.887852803706, 4490.955090449119, 4495.325701144789, 3582.0, 3630.43728222126, 3645.5989841117457, 3647.361711700442, 3710.573284072312, 1167.4512978899904, 1170.3855475875234, 1174.565410797993, 1178.4814681540095, 1186.187461588797, 889.9644014239358, 977.9926675524222, 986.6546708651914, 1019.2966852871494, 1023.0536753503129, 5507.366652834895, 5660.29246344207, 5673.234113394721, 5719.28508936383, 5844.766209351664, 1010.6361709784471, 1031.5564307347763, 1053.546974800843, 1091.3615534912008, 1093.1855767453299, 3912.4326972588815, 3937.7243592948794, 3948.9210215796097, 3968.900777480586, 3985.0, 9789.46157961319, 10143.543540540693, 10250.794984100276, 10277.794444111076, 10287.125594324567, 10052.145567626834, 10091.545880435398, 10145.03622155894, 10154.441505717257, 10169.491525423848, 7577.962110189414, 7796.064472263365, 7820.843583128306, 7823.647935842901, 7825.591393549102, 5702.7718891243885, 5762.539505298951, 5780.277465316835, 5896.823095307148, 5916.26046744157, 9320.813583728423, 9423.811523769624, 9463.952680236554, 9466.05339466048, 9490.715278541655, 8908.064653211579, 9274.907250927405, 9286.582103805209, 9299.72100836976, 9306.953465232631, 6610.206775187008, 6914.723411063501, 7059.964700176466, 7098.716051357887, 7294.489385742947, 7821.648025838965, 7844.803879903048, 7906.52560846351, 7920.405969552422, 7941.047074351115, 7073.469489788184, 7306.086739157606, 7323.560586364835, 7340.853182936418, 7474.850502990019, 6998.860022799414, 7118.394936430254, 7136.393406560501, 7169.426445884421, 7260.128784545888, 6521.152250207443, 6570.375814297634, 6609.768658096944, 6624.966875165594, 6625.834354141185, 4952.925706114339, 4988.251762235548, 5055.646104772631, 5076.847694569169, 5135.486451354835, 5015.899682006412, 5079.238114282887, 5107.770150343169, 5168.3797944246935, 5274.0], "value": 4381.429406763073, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.1010032510921, 334.0512943241195, 334.1762555301183, 339.2942679227208, 339.8691503771049, 5305.018571564264, 5357.785688572458, 5387.138057910735, 5394.219907430548, 5408.5943554233445, 5268.920966185501, 5278.6568873023225, 5325.3077099976945, 5331.600129990256, 5349.679019258847, 3964.235915017818, 3997.5202975642965, 4082.8979275518054, 4130.442390277319, 4149.813258403364, 4134.359174327984, 4140.958590414088, 4141.358089496133, 4144.21259960608, 4150.418941348214, 3946.6645335146545, 4100.2209580179815, 4102.733322334054, 4116.567760385146, 4125.391097471988, 3884.2520865610586, 3979.149336234174, 4047.392891066349, 4095.8566450174103, 4096.160287141129, 3585.8386372613295, 3588.1209103769484, 3589.838457269429, 3602.2795440911923, 3602.5676918769655, 5083.440821509631, 5105.285260063594, 5113.39216999333, 5115.974420127875, 5156.432792392834, 4600.539946005372, 4680.742559159245, 4687.10944920464, 4691.920858202632, 4692.389989301403, 5491.972540137273, 5496.6701997880255, 5503.257060296889, 5511.12621708617, 5548.72256387179, 3955.655077273712, 3958.485396898385, 3970.5433875104445, 3978.4430179774854, 3985.621365970228, 5680.8863822723315, 5752.0, 5766.913496297559, 5769.913451298234, 5776.6534007959235, 4077.5922407758985, 4090.9386359204636, 4102.174532333083, 4109.712320137562, 4130.173965206971, 4161.500619925568, 4167.1040726244, 4167.666586673059, 4168.374743788396, 4171.478565179353, 4609.861704148881, 4696.225122854759, 4703.6942598730975, 4708.505606911225, 4746.1456937750845, 5533.00405926937, 5567.715048121628, 5570.498655121059, 5578.0, 5603.187537807076, 1511.8866085043446, 1523.1927078648334, 1533.1874106723455, 1533.984660153384, 1537.3005282596391, 968.2883080935507, 1009.9192064634811, 1010.8433192855119, 1031.2626472072504, 1056.392574269798, 5327.413984461706, 5456.836294911159, 5457.208704737791, 5459.642319973188, 5489.533389661844, 5763.0, 5776.942230577641, 5803.7968671096305, 5804.158397032406, 5804.158397032491, 5254.894902101936, 5463.48096930791, 5472.753726082336, 5479.232907392969, 5483.670979741229, 3262.6411094779555, 3298.1919429739387, 3302.7119423424883, 3308.983455082709, 3310.3117410121013, 5746.913796293059, 6430.131932189188, 6443.581167224115, 6461.19235095613, 6461.353864613501, 5937.7921772737745, 5943.851403714855, 5963.19496867926, 5978.622078525619, 6009.399060093956, 6033.7586496540525, 6047.909281360783, 6086.269647642312, 6094.177286066324, 6098.207233059674, 5630.718464076862, 5770.480656740746, 5781.94218057814, 5819.854503637443, 5867.0, 5750.568707346882, 5753.424657534213, 5772.971135144466, 5796.333421656564, 5798.507126894261, 5940.762369505172, 6051.394860513913, 6064.0291905130125, 6075.513958883367, 6094.39056094387, 4158.584141585818, 4159.251334759772, 4205.705600607928, 4207.0, 4234.661227101763, 5711.572581652698, 5747.655140691572, 5755.366909639853, 5784.623999440023, 5798.59409841307, 5471.917921231265, 5593.8321850344555, 5644.88710225785, 5669.801556945487, 5687.317521897398, 5506.174073888948, 5529.806456774155, 5538.501534861882, 5568.0, 5576.498115169654, 5289.841304760709, 5461.644993075437, 5470.343558772973, 5479.547919801176, 5539.556835453073, 5274.855242084514, 5526.55787536988, 5529.861753456195, 5548.167774833646, 5567.610267281251, 5464.508194262536, 5522.66863988162, 5530.6128570999645, 5545.7781688732, 5562.415946325577], "value": 4300.163840741102, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.1156302907111, 804.0552350987589, 822.3667775812625, 833.2167762303438, 851.0383266908397, 14569.344379502922, 14976.775348369756, 14995.700085998273, 15002.0, 15015.699686006274, 12745.0, 13785.897128229743, 13821.0, 13906.58280251594, 14006.29968501576, 680.7855525509474, 690.278658801551, 779.4037561265636, 804.2038382001834, 818.4925346285312, 808.6239898447221, 810.9837803243931, 816.3265306122443, 816.4937738602075, 818.0469752738082, 709.1702707831823, 855.8758979947904, 862.8403745307107, 863.9934476335094, 865.5672163918041, 828.0849661124461, 844.957752112395, 848.719922425598, 849.8385306791752, 850.3494826457764, 620.4632992461488, 620.525298146918, 620.5625034350771, 621.1149112514694, 621.1924498152384, 14104.365303561364, 14142.787858182135, 14170.504032358922, 14191.148531088167, 14214.289285535682, 13387.531436399679, 13841.792373114411, 14007.369668364847, 14526.636834079127, 14683.706325873529, 11553.422328883522, 11634.243774154738, 11693.649190524298, 11827.112966527546, 11835.644930652094, 3778.244351129785, 3784.2620688965662, 3788.9810550947345, 3810.12367155553, 3873.4770805941403, 55859.162112568345, 55911.44088559144, 57317.42682573163, 57566.42433575694, 57772.71113644405, 10833.483312336279, 11022.338659680445, 11155.776884462266, 11173.944130279297, 11197.664070077748, 18076.0, 18084.18621162051, 18101.637967240582, 18133.27466901309, 18192.363267285582, 8026.9966254218225, 8292.59352819094, 8328.292095171979, 8438.198371154731, 8479.745607631781, 4574.679772415899, 4597.172508948354, 4616.584507394284, 4625.953740462553, 4717.740524271198, 3150.401423729484, 3204.599425071866, 3211.5985501812274, 3219.114743445571, 3223.2747631782663, 545.5989847462113, 554.919536667181, 564.7007086244297, 589.8849724303719, 656.7734131724548, 629.3580547841176, 643.6749441531996, 664.6078813499962, 701.7263267325746, 753.1150897695186, 8935.419197752126, 9359.485228312507, 9459.290553208399, 9653.46905920181, 9776.071273229032, 665.311402698205, 685.7867718470671, 763.0902180753332, 771.1016665584643, 782.338923609549, 4551.180787458223, 4578.267477203632, 4649.302604609268, 4694.342792009122, 4747.192977193886, 58640.0, 60431.69784151051, 60831.39168608346, 61134.694326528086, 69084.0, 55447.0, 58128.70935645295, 58474.7076264616, 59355.703221483614, 59935.400645993854, 53956.46043539514, 54817.0, 55011.72494137584, 55728.72135639377, 56444.0, 9938.552765125442, 9972.0, 10010.299279050396, 10093.848592270975, 10100.494975251355, 31122.68877311198, 32922.5061624071, 36276.29849194441, 36619.81690091533, 37470.43794343033, 46991.0, 47159.764201178776, 47368.763156183995, 47458.52541474679, 48331.27503087386, 12188.634340969786, 12300.200486968677, 12791.616251512469, 12961.09272350964, 13040.739185216433, 13269.933650331686, 14311.0, 14658.926705366404, 15013.624659383602, 15169.08985460876, 13577.253251071286, 13584.117032392864, 13721.534159009429, 14053.156810591398, 14383.0, 12914.0, 13069.15050521713, 13383.799243011168, 13647.931760341135, 14196.574102776933, 13602.319884005563, 13770.724585508435, 14148.43406263779, 14368.13791172533, 14427.42290308418, 11191.216614836883, 11388.487518061873, 11448.255863368855, 11486.425678716198, 11596.88403115958, 11289.7742045157, 11309.377984210947, 11538.134639901873, 11544.0, 11578.884211157781], "value": 6887.573363447109, "unit": "score"}], "name": "dromaeo_css", "value": 7062.088030711427, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 106.0, 110.0, 112.0, 113.0, 101.0, 111.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 153.0, 180.0, 133.0, 149.0, 157.0, 128.0, 185.0, 128.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 159.0, 159.0, 160.0, 160.0, 161.0, 162.0, 162.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 113.0, 111.0, 73.0, 72.0, 74.0, 132.0, 100.0, 74.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 153.0, 92.0, 93.0, 92.0, 148.0, 93.0, 91.0, 161.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 56.0, 57.0, 55.0, 76.0, 54.0, 56.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 64.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 76.0, 76.0, 76.0, 76.0, 77.0, 77.0, 76.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 125.0, 125.0, 127.0, 124.0, 136.0, 124.0, 125.0, 166.0, 126.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 201.0, 195.0, 194.0, 195.0, 191.0, 200.0, 195.0, 197.0, 199.0], "value": 196.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 70.0, 69.0, 69.0, 70.0, 68.0, 70.0, 68.0, 67.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1569.2999999999997, "alertThreshold": 2.0}]} 05:32:56 INFO - Return code: 0 05:32:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:32:56 ERROR - # TBPL SUCCESS # 05:32:56 INFO - Running post-action listener: _resource_record_post_action 05:32:56 INFO - Running post-run listener: _resource_record_post_run 05:32:57 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536969216; Read time: 8; Write time: 343704 05:32:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244838400; Read time: 0; Write time: 193852 05:32:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292130816; Read time: 8; Write time: 149852 05:32:57 INFO - Running post-run listener: _upload_blobber_files 05:32:57 INFO - Blob upload gear active. 05:32:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:32:57 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 05:32:57 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'] 05:32:57 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 05:32:57 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:32:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:58 INFO - (blobuploader) - INFO - Done attempting. 05:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:32:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:59 INFO - (blobuploader) - INFO - Done attempting. 05:32:59 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:59 INFO - Return code: 0 05:32:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e230c6f2c9da5c4ff739f0b4ce31a32d016bac2e763e786800b1c982e470529f2cf8ba514d2bd340a42c7e5bd26aec66d8cb22e0c3d22521f1146ecdcf18123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d6589cca78f316d241c9bbb921d6c0b93a954aea5a381f7185cf386bafa0dd24e6b87b34b14ad89eabeebba18cf3603e08a98edf51106777aa6fee3732183fd"} 05:32:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:59 INFO - Contents: 05:32:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e230c6f2c9da5c4ff739f0b4ce31a32d016bac2e763e786800b1c982e470529f2cf8ba514d2bd340a42c7e5bd26aec66d8cb22e0c3d22521f1146ecdcf18123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d6589cca78f316d241c9bbb921d6c0b93a954aea5a381f7185cf386bafa0dd24e6b87b34b14ad89eabeebba18cf3603e08a98edf51106777aa6fee3732183fd"} 05:32:59 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:59 INFO - Copying logs to upload dir... 05:32:59 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.869621 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-28 05:32:59.602561) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:32:59.606383) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960 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/2e230c6f2c9da5c4ff739f0b4ce31a32d016bac2e763e786800b1c982e470529f2cf8ba514d2bd340a42c7e5bd26aec66d8cb22e0c3d22521f1146ecdcf18123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d6589cca78f316d241c9bbb921d6c0b93a954aea5a381f7185cf386bafa0dd24e6b87b34b14ad89eabeebba18cf3603e08a98edf51106777aa6fee3732183fd"} build_url:https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/Ct3PIIkyTm6nMRp5UfTtTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e230c6f2c9da5c4ff739f0b4ce31a32d016bac2e763e786800b1c982e470529f2cf8ba514d2bd340a42c7e5bd26aec66d8cb22e0c3d22521f1146ecdcf18123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d6589cca78f316d241c9bbb921d6c0b93a954aea5a381f7185cf386bafa0dd24e6b87b34b14ad89eabeebba18cf3603e08a98edf51106777aa6fee3732183fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:32:59.634193) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:32:59.634930) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461844707.308590-1728206960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:32:59.727601) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:32:59.728336) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:32:59.728867) ========= ========= Total master_lag: 0.19 =========