builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1462505913.01 results: success (0) buildid: 20160505194628 builduid: 2e873fa8379c4b2c9e5841b57387531f revision: 57a2b1d3941f7a52c77086db05f518d88d0851f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.013529) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.013967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.014313) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.049933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.050234) ========= 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-1462505274.121429-2112475437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 20:38:33-- 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% 76.8M=0s 2016-05-05 20:38:33 (76.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085038 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.163919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.164238) ========= 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-1462505274.121429-2112475437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020258 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.242424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.242808) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 57a2b1d3941f7a52c77086db05f518d88d0851f6 --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 57a2b1d3941f7a52c77086db05f518d88d0851f6 --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-1462505274.121429-2112475437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 20:38:33,290 truncating revision to first 12 chars 2016-05-05 20:38:33,290 Setting DEBUG logging. 2016-05-05 20:38:33,290 attempt 1/10 2016-05-05 20:38:33,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/57a2b1d3941f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 20:38:33,643 unpacking tar archive at: fx-team-57a2b1d3941f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658955 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.916030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.916376) ========= script_repo_revision: 57a2b1d3941f7a52c77086db05f518d88d0851f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.916859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.917184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 20:38:33.930073) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-05 20:38:33.930385) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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-1462505274.121429-2112475437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:38:34 INFO - MultiFileLogger online at 20160505 20:38:34 in /builds/slave/test 20:38:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:38:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:38:34 INFO - {'append_to_log': False, 20:38:34 INFO - 'base_work_dir': '/builds/slave/test', 20:38:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:38:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:38:34 INFO - 'branch': 'Fx-Team-Non-PGO', 20:38:34 INFO - 'buildbot_json_path': 'buildprops.json', 20:38:34 INFO - 'config_files': ('talos/linux_config.py',), 20:38:34 INFO - 'default_actions': ('clobber', 20:38:34 INFO - 'read-buildbot-config', 20:38:34 INFO - 'download-and-extract', 20:38:34 INFO - 'populate-webroot', 20:38:34 INFO - 'create-virtualenv', 20:38:34 INFO - 'install', 20:38:34 INFO - 'run-tests'), 20:38:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:38:34 INFO - 'download_minidump_stackwalk': True, 20:38:34 INFO - 'download_symbols': 'ondemand', 20:38:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:38:34 INFO - 'tooltool.py': '/tools/tooltool.py', 20:38:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:38:34 INFO - '/tools/misc-python/virtualenv.py')}, 20:38:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:38:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:38:34 INFO - 'installer_path': 'installer.exe', 20:38:34 INFO - 'log_level': 'info', 20:38:34 INFO - 'log_name': 'talos', 20:38:34 INFO - 'log_to_console': True, 20:38:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:38:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:38:34 INFO - 'opt_config_files': (), 20:38:34 INFO - 'pip_index': False, 20:38:34 INFO - 'sps_profile': False, 20:38:34 INFO - 'sps_profile_interval': 0, 20:38:34 INFO - 'suite': 'dromaeojs', 20:38:34 INFO - 'system_bits': '32', 20:38:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:38:34 INFO - 'title': 'talos-linux64-ix-037', 20:38:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:38:34 INFO - 'use_talos_json': True, 20:38:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:38:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:38:34 INFO - 'work_dir': 'build'} 20:38:34 INFO - ##### 20:38:34 INFO - ##### Running clobber step. 20:38:34 INFO - ##### 20:38:34 INFO - Running pre-action listener: _resource_record_pre_action 20:38:34 INFO - Running main action method: clobber 20:38:34 INFO - rmtree: /builds/slave/test/build 20:38:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:38:35 INFO - Running post-action listener: _resource_record_post_action 20:38:35 INFO - ##### 20:38:35 INFO - ##### Running read-buildbot-config step. 20:38:35 INFO - ##### 20:38:35 INFO - Running pre-action listener: _resource_record_pre_action 20:38:35 INFO - Running main action method: read_buildbot_config 20:38:35 INFO - Using buildbot properties: 20:38:35 INFO - { 20:38:35 INFO - "project": "", 20:38:35 INFO - "product": "firefox", 20:38:35 INFO - "script_repo_revision": "production", 20:38:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:38:35 INFO - "repository": "", 20:38:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:38:35 INFO - "buildid": "20160505194628", 20:38:35 INFO - "pgo_build": "False", 20:38:35 INFO - "basedir": "/builds/slave/test", 20:38:35 INFO - "buildnumber": 1654, 20:38:35 INFO - "slavename": "talos-linux64-ix-037", 20:38:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:38:35 INFO - "platform": "ubuntu64_hw", 20:38:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:38:35 INFO - "branch": "fx-team", 20:38:35 INFO - "repo_path": "integration/fx-team", 20:38:35 INFO - "revision": "57a2b1d3941f7a52c77086db05f518d88d0851f6", 20:38:35 INFO - "stage_platform": "linux64", 20:38:35 INFO - "builduid": "2e873fa8379c4b2c9e5841b57387531f", 20:38:35 INFO - "slavebuilddir": "test" 20:38:35 INFO - } 20:38:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:38:35 INFO - Running post-action listener: _resource_record_post_action 20:38:35 INFO - ##### 20:38:35 INFO - ##### Running download-and-extract step. 20:38:35 INFO - ##### 20:38:35 INFO - Running pre-action listener: _resource_record_pre_action 20:38:35 INFO - Running main action method: download_and_extract 20:38:35 INFO - mkdir: /builds/slave/test/build/tests 20:38:35 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')]} 20:38:35 INFO - https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:38:45 INFO - Downloaded 1361 bytes. 20:38:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:38:45 INFO - Using the following test package requirements: 20:38:45 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:38:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:38:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:38:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:45 INFO - u'jsshell-linux-x86_64.zip'], 20:38:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:38:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:38:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:38:45 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:38:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:38:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:38:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:38:45 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')]} 20:38:45 INFO - https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:38:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:38:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:38:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:38:54 INFO - Downloaded 22321318 bytes. 20:38:54 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'] 20:38:54 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 20:38:55 INFO - Return code: 0 20:38:55 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 20:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:55 INFO - https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:38:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:38:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:38:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:38:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:38:56 INFO - Downloaded 22321318 bytes. 20:38:56 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'] 20:38:56 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 20:38:58 INFO - Return code: 0 20:38: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')]} 20:38:58 INFO - https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:38:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:38:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:38:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:38:58 INFO - Downloaded 10840152 bytes. 20:38:59 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'] 20:38:59 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 20:38:59 INFO - Return code: 0 20:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:59 INFO - https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:38:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:38:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:38:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:39:00 INFO - Downloaded 54838133 bytes. 20:39:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:39:00 INFO - mkdir: /builds/slave/test/properties 20:39:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:39:00 INFO - Writing to file /builds/slave/test/properties/build_url 20:39:00 INFO - Contents: 20:39:00 INFO - build_url:https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:39:01 INFO - Running post-action listener: _resource_record_post_action 20:39:01 INFO - Running post-action listener: set_extra_try_arguments 20:39:01 INFO - ##### 20:39:01 INFO - ##### Running populate-webroot step. 20:39:01 INFO - ##### 20:39:01 INFO - Running pre-action listener: _resource_record_pre_action 20:39:01 INFO - Running main action method: populate_webroot 20:39:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:39:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:39:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:39:01 INFO - '--tppagecycles', 20:39:01 INFO - '7'], 20:39:01 INFO - 'tests': ['tsvgm']}}, 20:39:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:39:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:39:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:39:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:39:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:39:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:39:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:01 INFO - 'talos_options': ['--disable-e10s'], 20:39:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:39:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:39:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:01 INFO - 'talos_options': ['--disable-e10s'], 20:39:01 INFO - 'tests': ['damp', 'tps']}, 20:39:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:01 INFO - 'tests': ['damp', 'tps']}, 20:39:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:39:01 INFO - 'tests': ['dromaeo_dom']}, 20:39:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:39:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:39:01 INFO - 'tests': ['a11yr', 20:39:01 INFO - 'ts_paint', 20:39:01 INFO - 'tpaint', 20:39:01 INFO - 'sessionrestore', 20:39:01 INFO - 'sessionrestore_no_auto_restore', 20:39:01 INFO - 'tabpaint']}, 20:39:01 INFO - 'other-e10s': {'tests': ['a11yr', 20:39:01 INFO - 'ts_paint', 20:39:01 INFO - 'tpaint', 20:39:01 INFO - 'sessionrestore', 20:39:01 INFO - 'sessionrestore_no_auto_restore', 20:39:01 INFO - 'tabpaint']}, 20:39:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:39:01 INFO - 'ts_paint', 20:39:01 INFO - 'tpaint', 20:39:01 INFO - 'sessionrestore', 20:39:01 INFO - 'sessionrestore_no_auto_restore', 20:39:01 INFO - 'tabpaint']}, 20:39:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:39:01 INFO - 'ts_paint', 20:39:01 INFO - 'tpaint', 20:39:01 INFO - 'sessionrestore', 20:39:01 INFO - 'sessionrestore_no_auto_restore', 20:39:01 INFO - 'tabpaint']}, 20:39:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:39:01 INFO - 'tests': ['a11yr', 20:39:01 INFO - 'ts_paint', 20:39:01 INFO - 'tpaint', 20:39:01 INFO - 'sessionrestore', 20:39:01 INFO - 'sessionrestore_no_auto_restore', 20:39:01 INFO - 'tabpaint']}, 20:39:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:39:01 INFO - 'tests': ['a11yr', 20:39:01 INFO - 'ts_paint', 20:39:01 INFO - 'tpaint', 20:39:01 INFO - 'sessionrestore', 20:39:01 INFO - 'sessionrestore_no_auto_restore', 20:39:01 INFO - 'tabpaint']}, 20:39:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:39:01 INFO - 'tests': ['tsvgx', 20:39:01 INFO - 'tsvgr_opacity', 20:39:01 INFO - 'tart', 20:39:01 INFO - 'tscrollx', 20:39:01 INFO - 'cart']}, 20:39:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:39:01 INFO - 'tsvgr_opacity', 20:39:01 INFO - 'tart', 20:39:01 INFO - 'tscrollx', 20:39:01 INFO - 'cart']}, 20:39:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:01 INFO - 'talos_options': ['--disable-e10s'], 20:39:01 INFO - 'tests': ['tp5o']}, 20:39:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:01 INFO - 'tests': ['tp5o']}, 20:39:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:01 INFO - 'talos_options': ['--disable-e10s', 20:39:01 INFO - '--xperf_path', 20:39:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:39:01 INFO - 'tests': ['tp5n']}, 20:39:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:01 INFO - 'talos_options': ['--xperf_path', 20:39:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:39:01 INFO - 'tests': ['tp5n']}}, 20:39:01 INFO - 'talos.zip': {'path': '', 20:39:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:39:01 INFO - Running post-action listener: _resource_record_post_action 20:39:01 INFO - ##### 20:39:01 INFO - ##### Running create-virtualenv step. 20:39:01 INFO - ##### 20:39:01 INFO - Running pre-action listener: _resource_record_pre_action 20:39:01 INFO - Running main action method: create_virtualenv 20:39:01 INFO - Creating virtualenv /builds/slave/test/build/venv 20:39:01 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 20:39:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:39:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:39:01 INFO - Using real prefix '/usr' 20:39:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:39:01 INFO - Installing distribute.............................................................................................................................................................................................done. 20:39:03 INFO - Installing pip.................done. 20:39:03 INFO - Return code: 0 20:39:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:39:03 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')]} 20:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:03 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')]} 20:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:03 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 0x7f4c03febf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3410>, '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 0x24b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b47a0>, '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-1462505274.121429-2112475437', '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 20:39:03 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 20:39:03 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 20:39:03 INFO - Using env: {'DISPLAY': ':0', 20:39:03 INFO - 'HOME': '/home/cltbld', 20:39:03 INFO - 'LANG': 'en_US.UTF-8', 20:39:03 INFO - 'LANGUAGE': 'en_US:en', 20:39:03 INFO - 'LOGNAME': 'cltbld', 20:39:03 INFO - 'MAIL': '/var/mail/cltbld', 20:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:03 INFO - 'MOZ_NO_REMOTE': '1', 20:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:03 INFO - 'NO_EM_RESTART': '1', 20:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:03 INFO - 'PWD': '/builds/slave/test', 20:39:03 INFO - 'SHELL': '/bin/bash', 20:39:03 INFO - 'SHLVL': '1', 20:39:03 INFO - 'TERM': 'linux', 20:39:03 INFO - 'TMOUT': '86400', 20:39:03 INFO - 'USER': 'cltbld', 20:39:03 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462505274.121429-2112475437', 20:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:03 INFO - '_': '/tools/buildbot/bin/python'} 20:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:04 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 20:39:04 INFO - Cleaning up... 20:39:04 INFO - Return code: 0 20:39:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4c03febf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3410>, '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 0x24b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b47a0>, '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-1462505274.121429-2112475437', '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 20:39:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:39:04 INFO - Using env: {'DISPLAY': ':0', 20:39:04 INFO - 'HOME': '/home/cltbld', 20:39:04 INFO - 'LANG': 'en_US.UTF-8', 20:39:04 INFO - 'LANGUAGE': 'en_US:en', 20:39:04 INFO - 'LOGNAME': 'cltbld', 20:39:04 INFO - 'MAIL': '/var/mail/cltbld', 20:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:04 INFO - 'MOZ_NO_REMOTE': '1', 20:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:04 INFO - 'NO_EM_RESTART': '1', 20:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:04 INFO - 'PWD': '/builds/slave/test', 20:39:04 INFO - 'SHELL': '/bin/bash', 20:39:04 INFO - 'SHLVL': '1', 20:39:04 INFO - 'TERM': 'linux', 20:39:04 INFO - 'TMOUT': '86400', 20:39:04 INFO - 'USER': 'cltbld', 20:39:04 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462505274.121429-2112475437', 20:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:04 INFO - '_': '/tools/buildbot/bin/python'} 20:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:04 INFO - Downloading/unpacking psutil>=0.7.1 20:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:39:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:39:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:39:06 INFO - Installing collected packages: psutil 20:39:06 INFO - Running setup.py install for psutil 20:39:06 INFO - building 'psutil._psutil_linux' extension 20:39:06 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 20:39:06 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 20:39:06 INFO - building 'psutil._psutil_posix' extension 20:39:06 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 20:39:06 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 20:39:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:39:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:39:06 INFO - Successfully installed psutil 20:39:06 INFO - Cleaning up... 20:39:06 INFO - Return code: 0 20:39:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:06 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 0x7f4c03febf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3410>, '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 0x24b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b47a0>, '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-1462505274.121429-2112475437', '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 20:39:06 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 20:39:06 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 20:39:06 INFO - Using env: {'DISPLAY': ':0', 20:39:06 INFO - 'HOME': '/home/cltbld', 20:39:06 INFO - 'LANG': 'en_US.UTF-8', 20:39:06 INFO - 'LANGUAGE': 'en_US:en', 20:39:06 INFO - 'LOGNAME': 'cltbld', 20:39:06 INFO - 'MAIL': '/var/mail/cltbld', 20:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:06 INFO - 'MOZ_NO_REMOTE': '1', 20:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:06 INFO - 'NO_EM_RESTART': '1', 20:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:06 INFO - 'PWD': '/builds/slave/test', 20:39:06 INFO - 'SHELL': '/bin/bash', 20:39:06 INFO - 'SHLVL': '1', 20:39:06 INFO - 'TERM': 'linux', 20:39:06 INFO - 'TMOUT': '86400', 20:39:06 INFO - 'USER': 'cltbld', 20:39:06 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462505274.121429-2112475437', 20:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:06 INFO - '_': '/tools/buildbot/bin/python'} 20:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:39:09 INFO - Installing collected packages: mozsystemmonitor 20:39:09 INFO - Running setup.py install for mozsystemmonitor 20:39:09 INFO - Successfully installed mozsystemmonitor 20:39:09 INFO - Cleaning up... 20:39:09 INFO - Return code: 0 20:39:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:39: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')]} 20:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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')]} 20:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:09 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 0x7f4c03febf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3410>, '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 0x24b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b47a0>, '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-1462505274.121429-2112475437', '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 20:39:09 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 20:39:09 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 20:39:09 INFO - Using env: {'DISPLAY': ':0', 20:39:09 INFO - 'HOME': '/home/cltbld', 20:39:09 INFO - 'LANG': 'en_US.UTF-8', 20:39:09 INFO - 'LANGUAGE': 'en_US:en', 20:39:09 INFO - 'LOGNAME': 'cltbld', 20:39:09 INFO - 'MAIL': '/var/mail/cltbld', 20:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:09 INFO - 'MOZ_NO_REMOTE': '1', 20:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:09 INFO - 'NO_EM_RESTART': '1', 20:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:09 INFO - 'PWD': '/builds/slave/test', 20:39:09 INFO - 'SHELL': '/bin/bash', 20:39:09 INFO - 'SHLVL': '1', 20:39:09 INFO - 'TERM': 'linux', 20:39:09 INFO - 'TMOUT': '86400', 20:39:09 INFO - 'USER': 'cltbld', 20:39:09 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462505274.121429-2112475437', 20:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:09 INFO - '_': '/tools/buildbot/bin/python'} 20:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:09 INFO - Downloading/unpacking blobuploader==1.2.4 20:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:11 INFO - Downloading blobuploader-1.2.4.tar.gz 20:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:39:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:39:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:11 INFO - Downloading docopt-0.6.1.tar.gz 20:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:39:12 INFO - Installing collected packages: blobuploader, requests, docopt 20:39:12 INFO - Running setup.py install for blobuploader 20:39:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:39:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:39:12 INFO - Running setup.py install for requests 20:39:12 INFO - Running setup.py install for docopt 20:39:12 INFO - Successfully installed blobuploader requests docopt 20:39:12 INFO - Cleaning up... 20:39:12 INFO - Return code: 0 20:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:39:12 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')]} 20:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:12 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')]} 20:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:12 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 0x7f4c03febf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3410>, '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 0x24b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b47a0>, '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-1462505274.121429-2112475437', '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 20:39:12 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 20:39:12 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 20:39:12 INFO - Using env: {'DISPLAY': ':0', 20:39:12 INFO - 'HOME': '/home/cltbld', 20:39:12 INFO - 'LANG': 'en_US.UTF-8', 20:39:12 INFO - 'LANGUAGE': 'en_US:en', 20:39:12 INFO - 'LOGNAME': 'cltbld', 20:39:12 INFO - 'MAIL': '/var/mail/cltbld', 20:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:12 INFO - 'MOZ_NO_REMOTE': '1', 20:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:12 INFO - 'NO_EM_RESTART': '1', 20:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:12 INFO - 'PWD': '/builds/slave/test', 20:39:12 INFO - 'SHELL': '/bin/bash', 20:39:12 INFO - 'SHLVL': '1', 20:39:12 INFO - 'TERM': 'linux', 20:39:12 INFO - 'TMOUT': '86400', 20:39:12 INFO - 'USER': 'cltbld', 20:39:12 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462505274.121429-2112475437', 20:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:12 INFO - '_': '/tools/buildbot/bin/python'} 20:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:39:12 INFO - Running setup.py (path:/tmp/pip-QvHr80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:39:12 INFO - Running setup.py (path:/tmp/pip-1EL91P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:39:13 INFO - Running setup.py (path:/tmp/pip-ApqsGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:39:13 INFO - Running setup.py (path:/tmp/pip-LHlVwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:39:13 INFO - Running setup.py (path:/tmp/pip-h8ETY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:39:13 INFO - Running setup.py (path:/tmp/pip-maDIML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:39:13 INFO - Running setup.py (path:/tmp/pip-WyqPz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:39:13 INFO - Running setup.py (path:/tmp/pip-8LNah8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:39:13 INFO - Running setup.py (path:/tmp/pip-VRWb5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:39:13 INFO - Running setup.py (path:/tmp/pip-tTVOwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:39:13 INFO - Running setup.py (path:/tmp/pip-YBbrlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:39:13 INFO - Running setup.py (path:/tmp/pip-R7pwtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:39:13 INFO - Running setup.py (path:/tmp/pip-uIaiqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:39:13 INFO - Running setup.py (path:/tmp/pip-x1VHUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:13 INFO - Running setup.py (path:/tmp/pip-gCLbYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:39:13 INFO - Running setup.py (path:/tmp/pip-W3tyJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:39:14 INFO - Running setup.py (path:/tmp/pip-f8dk9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:39:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:39:14 INFO - Running setup.py install for manifestparser 20:39:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:39:14 INFO - Running setup.py install for mozcrash 20:39:14 INFO - Running setup.py install for mozdebug 20:39:14 INFO - Running setup.py install for mozdevice 20:39:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:39:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:39:14 INFO - Running setup.py install for mozfile 20:39:14 INFO - Running setup.py install for mozhttpd 20:39:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:39:14 INFO - Running setup.py install for mozinfo 20:39:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:39:14 INFO - Running setup.py install for mozInstall 20:39:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:39:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:39:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:39:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:39:14 INFO - Running setup.py install for mozleak 20:39:14 INFO - Running setup.py install for mozlog 20:39:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:39:15 INFO - Running setup.py install for moznetwork 20:39:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:39:15 INFO - Running setup.py install for mozprocess 20:39:15 INFO - Running setup.py install for mozprofile 20:39:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:39:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:39:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:39:15 INFO - Running setup.py install for mozrunner 20:39:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:39:15 INFO - Running setup.py install for mozscreenshot 20:39:15 INFO - Running setup.py install for moztest 20:39:15 INFO - Running setup.py install for mozversion 20:39:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:39:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:39:15 INFO - Cleaning up... 20:39:15 INFO - Return code: 0 20:39:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:39:15 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')]} 20:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:15 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')]} 20:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:15 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 0x7f4c03febf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3410>, '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 0x24b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b47a0>, '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-1462505274.121429-2112475437', '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 20:39:15 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 20:39:15 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 20:39:15 INFO - Using env: {'DISPLAY': ':0', 20:39:15 INFO - 'HOME': '/home/cltbld', 20:39:15 INFO - 'LANG': 'en_US.UTF-8', 20:39:15 INFO - 'LANGUAGE': 'en_US:en', 20:39:15 INFO - 'LOGNAME': 'cltbld', 20:39:15 INFO - 'MAIL': '/var/mail/cltbld', 20:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:15 INFO - 'MOZ_NO_REMOTE': '1', 20:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:15 INFO - 'NO_EM_RESTART': '1', 20:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:15 INFO - 'PWD': '/builds/slave/test', 20:39:15 INFO - 'SHELL': '/bin/bash', 20:39:15 INFO - 'SHLVL': '1', 20:39:15 INFO - 'TERM': 'linux', 20:39:15 INFO - 'TMOUT': '86400', 20:39:15 INFO - 'USER': 'cltbld', 20:39:15 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462505274.121429-2112475437', 20:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:15 INFO - '_': '/tools/buildbot/bin/python'} 20:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:39:16 INFO - Running setup.py (path:/tmp/pip-sisaDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:39:16 INFO - Running setup.py (path:/tmp/pip-gTSWeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:39:16 INFO - Running setup.py (path:/tmp/pip-dNzxss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:39:16 INFO - Running setup.py (path:/tmp/pip-FO4Pl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:39:16 INFO - Running setup.py (path:/tmp/pip-SiTjc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:39:16 INFO - Running setup.py (path:/tmp/pip-SyMlRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:39:16 INFO - Running setup.py (path:/tmp/pip-k1pBnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:39:16 INFO - Running setup.py (path:/tmp/pip-t827Bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:39:16 INFO - Running setup.py (path:/tmp/pip-Sbzhm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:39:16 INFO - Running setup.py (path:/tmp/pip-i1Hf6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:39:16 INFO - Running setup.py (path:/tmp/pip-0Qtror-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:39:16 INFO - Running setup.py (path:/tmp/pip-nW4quj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:39:16 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)) 20:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:39:16 INFO - Running setup.py (path:/tmp/pip-JfL5j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:39:17 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)) 20:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:39:17 INFO - Running setup.py (path:/tmp/pip-DWS_3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:39:17 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)) 20:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:17 INFO - Running setup.py (path:/tmp/pip-cr6AG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:17 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)) 20:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:39:17 INFO - Running setup.py (path:/tmp/pip-ckEzVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:39:17 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)) 20:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:39:17 INFO - Running setup.py (path:/tmp/pip-9a6DCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:39:17 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)) 20:39:17 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)) 20:39:17 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)) 20:39:17 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)) 20:39:17 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)) 20:39:17 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)) 20:39:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:39:17 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 20:39:17 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 20:39:17 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 20:39:17 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 20:39:17 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 20:39:17 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 20:39:19 INFO - Downloading blessings-1.6.tar.gz 20:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:39:19 INFO - Installing collected packages: blessings 20:39:19 INFO - Running setup.py install for blessings 20:39:19 INFO - Successfully installed blessings 20:39:19 INFO - Cleaning up... 20:39:19 INFO - Return code: 0 20:39:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:39:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:39:19 INFO - Reading from file tmpfile_stdout 20:39:19 INFO - Current package versions: 20:39:19 INFO - argparse == 1.2.1 20:39:19 INFO - blessings == 1.6 20:39:19 INFO - blobuploader == 1.2.4 20:39:19 INFO - docopt == 0.6.1 20:39:19 INFO - manifestparser == 1.1 20:39:19 INFO - mozInstall == 1.12 20:39:19 INFO - mozcrash == 0.17 20:39:19 INFO - mozdebug == 0.1 20:39:19 INFO - mozdevice == 0.48 20:39:19 INFO - mozfile == 1.2 20:39:19 INFO - mozhttpd == 0.7 20:39:19 INFO - mozinfo == 0.9 20:39:19 INFO - mozleak == 0.1 20:39:19 INFO - mozlog == 3.1 20:39:19 INFO - moznetwork == 0.27 20:39:19 INFO - mozprocess == 0.22 20:39:19 INFO - mozprofile == 0.28 20:39:19 INFO - mozrunner == 6.11 20:39:19 INFO - mozscreenshot == 0.1 20:39:19 INFO - mozsystemmonitor == 0.0 20:39:19 INFO - moztest == 0.7 20:39:19 INFO - mozversion == 1.4 20:39:19 INFO - psutil == 3.1.1 20:39:19 INFO - requests == 1.2.3 20:39:19 INFO - wsgiref == 0.1.2 20:39:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:19 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 0x7f4c03febf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3410>, '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 0x24b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b47a0>, '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-1462505274.121429-2112475437', '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 20:39:19 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 20:39:19 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 20:39:19 INFO - Using env: {'DISPLAY': ':0', 20:39:19 INFO - 'HOME': '/home/cltbld', 20:39:19 INFO - 'LANG': 'en_US.UTF-8', 20:39:19 INFO - 'LANGUAGE': 'en_US:en', 20:39:19 INFO - 'LOGNAME': 'cltbld', 20:39:19 INFO - 'MAIL': '/var/mail/cltbld', 20:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:19 INFO - 'MOZ_NO_REMOTE': '1', 20:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:19 INFO - 'NO_EM_RESTART': '1', 20:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:19 INFO - 'PWD': '/builds/slave/test', 20:39:19 INFO - 'SHELL': '/bin/bash', 20:39:19 INFO - 'SHLVL': '1', 20:39:19 INFO - 'TERM': 'linux', 20:39:19 INFO - 'TMOUT': '86400', 20:39:19 INFO - 'USER': 'cltbld', 20:39:19 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462505274.121429-2112475437', 20:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:19 INFO - '_': '/tools/buildbot/bin/python'} 20:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:19 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)) 20:39:19 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)) 20:39:19 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)) 20:39:19 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)) 20:39:19 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)) 20:39:19 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)) 20:39:19 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)) 20:39:19 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)) 20:39:19 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)) 20:39:19 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)) 20:39:19 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)) 20:39:19 INFO - Cleaning up... 20:39:19 INFO - Return code: 0 20:39:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:19 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 0x7f4c03febf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3410>, '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 0x24b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b47a0>, '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-1462505274.121429-2112475437', '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 20:39:19 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 20:39:19 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 20:39:19 INFO - Using env: {'DISPLAY': ':0', 20:39:19 INFO - 'HOME': '/home/cltbld', 20:39:19 INFO - 'LANG': 'en_US.UTF-8', 20:39:19 INFO - 'LANGUAGE': 'en_US:en', 20:39:19 INFO - 'LOGNAME': 'cltbld', 20:39:19 INFO - 'MAIL': '/var/mail/cltbld', 20:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:19 INFO - 'MOZ_NO_REMOTE': '1', 20:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:19 INFO - 'NO_EM_RESTART': '1', 20:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:19 INFO - 'PWD': '/builds/slave/test', 20:39:19 INFO - 'SHELL': '/bin/bash', 20:39:19 INFO - 'SHLVL': '1', 20:39:19 INFO - 'TERM': 'linux', 20:39:19 INFO - 'TMOUT': '86400', 20:39:19 INFO - 'USER': 'cltbld', 20:39:19 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462505274.121429-2112475437', 20:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:19 INFO - '_': '/tools/buildbot/bin/python'} 20:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:20 INFO - Downloading/unpacking jsonschema 20:39:20 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 20:39:20 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 20:39:20 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 20:39:20 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 20:39:20 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 20:39:20 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 20:39:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:39:21 INFO - Downloading/unpacking functools32 (from jsonschema) 20:39:21 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 20:39:21 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 20:39:21 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 20:39:21 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 20:39:21 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 20:39:21 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 20:39:22 INFO - Downloading functools32-3.2.3-2.tar.gz 20:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:39:22 INFO - warning: no files found matching '*.txt' 20:39:22 INFO - no previously-included directories found matching 'build' 20:39:22 INFO - no previously-included directories found matching 'dist' 20:39:22 INFO - no previously-included directories found matching '.git*' 20:39:22 INFO - Installing collected packages: jsonschema, functools32 20:39:22 INFO - Running setup.py install for functools32 20:39:22 INFO - warning: no files found matching '*.txt' 20:39:22 INFO - no previously-included directories found matching 'build' 20:39:22 INFO - no previously-included directories found matching 'dist' 20:39:22 INFO - no previously-included directories found matching '.git*' 20:39:22 INFO - Successfully installed jsonschema functools32 20:39:22 INFO - Cleaning up... 20:39:22 INFO - Return code: 0 20:39:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:22 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 0x7f4c03febf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3410>, '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 0x24b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b47a0>, '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-1462505274.121429-2112475437', '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 20:39:22 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 20:39:22 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 20:39:22 INFO - Using env: {'DISPLAY': ':0', 20:39:22 INFO - 'HOME': '/home/cltbld', 20:39:22 INFO - 'LANG': 'en_US.UTF-8', 20:39:22 INFO - 'LANGUAGE': 'en_US:en', 20:39:22 INFO - 'LOGNAME': 'cltbld', 20:39:22 INFO - 'MAIL': '/var/mail/cltbld', 20:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:22 INFO - 'MOZ_NO_REMOTE': '1', 20:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:22 INFO - 'NO_EM_RESTART': '1', 20:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:22 INFO - 'PWD': '/builds/slave/test', 20:39:22 INFO - 'SHELL': '/bin/bash', 20:39:22 INFO - 'SHLVL': '1', 20:39:22 INFO - 'TERM': 'linux', 20:39:22 INFO - 'TMOUT': '86400', 20:39:22 INFO - 'USER': 'cltbld', 20:39:22 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462505274.121429-2112475437', 20:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:22 INFO - '_': '/tools/buildbot/bin/python'} 20:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:22 INFO - Downloading/unpacking flake8 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 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 20:39:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:39:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:39:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:39:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:39:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:39:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:39:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:39:25 INFO - no previously-included directories found matching 'docs/_build' 20:39:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:39:25 INFO - Running setup.py install for pep8 20:39:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:39:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:39:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:39:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:39:25 INFO - no previously-included directories found matching 'docs/_build' 20:39:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:39:25 INFO - Cleaning up... 20:39:25 INFO - Return code: 0 20:39:25 INFO - Running post-action listener: _resource_record_post_action 20:39:25 INFO - Running post-action listener: _start_resource_monitoring 20:39:25 INFO - Starting resource monitoring. 20:39:25 INFO - ##### 20:39:25 INFO - ##### Running install step. 20:39:25 INFO - ##### 20:39:25 INFO - Running pre-action listener: _resource_record_pre_action 20:39:25 INFO - Running main action method: install 20:39:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:39:25 INFO - Reading from file tmpfile_stdout 20:39:25 INFO - Detecting whether we're running mozinstall >=1.0... 20:39:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:39:25 INFO - Reading from file tmpfile_stdout 20:39:25 INFO - Output received: 20:39:25 INFO - Usage: mozinstall [options] installer 20:39:25 INFO - Options: 20:39:25 INFO - -h, --help show this help message and exit 20:39:25 INFO - -d DEST, --destination=DEST 20:39:25 INFO - Directory to install application into. [default: 20:39:25 INFO - "/builds/slave/test"] 20:39:25 INFO - --app=APP Application being installed. [default: firefox] 20:39:25 INFO - mkdir: /builds/slave/test/build/application 20:39:25 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'] 20:39:25 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 20:39:41 INFO - Reading from file tmpfile_stdout 20:39:41 INFO - Output received: 20:39:41 INFO - /builds/slave/test/build/application/firefox/firefox 20:39:41 INFO - Running post-action listener: _resource_record_post_action 20:39:41 INFO - ##### 20:39:41 INFO - ##### Running run-tests step. 20:39:41 INFO - ##### 20:39:41 INFO - Running pre-action listener: _resource_record_pre_action 20:39:41 INFO - Running main action method: run_tests 20:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:39:41 INFO - Python 2.7.3 20:39:41 INFO - Return code: 0 20:39:41 INFO - grabbing minidump binary from tooltool 20:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:41 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 0x24b3410>, '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 0x24b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:39:41 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 20:39:41 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 20:39:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:39:41 INFO - Return code: 0 20:39:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:39:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:39:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:39:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:39:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:39:42 INFO - Return code: 0 20:39:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:39:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:39:42 INFO - Using env: {'DISPLAY': ':0', 20:39:42 INFO - 'HOME': '/home/cltbld', 20:39:42 INFO - 'LANG': 'en_US.UTF-8', 20:39:42 INFO - 'LANGUAGE': 'en_US:en', 20:39:42 INFO - 'LOGNAME': 'cltbld', 20:39:42 INFO - 'MAIL': '/var/mail/cltbld', 20:39:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:39:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:42 INFO - 'MOZ_NO_REMOTE': '1', 20:39:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:39:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:42 INFO - 'NO_EM_RESTART': '1', 20:39:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:42 INFO - 'PWD': '/builds/slave/test', 20:39:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:39:42 INFO - 'SHELL': '/bin/bash', 20:39:42 INFO - 'SHLVL': '1', 20:39:42 INFO - 'TERM': 'linux', 20:39:42 INFO - 'TMOUT': '86400', 20:39:42 INFO - 'USER': 'cltbld', 20:39:42 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462505274.121429-2112475437', 20:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:42 INFO - '_': '/tools/buildbot/bin/python'} 20:39:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/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 20:39:42 INFO - mozversion application_buildid: 20160505194628 20:39:42 INFO - mozversion application_changeset: 57a2b1d3941f7a52c77086db05f518d88d0851f6 20:39:42 INFO - mozversion application_display_name: Nightly 20:39:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:39:42 INFO - mozversion application_name: Firefox 20:39:42 INFO - mozversion application_remotingname: firefox 20:39:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:39:42 INFO - mozversion application_vendor: Mozilla 20:39:42 INFO - mozversion application_version: 49.0a1 20:39:42 INFO - mozversion platform_buildid: 20160505194628 20:39:42 INFO - mozversion platform_changeset: 57a2b1d3941f7a52c77086db05f518d88d0851f6 20:39:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:39:42 INFO - mozversion platform_version: 49.0a1 20:39:42 INFO - using testdate: 1462505982 20:39:42 INFO - actual date: 1462505982 20:39:42 INFO - starting webserver on 'localhost:46597' 20:39:42 INFO - SUITE-START | Running 2 tests 20:39:42 INFO - TEST-START | dromaeo_css 20:39:42 INFO - operating with platform_type : linux_ 20:39:42 INFO - Initialising browser for dromaeo_css test... 20:39:42 INFO - TEST-INFO | started process 12707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPSVkYY/profile http://localhost:46597/getInfo.html) 20:39:47 INFO - PROCESS | 12707 | __metrics Screen width/height:1600/1200 20:39:47 INFO - PROCESS | 12707 | colorDepth:24 20:39:47 INFO - PROCESS | 12707 | Browser inner width/height: 1024/697 20:39:47 INFO - PROCESS | 12707 | __metrics 20:39:48 ERROR - PROCESS | 12707 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:39:49 INFO - TEST-INFO | 12707: exit 0 20:39:49 INFO - Browser initialized. 20:39:49 INFO - Running cycle 1/1 for dromaeo_css test... 20:39:49 INFO - TEST-INFO | started process 12786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPSVkYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:40:01 INFO - PROCESS | 12786 | RSS: Main: 154365952 20:40:01 INFO - PROCESS | 12786 | 20:40:52 INFO - PROCESS | 12786 | 1462506052766 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] 20:43:04 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:46597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46597/tests/dromaeo/cssquery-ext.html) 20:43:05 INFO - PROCESS | 12786 | RSS: Main: 268165120 20:43:05 INFO - PROCESS | 12786 | 20:46:08 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:46597/tests/dromaeo/cssquery-ext.html (next: http://localhost:46597/tests/dromaeo/cssquery-jquery.html) 20:46:08 INFO - PROCESS | 12786 | RSS: Main: 234401792 20:46:08 INFO - PROCESS | 12786 | 20:49:11 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:46597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46597/tests/dromaeo/cssquery-mootools.html) 20:49:11 INFO - PROCESS | 12786 | RSS: Main: 237506560 20:49:11 INFO - PROCESS | 12786 | 20:52:13 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:46597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46597/tests/dromaeo/cssquery-prototype.html) 20:52:14 INFO - PROCESS | 12786 | RSS: Main: 232103936 20:52:14 INFO - PROCESS | 12786 | 20:55:17 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:46597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46597/tests/dromaeo/cssquery-yui.html) 20:55:17 INFO - PROCESS | 12786 | RSS: Main: 204640256 20:55:17 INFO - PROCESS | 12786 | 20:58:20 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:46597/tests/dromaeo/cssquery-yui.html (next: http://localhost:46597/tests/dromaeo/cssquery-dojo.html) 20:58:20 INFO - PROCESS | 12786 | RSS: Main: 285675520 20:58:20 INFO - PROCESS | 12786 | 20:58:20 INFO - PROCESS | 12786 | __start_tp_report 20:58:20 INFO - PROCESS | 12786 | _x_x_mozilla_page_load 20:58:20 INFO - PROCESS | 12786 | _x_x_mozilla_page_load_details 20:58:20 INFO - PROCESS | 12786 | |i|pagename|runs| 20:58:20 INFO - PROCESS | 12786 | |0;dojo.html;2691.919242422727;2725.509408306504;2745.327394788277;2757.903473378431;2786.860656967151;4668.859934201971;4735.337052812609;4754.16802059639;4784.90430191396;4855.9514404855945;4773.737444440554;4789.80840766369;4797.6401769867225;4822.180229361008;4882.292067650197;4302.763348015857;4312.956870431287;4317.222899878021;4442.267025940716;4448.154850578379;4362.367456718774;4415.249407600716;4424.358468022151;4439.089986552749;4488.035072459421;4255.63827074699;4399.7360158390275;4424.513303536608;4439.134368798085;4447.777611119431;4271.508776490681;4326.307790753496;4328.4156638853665;4346.826126954949;4396.098799746044;4311.48262208537;4364.629006534448;4367.519572846984;4375.9562404375865;4421.358902959053;4560.315952607102;4672.462666793328;4690.202665546831;4721.480637129913;4726.314684370747;5052.469490703496;5072.974635126838;5079.085764562377;5137.101007323741;5190.662606930575;5134.05020071288;5154.149565321717;5172.560332371753;5180.197069454241;5180.6373553851245;4660.930086048712;4753.976230118897;4829.2997515360075;4861.173600487926;4863.392075990501;5225.451327610622;5265.052290587654;5274.736263186902;5310.123829568155;5328.280682107866;5056.191009438472;5066.265391518209;5112.769925353368;5116.872078198075;5118;4970.304157417964;5060.3168572242275;5086.745662716849;5143.8456846294675;5145.536901678792;5071;5088.440271570124;5091.0836049511445;5118.616103792156;5137.383513978347;5047.596192304681;5066.290719299301;5068.290439338495;5073.315102461121;5122.487751224922;4287.849925252601;4320.4383430153875;4321.783910804447;4387.692861499728;4441;3767.1900541383184;3789.4315852622326;3793.089658482;3819.197968426606;3845.69234461248;4356.259435895905;4356.738595684269;4358.063016451478;4359.832719109149;4406.911861762746;5003.174476211457;5060.822871199491;5061.493850614983;5069.340985671913;5100.948990510122;4365.388845561624;4397.956020439755;4399.978000109979;4443.911121777611;4450.755208463501;4642.048380082075;4652.116097941381;4652.790624421909;4658.045100754337;4697.248440249544;4668.463126740468;4798.976005119952;4845.176320025534;4849.660523763303;4851.393575803025;5107.438181799925;5134.486551344836;5147.716875571879;5149.227615857501;5185.196294574347;4816.783244754065;4849.030193961151;4861.270809378621;4862.708237505761;4886.804527818847;4922.704637721748;5010.298558201782;5024.321716568363;5038.420581633159;5119.334486516729;5103.7448127592725;5125.231215317732;5130.640855140105;5135.075686376488;5179.22311653255;4978.5270399312;4980.402351717817;4980.750962451791;4980.800767969241;4993.17612593918;4897.608191344755;4974.8756281093265;5026.095302845523;5033.320501732219;5068.518490743373;4950.851474455772;4987.625928055483;4990.451050384382;5024.271480635361;5026.944341688287;4890.24201248807;5072.721000345016;5075.365579302587;5116.2069879168785;5122.1804511278015;4740.4785473597185;4777.761111944319;4886.682365646222;4890.315355850113;4919.729414882216 20:58:20 INFO - PROCESS | 12786 | |1;ext.html;556.5714399912065;597.2802772658946;611.1901730207474;612.4763327355112;632.6299115017714;40872.59127408725;42621.573784262146;42690;42730.78634606831;47090.76454617722;43629.345559816546;43993;44128.11743765123;44140.3378949316;44174.33738493917;7914.24814642608;8091.069527004382;8092.514449133041;8099.838003239932;8102.473339232931;7917.010373703287;7982.28159465648;7986.081600615946;7986.361091112697;7986.960065199695;8011.719589814357;8040.477368970998;8040.959795201015;8042.638081286356;8043.919560804376;7965.96017019917;7985.241402066795;7997.200279972015;8004.319632831216;8016.7194148204535;7936.16670249627;8028.317593004602;8037.799055023613;8039.598020098972;8039.638216280223;40503.392449113286;40688.593114068775;40830.79584602058;41015.58984410147;41085;3202.2634793997513;3361.932761344784;3367.6800703933086;3376.57792775903;3382.6786455286956;30074.69925300741;30698;31272.21819454509;31474.685253147632;32384.676153238637;2931.413717256536;3010.834404107773;3022.3804120155314;3050.3746731919905;3053.3587946531256;250762;411935;418732.999999997;418891;421155;58605.41394586085;59088.70455647694;59396.109058364156;59404.10893836596;59737.40262597406;35007.64992350044;36338.27323453569;36411.27177456436;38539.42190867139;63241;14005.439782408794;14108.294585270696;14110.929445352913;14114.929425352808;14125.434982600786;11102.389368584805;11174.329540227613;11191.66425007251;11203.159763017806;11207.327560346404;19393.4181974541;19477.280338283552;19559;19595.11821968015;19683.409497715093;6986.93013069873;7013.438924885997;7315.732123041874;7318.268173182639;7342.596157211405;887.5784002598714;904.6697955246419;938.4650749073099;970.8640790289365;1084.7830433913248;27577.44845103127;27954.720452795213;28752.281192970342;28828.135155945354;28977.13068607945;1013.6806905824642;1020.2908978260039;1027.5992362978445;1040.3601784902382;1043.4886905416292;15331;15575;15577.610559735871;15743.606409839846;15975.600609984844;280914;283804;283915;284598;285163;49062;49913.25130123051;50156;50416.24375634368;50488.242676359885;1152.757920836617;1255.3534929511309;1289.3553223388305;1295.1257900917033;1315.0137396952287;29188.562171567868;30528;30596.541051884684;30740;31142.377152457277;44162.35025898457;44843.10313793771;44878.326825097;44927.775361122985;44941.550584493736;270426;276667;276724;277819;278271;23936.281911542683;25801.483970320864;26448.8677556611;26838.329041774112;28774.712252878042;43169.3524597125;43362.34956475718;43812.12375752403;44520.554794451644;44586.10827783491;37972;38264.2347153061;38348.61651383562;38407.80796096002;38874;36530.8173459131;37623.623763763106;37763.81118094392;37779.62220377761;37927.24145517129;36754.8162259187;37617.62382376141;37782.62217377791;37933.62066379301;38048;32698.34603307873;33142.834285828416;33484.665153348156;34023.31953360968;34336;25894.35264118412;26071;26173.214803555922;26240;26404.471910562064 20:58:20 INFO - PROCESS | 12786 | |2;jquery.html;373.30006238303184;379.29640516841266;380.4863434363609;391.12778503936204;391.71013450046956;16036.759448608265;16159.272832722527;16969.406070787525;16980.405685801;16984.745228821546;10112.342697724644;10115.190784737222;10125.544350504226;10130.290879638409;10361.430121343323;3399.133221028634;4618.792154353062;4758.310045043467;4796.352492413532;5106.489351064901;5135.948640513584;5358.062339090644;5382.381026182;5396.487333703292;5474.206240095184;5419.5393391561765;5435.918461223085;5455.290812194409;5459.153831156157;5464.672119672832;5301.655392399501;5340.973295133538;5402.35171779385;5429.891402171954;5435.076037073667;5080.288759573663;5262.789488420459;5270.39390470097;5275.366955965309;5278.049951008817;12371;12459.563915262923;12576.056795740356;12576.937115314366;13578.524751633744;1858.7583614130076;1941.6602094633524;1963.7741659709172;1969.1827891425041;2093.7801530839197;8807.77980550485;8907.599158037903;9175.862362064574;9179.311551633587;9204.125608067223;1750.6936286149873;1769.6549172911286;1801.3335066025522;1809.5928416106403;1811.936582219616;68215.65892170557;68356.6582167091;68872.31127688759;69218.65390673064;69943;9979.750506237402;10037.297389182688;10120.696379108638;10311.587536498606;10325.380477171393;14032.579022629337;14088.85911140896;14137.222452765196;14163;14175.220362879934;7232.602206878672;7382.852342953111;7447.664855081426;7547.320741133324;7588.734394296173;6880.793576192722;6971;7035.296470352924;7067.187273463617;7086.893696594555;4270.551592082787;4396.142752163298;4405.889852753643;4423.8009289581405;4490.595846373842;1651.38898607516;1704.5227336345843;1818.1011491306424;1846.4183782108862;1887.584731359099;896.8430524658158;927.7402327348218;931.3806318797923;960.4669408478222;1004.2568499310604;16935.745963810554;17033.574160645836;17123;17383.391581294592;17438.320053021493;909.4316052467208;927.0127314410132;951.990480095204;963.2967933408651;968.9079537443931;9492.620295188115;9529.094736000068;10323.32898361604;10343.37939723619;10605.787884242272;398108;403967;417424;418848.7748296351;420839;78488;84415.15584844195;85567.57216214003;86091.56954215189;87011.56494217615;955.3169483819103;979.4955597867104;981.3081777346953;982.1504398695077;1017.29298137795;15704.29330680145;15831.604209894846;15876.206189690238;15891.682166356839;16439.589010274838;35574.82212588921;36029.45955810612;36259.818700906326;36576.45135323025;36894;50591.241131383795;50612.24081638705;50849.74575127101;51324;51739.22391164211;6315.400036996478;7243.818904527429;7270.636468176464;7284.453665975179;7652.04349456318;9251.907480925374;10234.948825255826;10252.38485690861;10487.52806123711;10537.315074520131;8720.302375810046;8827.073157318646;8868.822623547621;8905.243054340453;8986.460812351279;9263.490508022123;9284.58219380116;9289.907100928904;9389.906100939177;9542.236621070158;9101.908980910106;9294.163525282756;9426.387284826464;9453.196478299422;9529.809403811747;7407.777766667009;7616.04799400075;7676.347510461674;7717.305442510201;7813.296803287732;8375.288100511281;9448.244140468883;9681.951590242004;9703.641490191238;9740.17208537254 20:58:20 INFO - PROCESS | 12786 | |3;mootools.html;1348.6223857319953;1536.677297767469;1546.5592306192734;1700.2518891687664;1845.1696736468584;7294.197638259787;7575.962120189405;7606.391488680906;7809.180036096199;7811.3360364368955;7556.622168891561;7700.614969251529;7730.845383092349;7733.7293194738195;7747;1881.07827164689;2068.88621125838;2138.379869837753;2142.357292812154;2171.359448962552;2143.517708515587;2149.8065174134326;2153.8923053847243;2154.482924098213;2158.4927542027613;2133.935981920537;2138.9786102139014;2170.4573856535867;2171.0664414301846;2172.6523756199012;1834.5505351188976;2067;2134.103676455892;2134.487722946482;2148.709924160242;2091.937241882746;2118.50215199428;2138.422625891016;2142.967855482169;2143.6570148776277;7683.2700893415595;7709.6916123354995;7731.961340193319;7782.766517004499;7785.688572457095;4374.12517496502;4536.7504787236685;4549.863504094882;4558.133954548625;4568.314752787075;2780.263230243987;2786.7213278672175;2798.3423895384567;2813.4513769814894;2839.33275680215;902.251131560803;904.3398319226935;917.6742256498914;918.2057520245007;918.4581097152712;10287.69136925901;10311.123554497877;10317.484125793755;10332.431716255604;10349.9482502587;4048.736832105904;4140.358244472111;4215.936760948588;4216.093539888877;4225.112726327444;8892.555372231363;8898.288136949028;8916.777080573038;8924.419912705653;8934;4450.599446049806;4457.665675074318;4472.508024117345;4492.191405546968;4498.370228168059;3450.46517789743;3815.08437974884;3904.3362628353248;3908.9413658795143;3960.584138665456;3611.9277614448088;3656.0859785053735;3699.9445008324897;3732.234891847165;3784.6783023442763;1188.4948896719034;1194.7849387110405;1196.611101392051;1210.1831263896834;1212.0969877441362;751.6317004667674;757.1595528962847;821.650798410673;888.1828717579842;927.823713494434;5179.766910489037;5235.058727260045;5265.78936842522;5268.00296956199;5307.4427185145005;371.08897656253833;371.70449492653404;380.6174794331679;382.075377586242;382.35000499151556;3615.584207816135;3653.926921461556;3732.8880133596035;3770.2836461072857;3845.307844588001;9058.637654493747;9430.245580353556;9534.237261019101;9595.184409325146;9596.856047159297;9305.395149315273;9394.718158455258;9523.90476095244;9579.233661307078;9582.041795820362;7162.4986250962975;7277.163126240444;7322.597257150908;7401.444891633149;7408.85182296351;5282.788688452419;5327.813526526708;5417.891642167056;5518.144687573433;5531.695756733418;8591.52746598918;8697.95651021741;8802.471851688919;8844.425112367675;8866.246369058703;8637.093105223861;8892.28861691076;8921.420107692978;8997.32520060985;9012.05373435806;6092.847678807888;6551.50863685216;6700;6707.42986846104;6804.523683342317;7499.987501687202;7500.099988001475;7539.095308563007;7554.395648348009;7565.167831538416;6739.359760822714;6831.0436538883605;6886.345797149263;6950.687219075255;7039.331263529956;6709.194896612437;6712.39588437043;6729.259781424137;6770.796876093725;6823;6431.324710905287;6437.163168788027;6488.935110648833;6498.610083395011;6573.5398522103;4715.905681886412;4729.739864307496;4767.6424268179335;4804.375431193923;4849.75751212445;4641.767911604474;4688.085823264567;4718.882027949328;4757.35775670294;4811.109944660249 20:58:20 INFO - PROCESS | 12786 | |4;prototype.html;288.5109738992408;297.1249669722667;299.62546816479403;304.4519864244361;307.2641024745735;4787.13831510328;4789.257665061917;4806.855794326167;4807.567318941295;4844.903101937959;4726.550977657125;4745.31192977019;4763.261694437359;4764;4771.42742870856;3578.4274516077367;3648.8358023888854;3668.504751858505;3693.722970777189;3713.8885833425043;3558.6085530591613;3681.4293784463453;3682.742208045438;3692.20617567223;3743.5694895087004;3631.691306238973;3645.4714066460347;3671.192337685718;3674.4672022556715;3701.9629803702023;3599.3341231871927;3666.9633303666888;3668.486411902349;3683.2449347883753;3782.5650050244026;3363.4954756786433;3367.8821241256683;3377.712894403954;3380.3915295246848;3382.458806590934;4477.082198149372;4515.345274935116;4535.750533720644;4544.659150563721;4553.927962776928;4240.194363071007;4266.914661706748;4279.486461624594;4298.78506074695;4302.763348015857;4711.623070154379;4911.435184953741;4942.382202224722;4950.331705219785;4952.158133117378;3628;3645.8177091145603;3651.7991510466913;3653.4337177737493;3685.760425572356;5181.844544663666;5215.0534947754395;5233.816816411408;5234.790608375661;5250.474952504757;3460.463628137643;3654;3749.718771092179;3751.9249615008093;3755.9436608450897;3646.9452958205648;3668.5781135169796;3685.4656074868994;3697.630236976335;3698.7041036716996;4184.121334519785;4194.979025104916;4196.475440569929;4205.663546916239;4213.672693101663;5010.098182327143;5022;5028.371453568304;5051.9390927904815;5074.619403544749;1214.2532342609231;1248.3820508847996;1251.7997120460682;1259.9290602987571;1261.1928365845683;832.937529685276;844.9450785699033;846.7163500227492;847.1740053447962;849.3544905871458;4249.086446414036;4347.826086956549;4437.245668236407;4464.129494748558;4464.352668863062;5119.283300337956;5151.896962060738;5169.948300517022;5174.560162386239;5186.844394668166;4413.801378937956;4414.3157810539415;4418.497710778351;4442.42248507692;4459.955400446019;2497.600383938561;2639.28739240404;2656.7646044588973;2667.2665017120057;2675.4916565852427;4722.229164063476;4757.381540399726;4784.928226076611;4792.705969388246;4818.807247710052;5075.3402057732255;5116.692998420107;5124.231365295161;5129.538341549279;5148.9485105149215;4602.608778253819;4913.115639184981;4921.827736029221;4931.717753384146;4936.358273424432;5151.8196863109615;5156.871078223075;5191.92212116811;5197.246399272009;5214.322138122172;4837.637177211653;5045.8738531537;5085.7711402986215;5091.363579552556;5104.779420951898;4837.298591704253;4862.927056094232;4900.338454308623;4901.607871370211;4913.434954980223;3625.2568223514645;3640.1263696712067;3645.3778068759148;3657.4148136298063;3676.7793932364143;5183.844484665466;5204.609654275869;5226.163813789775;5228.398734145622;5234.816781412632;4687.789049492849;4938.75306234694;4991.376077990251;4997.925031124463;5002.724850133132;4981.252812078217;4989.775460104376;4993.925091123563;5004.299398084198;5033.119204139188;4819.349387832738;4915.43472500667;4924.138275801792;4946.134426475281;4950.653454258168;4767.545898500991;4906.3376444181;4964.950350496449;4980.975095124646;5051.368578927634;4896.90206195867;4905.166121759238;4915.336429581961;4919.827806026772;4925.778339974638 20:58:20 INFO - PROCESS | 12786 | |5;yui.html;679.7450955891541;718.2637796258838;754.5020286610835;772.4901564967123;779.477749907562;10694.732631684203;11810.999999999989;11883.465244064017;11946.581869634565;11988.460519276632;12345.321007344592;12426.192297500656;12441.626751197457;12467.314297713645;12499.18755280906;671.2180309938927;827.0488937721608;858.5063588436674;858.935579831512;864.7967727584013;852.4373913217278;853.2747164909839;855.4696088425154;858.6994551906814;858.8969323681167;712.8075419636695;914.9176574108329;915.7252824152761;915.9908400916006;916.1022198245723;731.3344856180877;734.4381548115696;859.5916939453772;895.6193617712446;896.9327300452427;668.6422763821332;668.759246671198;668.906353110565;668.9163854518185;669.6417416682052;11471.541138354456;11511.827322590168;11529.538818447336;11550;11561.826572601418;11601.303921764722;11958.402079896057;11986.460609272604;12143.453544590515;12189.451474683572;10387.636432724817;10453.947730261376;10473.423961682105;10508.246884095797;10805.297655652357;4086.734362266443;4088.2232375848494;4092.529359123709;4131.669466442678;4199.91600167998;42109.1578168438;42958.785206074084;44156;44386.33420498695;44765.55234447646;9813.093433335998;10024.799504010025;10039.548220330104;10050.296479246528;10108.747281318027;17469.7379539307;17690.911545442446;17792.644147116986;17821.376251831123;17897.642047159243;6493.967530162414;6595.967020164869;6623.172103487064;6640.701168447432;6745.730170793114;3664.303782281358;3759.962400376016;3788.507494025814;3799.962000380016;3801.0877389426337;2594.15689900783;2664.9467010659678;2666.2801043718086;2674.1175412113957;2676.6215399069497;489.57407055861626;496.5183771741405;496.74169431895933;501.8250428477618;511.9795208191705;510.6297933997896;519.8466452396476;599.1611743559052;604.9395060494004;613.1599708399432;7535.8116047099265;7663.463557551029;7699.11460182075;7849.097353804272;7975.441719079608;596.1594152245314;598.4912824099567;613.0436519030327;617.1668247865346;645.3578689204272;3286.1620286827183;3628.9274214515563;3644.7448678592773;3654.3604869147794;3711.3690672585726;55417.722911385994;57296;57513.137302940486;57686.423135768106;57754.13368799471;42718.78640606839;49077.26384104241;50916.490835091914;51320.74339628278;52540;42622.14755704869;42760;43873.56126438759;44024;44652;7650.349720273839;7665.463417560717;7882.211778822301;7931.920680793349;7980.720674776355;27825;27972;28078.157655270374;28967.5654865173;31114.844425777726;38881.416778748906;39323.410148847215;39381.80309098436;39446;40026.79986600048;9999.453147138172;10147.188224942134;10309.845352319571;10548.354046951;10662.147028237567;10818.24272300963;10880.45597720095;10915.181361398085;10947.178961577754;11623.76752464963;10398.22013349017;10526.315789473965;10732;10748.193885458779;10888.945555272174;10215.795684086424;10364.274500784873;10684.893151068702;10693.465326733476;11016.228863979444;9560.6284970335;9616.064273020995;9906.801863962537;9924.255680823822;9947;8568.614412351335;8741.956290218508;8798.076201998698;8898.73303800887;9099.135582119688;8621.224089831945;8999.775005624912;9076.137766912132;9085.091490850862;9112.544372781202 20:58:20 INFO - PROCESS | 12786 | __end_tp_report 20:58:20 INFO - PROCESS | 12786 | __start_cc_report 20:58:20 INFO - PROCESS | 12786 | _x_x_mozilla_cycle_collect,1084 20:58:20 INFO - PROCESS | 12786 | __end_cc_report 20:58:20 INFO - PROCESS | 12786 | __startTimestamp1462507100914__endTimestamp 20:58:20 INFO - PROCESS | 12786 | 20:58:20 INFO - PROCESS | 12786 | ------- Summary: start ------- 20:58:20 INFO - PROCESS | 12786 | Number of tests: 6 20:58:20 INFO - PROCESS | 12786 | 20:58:20 INFO - PROCESS | 12786 | [#0] dojo.html Cycles:165 Average:4729.19 Median:4861.27 stddev:491.83 (10.1%) stddev-sans-first:466.65 20:58:20 INFO - PROCESS | 12786 | Values: 2691.9 2725.5 2745.3 2757.9 2786.9 4668.9 4735.3 4754.2 4784.9 4856.0 4773.7 4789.8 4797.6 4822.2 4882.3 4302.8 4313.0 4317.2 4442.3 4448.2 4362.4 4415.2 4424.4 4439.1 4488.0 4255.6 4399.7 4424.5 4439.1 4447.8 4271.5 4326.3 4328.4 4346.8 4396.1 4311.5 4364.6 4367.5 4376.0 4421.4 4560.3 4672.5 4690.2 4721.5 4726.3 5052.5 5073.0 5079.1 5137.1 5190.7 5134.1 5154.1 5172.6 5180.2 5180.6 4660.9 4754.0 4829.3 4861.2 4863.4 5225.5 5265.1 5274.7 5310.1 5328.3 5056.2 5066.3 5112.8 5116.9 5118.0 4970.3 5060.3 5086.7 5143.8 5145.5 5071.0 5088.4 5091.1 5118.6 5137.4 5047.6 5066.3 5068.3 5073.3 5122.5 4287.8 4320.4 4321.8 4387.7 4441.0 3767.2 3789.4 3793.1 3819.2 3845.7 4356.3 4356.7 4358.1 4359.8 4406.9 5003.2 5060.8 5061.5 5069.3 5100.9 4365.4 4398.0 4400.0 4443.9 4450.8 4642.0 4652.1 4652.8 4658.0 4697.2 4668.5 4799.0 4845.2 4849.7 4851.4 5107.4 5134.5 5147.7 5149.2 5185.2 4816.8 4849.0 4861.3 4862.7 4886.8 4922.7 5010.3 5024.3 5038.4 5119.3 5103.7 5125.2 5130.6 5135.1 5179.2 4978.5 4980.4 4980.8 4980.8 4993.2 4897.6 4974.9 5026.1 5033.3 5068.5 4950.9 4987.6 4990.5 5024.3 5026.9 4890.2 5072.7 5075.4 5116.2 5122.2 4740.5 4777.8 4886.7 4890.3 4919.7 20:58:20 INFO - PROCESS | 12786 | 20:58:20 INFO - PROCESS | 12786 | [#1] ext.html Cycles:180 Average:47759.42 Median:37781.12 stddev:84369.19 (223.3%) stddev-sans-first:84531.43 20:58:20 INFO - PROCESS | 12786 | Values: 556.6 597.3 611.2 612.5 632.6 40872.6 42621.6 42690.0 42730.8 47090.8 43629.3 43993.0 44128.1 44140.3 44174.3 7914.2 8091.1 8092.5 8099.8 8102.5 7917.0 7982.3 7986.1 7986.4 7987.0 8011.7 8040.5 8041.0 8042.6 8043.9 7966.0 7985.2 7997.2 8004.3 8016.7 7936.2 8028.3 8037.8 8039.6 8039.6 40503.4 40688.6 40830.8 41015.6 41085.0 3202.3 3361.9 3367.7 3376.6 3382.7 30074.7 30698.0 31272.2 31474.7 32384.7 2931.4 3010.8 3022.4 3050.4 3053.4 250762.0 411935.0 418733.0 418891.0 421155.0 58605.4 59088.7 59396.1 59404.1 59737.4 35007.6 36338.3 36411.3 38539.4 63241.0 14005.4 14108.3 14110.9 14114.9 14125.4 11102.4 11174.3 11191.7 11203.2 11207.3 19393.4 19477.3 19559.0 19595.1 19683.4 6986.9 7013.4 7315.7 7318.3 7342.6 887.6 904.7 938.5 970.9 1084.8 27577.4 27954.7 28752.3 28828.1 28977.1 1013.7 1020.3 1027.6 1040.4 1043.5 15331.0 15575.0 15577.6 15743.6 15975.6 280914.0 283804.0 283915.0 284598.0 285163.0 49062.0 49913.3 50156.0 50416.2 50488.2 1152.8 1255.4 1289.4 1295.1 1315.0 29188.6 30528.0 30596.5 30740.0 31142.4 44162.4 44843.1 44878.3 44927.8 44941.6 270426.0 276667.0 276724.0 277819.0 278271.0 23936.3 25801.5 26448.9 26838.3 28774.7 43169.4 43362.3 43812.1 44520.6 44586.1 37972.0 38264.2 38348.6 38407.8 38874.0 36530.8 37623.6 37763.8 37779.6 37927.2 36754.8 37617.6 37782.6 37933.6 38048.0 32698.3 33142.8 33484.7 34023.3 34336.0 25894.4 26071.0 26173.2 26240.0 26404.5 20:58:20 INFO - PROCESS | 12786 | 20:58:20 INFO - PROCESS | 12786 | [#2] jquery.html Cycles:180 Average:24552.57 Median:5266.59 stddev:68132.22 (1293.7%) stddev-sans-first:68299.16 20:58:20 INFO - PROCESS | 12786 | Values: 373.3 379.3 380.5 391.1 391.7 16036.8 16159.3 16969.4 16980.4 16984.7 10112.3 10115.2 10125.5 10130.3 10361.4 3399.1 4618.8 4758.3 4796.4 5106.5 5135.9 5358.1 5382.4 5396.5 5474.2 5419.5 5435.9 5455.3 5459.2 5464.7 5301.7 5341.0 5402.4 5429.9 5435.1 5080.3 5262.8 5270.4 5275.4 5278.0 12371.0 12459.6 12576.1 12576.9 13578.5 1858.8 1941.7 1963.8 1969.2 2093.8 8807.8 8907.6 9175.9 9179.3 9204.1 1750.7 1769.7 1801.3 1809.6 1811.9 68215.7 68356.7 68872.3 69218.7 69943.0 9979.8 10037.3 10120.7 10311.6 10325.4 14032.6 14088.9 14137.2 14163.0 14175.2 7232.6 7382.9 7447.7 7547.3 7588.7 6880.8 6971.0 7035.3 7067.2 7086.9 4270.6 4396.1 4405.9 4423.8 4490.6 1651.4 1704.5 1818.1 1846.4 1887.6 896.8 927.7 931.4 960.5 1004.3 16935.7 17033.6 17123.0 17383.4 17438.3 909.4 927.0 952.0 963.3 968.9 9492.6 9529.1 10323.3 10343.4 10605.8 398108.0 403967.0 417424.0 418848.8 420839.0 78488.0 84415.2 85567.6 86091.6 87011.6 955.3 979.5 981.3 982.2 1017.3 15704.3 15831.6 15876.2 15891.7 16439.6 35574.8 36029.5 36259.8 36576.5 36894.0 50591.2 50612.2 50849.7 51324.0 51739.2 6315.4 7243.8 7270.6 7284.5 7652.0 9251.9 10234.9 10252.4 10487.5 10537.3 8720.3 8827.1 8868.8 8905.2 8986.5 9263.5 9284.6 9289.9 9389.9 9542.2 9101.9 9294.2 9426.4 9453.2 9529.8 7407.8 7616.0 7676.3 7717.3 7813.3 8375.3 9448.2 9682.0 9703.6 9740.2 20:58:20 INFO - PROCESS | 12786 | 20:58:20 INFO - PROCESS | 12786 | [#3] mootools.html Cycles:180 Average:5090.32 Median:5207.41 stddev:2854.24 (54.8%) stddev-sans-first:2848.40 20:58:20 INFO - PROCESS | 12786 | Values: 1348.6 1536.7 1546.6 1700.3 1845.2 7294.2 7576.0 7606.4 7809.2 7811.3 7556.6 7700.6 7730.8 7733.7 7747.0 1881.1 2068.9 2138.4 2142.4 2171.4 2143.5 2149.8 2153.9 2154.5 2158.5 2133.9 2139.0 2170.5 2171.1 2172.7 1834.6 2067.0 2134.1 2134.5 2148.7 2091.9 2118.5 2138.4 2143.0 2143.7 7683.3 7709.7 7732.0 7782.8 7785.7 4374.1 4536.8 4549.9 4558.1 4568.3 2780.3 2786.7 2798.3 2813.5 2839.3 902.3 904.3 917.7 918.2 918.5 10287.7 10311.1 10317.5 10332.4 10349.9 4048.7 4140.4 4215.9 4216.1 4225.1 8892.6 8898.3 8916.8 8924.4 8934.0 4450.6 4457.7 4472.5 4492.2 4498.4 3450.5 3815.1 3904.3 3908.9 3960.6 3611.9 3656.1 3699.9 3732.2 3784.7 1188.5 1194.8 1196.6 1210.2 1212.1 751.6 757.2 821.7 888.2 927.8 5179.8 5235.1 5265.8 5268.0 5307.4 371.1 371.7 380.6 382.1 382.4 3615.6 3653.9 3732.9 3770.3 3845.3 9058.6 9430.2 9534.2 9595.2 9596.9 9305.4 9394.7 9523.9 9579.2 9582.0 7162.5 7277.2 7322.6 7401.4 7408.9 5282.8 5327.8 5417.9 5518.1 5531.7 8591.5 8698.0 8802.5 8844.4 8866.2 8637.1 8892.3 8921.4 8997.3 9012.1 6092.8 6551.5 6700.0 6707.4 6804.5 7500.0 7500.1 7539.1 7554.4 7565.2 6739.4 6831.0 6886.3 6950.7 7039.3 6709.2 6712.4 6729.3 6770.8 6823.0 6431.3 6437.2 6488.9 6498.6 6573.5 4715.9 4729.7 4767.6 4804.4 4849.8 4641.8 4688.1 4718.9 4757.4 4811.1 20:58:20 INFO - PROCESS | 12786 | 20:58:20 INFO - PROCESS | 12786 | [#4] prototype.html Cycles:180 Average:4143.82 Median:4751.35 stddev:1206.76 (25.4%) stddev-sans-first:1174.93 20:58:20 INFO - PROCESS | 12786 | Values: 288.5 297.1 299.6 304.5 307.3 4787.1 4789.3 4806.9 4807.6 4844.9 4726.6 4745.3 4763.3 4764.0 4771.4 3578.4 3648.8 3668.5 3693.7 3713.9 3558.6 3681.4 3682.7 3692.2 3743.6 3631.7 3645.5 3671.2 3674.5 3702.0 3599.3 3667.0 3668.5 3683.2 3782.6 3363.5 3367.9 3377.7 3380.4 3382.5 4477.1 4515.3 4535.8 4544.7 4553.9 4240.2 4266.9 4279.5 4298.8 4302.8 4711.6 4911.4 4942.4 4950.3 4952.2 3628.0 3645.8 3651.8 3653.4 3685.8 5181.8 5215.1 5233.8 5234.8 5250.5 3460.5 3654.0 3749.7 3751.9 3755.9 3646.9 3668.6 3685.5 3697.6 3698.7 4184.1 4195.0 4196.5 4205.7 4213.7 5010.1 5022.0 5028.4 5051.9 5074.6 1214.3 1248.4 1251.8 1259.9 1261.2 832.9 844.9 846.7 847.2 849.4 4249.1 4347.8 4437.2 4464.1 4464.4 5119.3 5151.9 5169.9 5174.6 5186.8 4413.8 4414.3 4418.5 4442.4 4460.0 2497.6 2639.3 2656.8 2667.3 2675.5 4722.2 4757.4 4784.9 4792.7 4818.8 5075.3 5116.7 5124.2 5129.5 5148.9 4602.6 4913.1 4921.8 4931.7 4936.4 5151.8 5156.9 5191.9 5197.2 5214.3 4837.6 5045.9 5085.8 5091.4 5104.8 4837.3 4862.9 4900.3 4901.6 4913.4 3625.3 3640.1 3645.4 3657.4 3676.8 5183.8 5204.6 5226.2 5228.4 5234.8 4687.8 4938.8 4991.4 4997.9 5002.7 4981.3 4989.8 4993.9 5004.3 5033.1 4819.3 4915.4 4924.1 4946.1 4950.7 4767.5 4906.3 4965.0 4981.0 5051.4 4896.9 4905.2 4915.3 4919.8 4925.8 20:58:20 INFO - PROCESS | 12786 | 20:58:20 INFO - PROCESS | 12786 | [#5] yui.html Cycles:180 Average:12799.17 Median:44271.17 stddev:14973.99 (33.8%) stddev-sans-first:14988.34 20:58:20 INFO - PROCESS | 12786 | Values: 679.7 718.3 754.5 772.5 779.5 10694.7 11811.0 11883.5 11946.6 11988.5 12345.3 12426.2 12441.6 12467.3 12499.2 671.2 827.0 858.5 858.9 864.8 852.4 853.3 855.5 858.7 858.9 712.8 914.9 915.7 916.0 916.1 731.3 734.4 859.6 895.6 896.9 668.6 668.8 668.9 668.9 669.6 11471.5 11511.8 11529.5 11550.0 11561.8 11601.3 11958.4 11986.5 12143.5 12189.5 10387.6 10453.9 10473.4 10508.2 10805.3 4086.7 4088.2 4092.5 4131.7 4199.9 42109.2 42958.8 44156.0 44386.3 44765.6 9813.1 10024.8 10039.5 10050.3 10108.7 17469.7 17690.9 17792.6 17821.4 17897.6 6494.0 6596.0 6623.2 6640.7 6745.7 3664.3 3760.0 3788.5 3800.0 3801.1 2594.2 2664.9 2666.3 2674.1 2676.6 489.6 496.5 496.7 501.8 512.0 510.6 519.8 599.2 604.9 613.2 7535.8 7663.5 7699.1 7849.1 7975.4 596.2 598.5 613.0 617.2 645.4 3286.2 3628.9 3644.7 3654.4 3711.4 55417.7 57296.0 57513.1 57686.4 57754.1 42718.8 49077.3 50916.5 51320.7 52540.0 42622.1 42760.0 43873.6 44024.0 44652.0 7650.3 7665.5 7882.2 7931.9 7980.7 27825.0 27972.0 28078.2 28967.6 31114.8 38881.4 39323.4 39381.8 39446.0 40026.8 9999.5 10147.2 10309.8 10548.4 10662.1 10818.2 10880.5 10915.2 10947.2 11623.8 10398.2 10526.3 10732.0 10748.2 10888.9 10215.8 10364.3 10684.9 10693.5 11016.2 9560.6 9616.1 9906.8 9924.3 9947.0 8568.6 8742.0 8798.1 8898.7 9099.1 8621.2 8999.8 9076.1 9085.1 9112.5 20:58:20 INFO - PROCESS | 12786 | -------- Summary: end -------- 20:58:20 INFO - PROCESS | 12786 | 20:58:21 INFO - TEST-INFO | 12786: exit 0 20:58:21 INFO - TEST-OK | dromaeo_css | took 1118770ms 20:58:21 INFO - TEST-START | kraken 20:58:21 INFO - operating with platform_type : linux_ 20:58:21 INFO - Initialising browser for kraken test... 20:58:21 INFO - TEST-INFO | started process 12964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6XJN3R/profile http://localhost:46597/getInfo.html) 20:58:25 INFO - PROCESS | 12964 | __metrics Screen width/height:1600/1200 20:58:25 INFO - PROCESS | 12964 | colorDepth:24 20:58:25 INFO - PROCESS | 12964 | Browser inner width/height: 1024/697 20:58:25 INFO - PROCESS | 12964 | __metrics 20:58:26 ERROR - PROCESS | 12964 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:58:27 INFO - TEST-INFO | 12964: exit 0 20:58:27 INFO - Browser initialized. 20:58:27 INFO - Running cycle 1/1 for kraken test... 20:58:27 INFO - TEST-INFO | started process 13043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6XJN3R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:58:39 INFO - PROCESS | 13043 | RSS: Main: 154513408 20:58:39 INFO - PROCESS | 13043 | 20:58:42 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46597/tests/kraken/driver.html?testName=audio-beat-detection) 20:58:43 INFO - PROCESS | 13043 | RSS: Main: 209649664 20:58:43 INFO - PROCESS | 13043 | 20:58:46 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46597/tests/kraken/driver.html?testName=audio-dft) 20:58:46 INFO - PROCESS | 13043 | RSS: Main: 197636096 20:58:46 INFO - PROCESS | 13043 | 20:58:50 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46597/tests/kraken/driver.html?testName=audio-fft) 20:58:50 INFO - PROCESS | 13043 | RSS: Main: 266915840 20:58:50 INFO - PROCESS | 13043 | 20:58:52 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46597/tests/kraken/driver.html?testName=audio-oscillator) 20:58:53 INFO - PROCESS | 13043 | RSS: Main: 176566272 20:58:53 INFO - PROCESS | 13043 | 20:58:55 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:58:56 INFO - PROCESS | 13043 | RSS: Main: 180490240 20:58:56 INFO - PROCESS | 13043 | 20:58:59 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46597/tests/kraken/driver.html?testName=imaging-darkroom) 20:59:00 INFO - PROCESS | 13043 | RSS: Main: 215883776 20:59:00 INFO - PROCESS | 13043 | 20:59:03 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46597/tests/kraken/driver.html?testName=imaging-desaturate) 20:59:04 INFO - PROCESS | 13043 | RSS: Main: 217300992 20:59:04 INFO - PROCESS | 13043 | 20:59:07 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46597/tests/kraken/driver.html?testName=json-parse-financial) 20:59:07 INFO - PROCESS | 13043 | RSS: Main: 217374720 20:59:07 INFO - PROCESS | 13043 | 20:59:09 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:59:10 INFO - PROCESS | 13043 | RSS: Main: 203710464 20:59:10 INFO - PROCESS | 13043 | 20:59:11 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46597/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:59:12 INFO - PROCESS | 13043 | RSS: Main: 208580608 20:59:12 INFO - PROCESS | 13043 | 20:59:14 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:59:15 INFO - PROCESS | 13043 | RSS: Main: 218083328 20:59:15 INFO - PROCESS | 13043 | 20:59:18 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:59:18 INFO - PROCESS | 13043 | RSS: Main: 224710656 20:59:18 INFO - PROCESS | 13043 | 20:59:21 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:59:22 INFO - PROCESS | 13043 | RSS: Main: 221605888 20:59:22 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | Cycle 1(1): loaded http://localhost:46597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46597/tests/kraken/driver.html?testName=ai-astar) 20:59:24 INFO - PROCESS | 13043 | RSS: Main: 268124160 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | __start_tp_report 20:59:24 INFO - PROCESS | 13043 | _x_x_mozilla_page_load 20:59:24 INFO - PROCESS | 13043 | _x_x_mozilla_page_load_details 20:59:24 INFO - PROCESS | 13043 | |i|pagename|runs| 20:59:24 INFO - PROCESS | 13043 | |0;ai-astar;114;108;114;114;114;114;114;115;114;115 20:59:24 INFO - PROCESS | 13043 | |1;audio-beat-detection;172;139;161;186;136;158;166;133;179;140 20:59:24 INFO - PROCESS | 13043 | |2;audio-dft;160;162;161;160;163;161;162;162;161;161 20:59:24 INFO - PROCESS | 13043 | |3;audio-fft;76;76;77;118;77;74;77;75;130;76 20:59:24 INFO - PROCESS | 13043 | |4;audio-oscillator;92;93;121;92;93;94;124;92;92;118 20:59:24 INFO - PROCESS | 13043 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;116 20:59:24 INFO - PROCESS | 13043 | |6;imaging-darkroom;146;145;146;146;145;146;147;147;146;145 20:59:24 INFO - PROCESS | 13043 | |7;imaging-desaturate;95;94;95;95;95;94;94;95;95;95 20:59:24 INFO - PROCESS | 13043 | |8;json-parse-financial;65;65;66;64;71;66;72;90;65;63 20:59:24 INFO - PROCESS | 13043 | |9;json-stringify-tinderbox;63;64;64;64;63;64;65;65;64;63 20:59:24 INFO - PROCESS | 13043 | |10;stanford-crypto-aes;82;81;83;82;89;86;83;83;92;91 20:59:24 INFO - PROCESS | 13043 | |11;stanford-crypto-ccm;135;133;133;142;131;142;132;129;179;132 20:59:24 INFO - PROCESS | 13043 | |12;stanford-crypto-pbkdf2;180;176;174;177;174;175;176;180;175;179 20:59:24 INFO - PROCESS | 13043 | |13;stanford-crypto-sha256-iterative;68;67;67;68;67;68;67;68;68;67 20:59:24 INFO - PROCESS | 13043 | __end_tp_report 20:59:24 INFO - PROCESS | 13043 | __start_cc_report 20:59:24 INFO - PROCESS | 13043 | _x_x_mozilla_cycle_collect,1868 20:59:24 INFO - PROCESS | 13043 | __end_cc_report 20:59:24 INFO - PROCESS | 13043 | __startTimestamp1462507164408__endTimestamp 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | ------- Summary: start ------- 20:59:24 INFO - PROCESS | 13043 | Number of tests: 14 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:2.01 (1.8%) stddev-sans-first:2.13 20:59:24 INFO - PROCESS | 13043 | Values: 114.0 108.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 115.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:163.50 stddev:19.08 (11.7%) stddev-sans-first:19.46 20:59:24 INFO - PROCESS | 13043 | Values: 172.0 139.0 161.0 186.0 136.0 158.0 166.0 133.0 179.0 140.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 20:59:24 INFO - PROCESS | 13043 | Values: 160.0 162.0 161.0 160.0 163.0 161.0 162.0 162.0 161.0 161.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#3] audio-fft Cycles:10 Average:85.60 Median:76.00 stddev:20.46 (26.9%) stddev-sans-first:21.40 20:59:24 INFO - PROCESS | 13043 | Values: 76.0 76.0 77.0 118.0 77.0 74.0 77.0 75.0 130.0 76.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:92.00 stddev:13.82 (15.0%) stddev-sans-first:14.26 20:59:24 INFO - PROCESS | 13043 | Values: 92.0 93.0 121.0 92.0 93.0 94.0 124.0 92.0 92.0 118.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:59:24 INFO - PROCESS | 13043 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 20:59:24 INFO - PROCESS | 13043 | Values: 146.0 145.0 146.0 146.0 145.0 146.0 147.0 147.0 146.0 145.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:59:24 INFO - PROCESS | 13043 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:66.00 stddev:8.03 (12.2%) stddev-sans-first:8.40 20:59:24 INFO - PROCESS | 13043 | Values: 65.0 65.0 66.0 64.0 71.0 66.0 72.0 90.0 65.0 63.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 20:59:24 INFO - PROCESS | 13043 | Values: 63.0 64.0 64.0 64.0 63.0 64.0 65.0 65.0 64.0 63.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:4.05 (4.8%) stddev-sans-first:4.13 20:59:24 INFO - PROCESS | 13043 | Values: 82.0 81.0 83.0 82.0 89.0 86.0 83.0 83.0 92.0 91.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:134.00 stddev:14.79 (11.0%) stddev-sans-first:15.62 20:59:24 INFO - PROCESS | 13043 | Values: 135.0 133.0 133.0 142.0 131.0 142.0 132.0 129.0 179.0 132.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:176.50 stddev:2.32 (1.3%) stddev-sans-first:2.11 20:59:24 INFO - PROCESS | 13043 | Values: 180.0 176.0 174.0 177.0 174.0 175.0 176.0 180.0 175.0 179.0 20:59:24 INFO - PROCESS | 13043 | 20:59:24 INFO - PROCESS | 13043 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 20:59:24 INFO - PROCESS | 13043 | Values: 68.0 67.0 67.0 68.0 67.0 68.0 67.0 68.0 68.0 67.0 20:59:24 INFO - PROCESS | 13043 | -------- Summary: end -------- 20:59:24 INFO - PROCESS | 13043 | 20:59:25 INFO - TEST-INFO | 13043: exit 0 20:59:25 INFO - TEST-OK | kraken | took 63705ms 20:59:25 INFO - SUITE-END | took 1182s 20:59:25 INFO - Completed test suite (00:19:42) 20:59:25 INFO - javascript benchmark 20:59:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2691.919242422727, 2725.509408306504, 2745.327394788277, 2757.903473378431, 2786.860656967151, 4668.859934201971, 4735.337052812609, 4754.16802059639, 4784.90430191396, 4855.9514404855945, 4773.737444440554, 4789.80840766369, 4797.6401769867225, 4822.180229361008, 4882.292067650197, 4302.763348015857, 4312.956870431287, 4317.222899878021, 4442.267025940716, 4448.154850578379, 4362.367456718774, 4415.249407600716, 4424.358468022151, 4439.089986552749, 4488.035072459421, 4255.63827074699, 4399.7360158390275, 4424.513303536608, 4439.134368798085, 4447.777611119431, 4271.508776490681, 4326.307790753496, 4328.4156638853665, 4346.826126954949, 4396.098799746044, 4311.48262208537, 4364.629006534448, 4367.519572846984, 4375.9562404375865, 4421.358902959053, 4560.315952607102, 4672.462666793328, 4690.202665546831, 4721.480637129913, 4726.314684370747, 5052.469490703496, 5072.974635126838, 5079.085764562377, 5137.101007323741, 5190.662606930575, 5134.05020071288, 5154.149565321717, 5172.560332371753, 5180.197069454241, 5180.6373553851245, 4660.930086048712, 4753.976230118897, 4829.2997515360075, 4861.173600487926, 4863.392075990501, 5225.451327610622, 5265.052290587654, 5274.736263186902, 5310.123829568155, 5328.280682107866, 5056.191009438472, 5066.265391518209, 5112.769925353368, 5116.872078198075, 5118.0, 4970.304157417964, 5060.3168572242275, 5086.745662716849, 5143.8456846294675, 5145.536901678792, 5071.0, 5088.440271570124, 5091.0836049511445, 5118.616103792156, 5137.383513978347, 5047.596192304681, 5066.290719299301, 5068.290439338495, 5073.315102461121, 5122.487751224922, 4287.849925252601, 4320.4383430153875, 4321.783910804447, 4387.692861499728, 4441.0, 3767.1900541383184, 3789.4315852622326, 3793.089658482, 3819.197968426606, 3845.69234461248, 4356.259435895905, 4356.738595684269, 4358.063016451478, 4359.832719109149, 4406.911861762746, 5003.174476211457, 5060.822871199491, 5061.493850614983, 5069.340985671913, 5100.948990510122, 4365.388845561624, 4397.956020439755, 4399.978000109979, 4443.911121777611, 4450.755208463501, 4642.048380082075, 4652.116097941381, 4652.790624421909, 4658.045100754337, 4697.248440249544, 4668.463126740468, 4798.976005119952, 4845.176320025534, 4849.660523763303, 4851.393575803025, 5107.438181799925, 5134.486551344836, 5147.716875571879, 5149.227615857501, 5185.196294574347, 4816.783244754065, 4849.030193961151, 4861.270809378621, 4862.708237505761, 4886.804527818847, 4922.704637721748, 5010.298558201782, 5024.321716568363, 5038.420581633159, 5119.334486516729, 5103.7448127592725, 5125.231215317732, 5130.640855140105, 5135.075686376488, 5179.22311653255, 4978.5270399312, 4980.402351717817, 4980.750962451791, 4980.800767969241, 4993.17612593918, 4897.608191344755, 4974.8756281093265, 5026.095302845523, 5033.320501732219, 5068.518490743373, 4950.851474455772, 4987.625928055483, 4990.451050384382, 5024.271480635361, 5026.944341688287, 4890.24201248807, 5072.721000345016, 5075.365579302587, 5116.2069879168785, 5122.1804511278015, 4740.4785473597185, 4777.761111944319, 4886.682365646222, 4890.315355850113, 4919.729414882216], "value": 4698.607566376854, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.5714399912065, 597.2802772658946, 611.1901730207474, 612.4763327355112, 632.6299115017714, 40872.59127408725, 42621.573784262146, 42690.0, 42730.78634606831, 47090.76454617722, 43629.345559816546, 43993.0, 44128.11743765123, 44140.3378949316, 44174.33738493917, 7914.24814642608, 8091.069527004382, 8092.514449133041, 8099.838003239932, 8102.473339232931, 7917.010373703287, 7982.28159465648, 7986.081600615946, 7986.361091112697, 7986.960065199695, 8011.719589814357, 8040.477368970998, 8040.959795201015, 8042.638081286356, 8043.919560804376, 7965.96017019917, 7985.241402066795, 7997.200279972015, 8004.319632831216, 8016.7194148204535, 7936.16670249627, 8028.317593004602, 8037.799055023613, 8039.598020098972, 8039.638216280223, 40503.392449113286, 40688.593114068775, 40830.79584602058, 41015.58984410147, 41085.0, 3202.2634793997513, 3361.932761344784, 3367.6800703933086, 3376.57792775903, 3382.6786455286956, 30074.69925300741, 30698.0, 31272.21819454509, 31474.685253147632, 32384.676153238637, 2931.413717256536, 3010.834404107773, 3022.3804120155314, 3050.3746731919905, 3053.3587946531256, 250762.0, 411935.0, 418732.999999997, 418891.0, 421155.0, 58605.41394586085, 59088.70455647694, 59396.109058364156, 59404.10893836596, 59737.40262597406, 35007.64992350044, 36338.27323453569, 36411.27177456436, 38539.42190867139, 63241.0, 14005.439782408794, 14108.294585270696, 14110.929445352913, 14114.929425352808, 14125.434982600786, 11102.389368584805, 11174.329540227613, 11191.66425007251, 11203.159763017806, 11207.327560346404, 19393.4181974541, 19477.280338283552, 19559.0, 19595.11821968015, 19683.409497715093, 6986.93013069873, 7013.438924885997, 7315.732123041874, 7318.268173182639, 7342.596157211405, 887.5784002598714, 904.6697955246419, 938.4650749073099, 970.8640790289365, 1084.7830433913248, 27577.44845103127, 27954.720452795213, 28752.281192970342, 28828.135155945354, 28977.13068607945, 1013.6806905824642, 1020.2908978260039, 1027.5992362978445, 1040.3601784902382, 1043.4886905416292, 15331.0, 15575.0, 15577.610559735871, 15743.606409839846, 15975.600609984844, 280914.0, 283804.0, 283915.0, 284598.0, 285163.0, 49062.0, 49913.25130123051, 50156.0, 50416.24375634368, 50488.242676359885, 1152.757920836617, 1255.3534929511309, 1289.3553223388305, 1295.1257900917033, 1315.0137396952287, 29188.562171567868, 30528.0, 30596.541051884684, 30740.0, 31142.377152457277, 44162.35025898457, 44843.10313793771, 44878.326825097, 44927.775361122985, 44941.550584493736, 270426.0, 276667.0, 276724.0, 277819.0, 278271.0, 23936.281911542683, 25801.483970320864, 26448.8677556611, 26838.329041774112, 28774.712252878042, 43169.3524597125, 43362.34956475718, 43812.12375752403, 44520.554794451644, 44586.10827783491, 37972.0, 38264.2347153061, 38348.61651383562, 38407.80796096002, 38874.0, 36530.8173459131, 37623.623763763106, 37763.81118094392, 37779.62220377761, 37927.24145517129, 36754.8162259187, 37617.62382376141, 37782.62217377791, 37933.62066379301, 38048.0, 32698.34603307873, 33142.834285828416, 33484.665153348156, 34023.31953360968, 34336.0, 25894.35264118412, 26071.0, 26173.214803555922, 26240.0, 26404.471910562064], "value": 18037.28336109974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.30006238303184, 379.29640516841266, 380.4863434363609, 391.12778503936204, 391.71013450046956, 16036.759448608265, 16159.272832722527, 16969.406070787525, 16980.405685801, 16984.745228821546, 10112.342697724644, 10115.190784737222, 10125.544350504226, 10130.290879638409, 10361.430121343323, 3399.133221028634, 4618.792154353062, 4758.310045043467, 4796.352492413532, 5106.489351064901, 5135.948640513584, 5358.062339090644, 5382.381026182, 5396.487333703292, 5474.206240095184, 5419.5393391561765, 5435.918461223085, 5455.290812194409, 5459.153831156157, 5464.672119672832, 5301.655392399501, 5340.973295133538, 5402.35171779385, 5429.891402171954, 5435.076037073667, 5080.288759573663, 5262.789488420459, 5270.39390470097, 5275.366955965309, 5278.049951008817, 12371.0, 12459.563915262923, 12576.056795740356, 12576.937115314366, 13578.524751633744, 1858.7583614130076, 1941.6602094633524, 1963.7741659709172, 1969.1827891425041, 2093.7801530839197, 8807.77980550485, 8907.599158037903, 9175.862362064574, 9179.311551633587, 9204.125608067223, 1750.6936286149873, 1769.6549172911286, 1801.3335066025522, 1809.5928416106403, 1811.936582219616, 68215.65892170557, 68356.6582167091, 68872.31127688759, 69218.65390673064, 69943.0, 9979.750506237402, 10037.297389182688, 10120.696379108638, 10311.587536498606, 10325.380477171393, 14032.579022629337, 14088.85911140896, 14137.222452765196, 14163.0, 14175.220362879934, 7232.602206878672, 7382.852342953111, 7447.664855081426, 7547.320741133324, 7588.734394296173, 6880.793576192722, 6971.0, 7035.296470352924, 7067.187273463617, 7086.893696594555, 4270.551592082787, 4396.142752163298, 4405.889852753643, 4423.8009289581405, 4490.595846373842, 1651.38898607516, 1704.5227336345843, 1818.1011491306424, 1846.4183782108862, 1887.584731359099, 896.8430524658158, 927.7402327348218, 931.3806318797923, 960.4669408478222, 1004.2568499310604, 16935.745963810554, 17033.574160645836, 17123.0, 17383.391581294592, 17438.320053021493, 909.4316052467208, 927.0127314410132, 951.990480095204, 963.2967933408651, 968.9079537443931, 9492.620295188115, 9529.094736000068, 10323.32898361604, 10343.37939723619, 10605.787884242272, 398108.0, 403967.0, 417424.0, 418848.7748296351, 420839.0, 78488.0, 84415.15584844195, 85567.57216214003, 86091.56954215189, 87011.56494217615, 955.3169483819103, 979.4955597867104, 981.3081777346953, 982.1504398695077, 1017.29298137795, 15704.29330680145, 15831.604209894846, 15876.206189690238, 15891.682166356839, 16439.589010274838, 35574.82212588921, 36029.45955810612, 36259.818700906326, 36576.45135323025, 36894.0, 50591.241131383795, 50612.24081638705, 50849.74575127101, 51324.0, 51739.22391164211, 6315.400036996478, 7243.818904527429, 7270.636468176464, 7284.453665975179, 7652.04349456318, 9251.907480925374, 10234.948825255826, 10252.38485690861, 10487.52806123711, 10537.315074520131, 8720.302375810046, 8827.073157318646, 8868.822623547621, 8905.243054340453, 8986.460812351279, 9263.490508022123, 9284.58219380116, 9289.907100928904, 9389.906100939177, 9542.236621070158, 9101.908980910106, 9294.163525282756, 9426.387284826464, 9453.196478299422, 9529.809403811747, 7407.777766667009, 7616.04799400075, 7676.347510461674, 7717.305442510201, 7813.296803287732, 8375.288100511281, 9448.244140468883, 9681.951590242004, 9703.641490191238, 9740.17208537254], "value": 7941.239450192787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.6223857319953, 1536.677297767469, 1546.5592306192734, 1700.2518891687664, 1845.1696736468584, 7294.197638259787, 7575.962120189405, 7606.391488680906, 7809.180036096199, 7811.3360364368955, 7556.622168891561, 7700.614969251529, 7730.845383092349, 7733.7293194738195, 7747.0, 1881.07827164689, 2068.88621125838, 2138.379869837753, 2142.357292812154, 2171.359448962552, 2143.517708515587, 2149.8065174134326, 2153.8923053847243, 2154.482924098213, 2158.4927542027613, 2133.935981920537, 2138.9786102139014, 2170.4573856535867, 2171.0664414301846, 2172.6523756199012, 1834.5505351188976, 2067.0, 2134.103676455892, 2134.487722946482, 2148.709924160242, 2091.937241882746, 2118.50215199428, 2138.422625891016, 2142.967855482169, 2143.6570148776277, 7683.2700893415595, 7709.6916123354995, 7731.961340193319, 7782.766517004499, 7785.688572457095, 4374.12517496502, 4536.7504787236685, 4549.863504094882, 4558.133954548625, 4568.314752787075, 2780.263230243987, 2786.7213278672175, 2798.3423895384567, 2813.4513769814894, 2839.33275680215, 902.251131560803, 904.3398319226935, 917.6742256498914, 918.2057520245007, 918.4581097152712, 10287.69136925901, 10311.123554497877, 10317.484125793755, 10332.431716255604, 10349.9482502587, 4048.736832105904, 4140.358244472111, 4215.936760948588, 4216.093539888877, 4225.112726327444, 8892.555372231363, 8898.288136949028, 8916.777080573038, 8924.419912705653, 8934.0, 4450.599446049806, 4457.665675074318, 4472.508024117345, 4492.191405546968, 4498.370228168059, 3450.46517789743, 3815.08437974884, 3904.3362628353248, 3908.9413658795143, 3960.584138665456, 3611.9277614448088, 3656.0859785053735, 3699.9445008324897, 3732.234891847165, 3784.6783023442763, 1188.4948896719034, 1194.7849387110405, 1196.611101392051, 1210.1831263896834, 1212.0969877441362, 751.6317004667674, 757.1595528962847, 821.650798410673, 888.1828717579842, 927.823713494434, 5179.766910489037, 5235.058727260045, 5265.78936842522, 5268.00296956199, 5307.4427185145005, 371.08897656253833, 371.70449492653404, 380.6174794331679, 382.075377586242, 382.35000499151556, 3615.584207816135, 3653.926921461556, 3732.8880133596035, 3770.2836461072857, 3845.307844588001, 9058.637654493747, 9430.245580353556, 9534.237261019101, 9595.184409325146, 9596.856047159297, 9305.395149315273, 9394.718158455258, 9523.90476095244, 9579.233661307078, 9582.041795820362, 7162.4986250962975, 7277.163126240444, 7322.597257150908, 7401.444891633149, 7408.85182296351, 5282.788688452419, 5327.813526526708, 5417.891642167056, 5518.144687573433, 5531.695756733418, 8591.52746598918, 8697.95651021741, 8802.471851688919, 8844.425112367675, 8866.246369058703, 8637.093105223861, 8892.28861691076, 8921.420107692978, 8997.32520060985, 9012.05373435806, 6092.847678807888, 6551.50863685216, 6700.0, 6707.42986846104, 6804.523683342317, 7499.987501687202, 7500.099988001475, 7539.095308563007, 7554.395648348009, 7565.167831538416, 6739.359760822714, 6831.0436538883605, 6886.345797149263, 6950.687219075255, 7039.331263529956, 6709.194896612437, 6712.39588437043, 6729.259781424137, 6770.796876093725, 6823.0, 6431.324710905287, 6437.163168788027, 6488.935110648833, 6498.610083395011, 6573.5398522103, 4715.905681886412, 4729.739864307496, 4767.6424268179335, 4804.375431193923, 4849.75751212445, 4641.767911604474, 4688.085823264567, 4718.882027949328, 4757.35775670294, 4811.109944660249], "value": 4024.3475168692403, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.5109738992408, 297.1249669722667, 299.62546816479403, 304.4519864244361, 307.2641024745735, 4787.13831510328, 4789.257665061917, 4806.855794326167, 4807.567318941295, 4844.903101937959, 4726.550977657125, 4745.31192977019, 4763.261694437359, 4764.0, 4771.42742870856, 3578.4274516077367, 3648.8358023888854, 3668.504751858505, 3693.722970777189, 3713.8885833425043, 3558.6085530591613, 3681.4293784463453, 3682.742208045438, 3692.20617567223, 3743.5694895087004, 3631.691306238973, 3645.4714066460347, 3671.192337685718, 3674.4672022556715, 3701.9629803702023, 3599.3341231871927, 3666.9633303666888, 3668.486411902349, 3683.2449347883753, 3782.5650050244026, 3363.4954756786433, 3367.8821241256683, 3377.712894403954, 3380.3915295246848, 3382.458806590934, 4477.082198149372, 4515.345274935116, 4535.750533720644, 4544.659150563721, 4553.927962776928, 4240.194363071007, 4266.914661706748, 4279.486461624594, 4298.78506074695, 4302.763348015857, 4711.623070154379, 4911.435184953741, 4942.382202224722, 4950.331705219785, 4952.158133117378, 3628.0, 3645.8177091145603, 3651.7991510466913, 3653.4337177737493, 3685.760425572356, 5181.844544663666, 5215.0534947754395, 5233.816816411408, 5234.790608375661, 5250.474952504757, 3460.463628137643, 3654.0, 3749.718771092179, 3751.9249615008093, 3755.9436608450897, 3646.9452958205648, 3668.5781135169796, 3685.4656074868994, 3697.630236976335, 3698.7041036716996, 4184.121334519785, 4194.979025104916, 4196.475440569929, 4205.663546916239, 4213.672693101663, 5010.098182327143, 5022.0, 5028.371453568304, 5051.9390927904815, 5074.619403544749, 1214.2532342609231, 1248.3820508847996, 1251.7997120460682, 1259.9290602987571, 1261.1928365845683, 832.937529685276, 844.9450785699033, 846.7163500227492, 847.1740053447962, 849.3544905871458, 4249.086446414036, 4347.826086956549, 4437.245668236407, 4464.129494748558, 4464.352668863062, 5119.283300337956, 5151.896962060738, 5169.948300517022, 5174.560162386239, 5186.844394668166, 4413.801378937956, 4414.3157810539415, 4418.497710778351, 4442.42248507692, 4459.955400446019, 2497.600383938561, 2639.28739240404, 2656.7646044588973, 2667.2665017120057, 2675.4916565852427, 4722.229164063476, 4757.381540399726, 4784.928226076611, 4792.705969388246, 4818.807247710052, 5075.3402057732255, 5116.692998420107, 5124.231365295161, 5129.538341549279, 5148.9485105149215, 4602.608778253819, 4913.115639184981, 4921.827736029221, 4931.717753384146, 4936.358273424432, 5151.8196863109615, 5156.871078223075, 5191.92212116811, 5197.246399272009, 5214.322138122172, 4837.637177211653, 5045.8738531537, 5085.7711402986215, 5091.363579552556, 5104.779420951898, 4837.298591704253, 4862.927056094232, 4900.338454308623, 4901.607871370211, 4913.434954980223, 3625.2568223514645, 3640.1263696712067, 3645.3778068759148, 3657.4148136298063, 3676.7793932364143, 5183.844484665466, 5204.609654275869, 5226.163813789775, 5228.398734145622, 5234.816781412632, 4687.789049492849, 4938.75306234694, 4991.376077990251, 4997.925031124463, 5002.724850133132, 4981.252812078217, 4989.775460104376, 4993.925091123563, 5004.299398084198, 5033.119204139188, 4819.349387832738, 4915.43472500667, 4924.138275801792, 4946.134426475281, 4950.653454258168, 4767.545898500991, 4906.3376444181, 4964.950350496449, 4980.975095124646, 5051.368578927634, 4896.90206195867, 4905.166121759238, 4915.336429581961, 4919.827806026772, 4925.778339974638], "value": 3759.993996649714, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.7450955891541, 718.2637796258838, 754.5020286610835, 772.4901564967123, 779.477749907562, 10694.732631684203, 11810.999999999989, 11883.465244064017, 11946.581869634565, 11988.460519276632, 12345.321007344592, 12426.192297500656, 12441.626751197457, 12467.314297713645, 12499.18755280906, 671.2180309938927, 827.0488937721608, 858.5063588436674, 858.935579831512, 864.7967727584013, 852.4373913217278, 853.2747164909839, 855.4696088425154, 858.6994551906814, 858.8969323681167, 712.8075419636695, 914.9176574108329, 915.7252824152761, 915.9908400916006, 916.1022198245723, 731.3344856180877, 734.4381548115696, 859.5916939453772, 895.6193617712446, 896.9327300452427, 668.6422763821332, 668.759246671198, 668.906353110565, 668.9163854518185, 669.6417416682052, 11471.541138354456, 11511.827322590168, 11529.538818447336, 11550.0, 11561.826572601418, 11601.303921764722, 11958.402079896057, 11986.460609272604, 12143.453544590515, 12189.451474683572, 10387.636432724817, 10453.947730261376, 10473.423961682105, 10508.246884095797, 10805.297655652357, 4086.734362266443, 4088.2232375848494, 4092.529359123709, 4131.669466442678, 4199.91600167998, 42109.1578168438, 42958.785206074084, 44156.0, 44386.33420498695, 44765.55234447646, 9813.093433335998, 10024.799504010025, 10039.548220330104, 10050.296479246528, 10108.747281318027, 17469.7379539307, 17690.911545442446, 17792.644147116986, 17821.376251831123, 17897.642047159243, 6493.967530162414, 6595.967020164869, 6623.172103487064, 6640.701168447432, 6745.730170793114, 3664.303782281358, 3759.962400376016, 3788.507494025814, 3799.962000380016, 3801.0877389426337, 2594.15689900783, 2664.9467010659678, 2666.2801043718086, 2674.1175412113957, 2676.6215399069497, 489.57407055861626, 496.5183771741405, 496.74169431895933, 501.8250428477618, 511.9795208191705, 510.6297933997896, 519.8466452396476, 599.1611743559052, 604.9395060494004, 613.1599708399432, 7535.8116047099265, 7663.463557551029, 7699.11460182075, 7849.097353804272, 7975.441719079608, 596.1594152245314, 598.4912824099567, 613.0436519030327, 617.1668247865346, 645.3578689204272, 3286.1620286827183, 3628.9274214515563, 3644.7448678592773, 3654.3604869147794, 3711.3690672585726, 55417.722911385994, 57296.0, 57513.137302940486, 57686.423135768106, 57754.13368799471, 42718.78640606839, 49077.26384104241, 50916.490835091914, 51320.74339628278, 52540.0, 42622.14755704869, 42760.0, 43873.56126438759, 44024.0, 44652.0, 7650.349720273839, 7665.463417560717, 7882.211778822301, 7931.920680793349, 7980.720674776355, 27825.0, 27972.0, 28078.157655270374, 28967.5654865173, 31114.844425777726, 38881.416778748906, 39323.410148847215, 39381.80309098436, 39446.0, 40026.79986600048, 9999.453147138172, 10147.188224942134, 10309.845352319571, 10548.354046951, 10662.147028237567, 10818.24272300963, 10880.45597720095, 10915.181361398085, 10947.178961577754, 11623.76752464963, 10398.22013349017, 10526.315789473965, 10732.0, 10748.193885458779, 10888.945555272174, 10215.795684086424, 10364.274500784873, 10684.893151068702, 10693.465326733476, 11016.228863979444, 9560.6284970335, 9616.064273020995, 9906.801863962537, 9924.255680823822, 9947.0, 8568.614412351335, 8741.956290218508, 8798.076201998698, 8898.73303800887, 9099.135582119688, 8621.224089831945, 8999.775005624912, 9076.137766912132, 9085.091490850862, 9112.544372781202], "value": 5908.171880683675, "unit": "score"}], "name": "dromaeo_css", "value": 6259.928388023019, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 139.0, 161.0, 186.0, 136.0, 158.0, 166.0, 133.0, 179.0, 140.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 160.0, 163.0, 161.0, 162.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 118.0, 77.0, 74.0, 77.0, 75.0, 130.0, 76.0], "value": 85.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 121.0, 92.0, 93.0, 94.0, 124.0, 92.0, 92.0, 118.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 71.0, 66.0, 72.0, 90.0, 65.0, 63.0], "value": 68.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 65.0, 65.0, 64.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 83.0, 82.0, 89.0, 86.0, 83.0, 83.0, 92.0, 91.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 133.0, 142.0, 131.0, 142.0, 132.0, 129.0, 179.0, 132.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 174.0, 177.0, 174.0, 175.0, 176.0, 180.0, 175.0, 179.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1576.6000000000001, "alertThreshold": 2.0}]} 20:59:25 INFO - Return code: 0 20:59:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:59:25 ERROR - # TBPL SUCCESS # 20:59:25 INFO - Running post-action listener: _resource_record_post_action 20:59:25 INFO - Running post-run listener: _resource_record_post_run 20:59:26 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 16384; Write bytes: 519467008; Read time: 28; Write time: 355884 20:59:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234700800; Read time: 0; Write time: 184520 20:59:26 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 284766208; Read time: 28; Write time: 171364 20:59:26 INFO - Running post-run listener: _upload_blobber_files 20:59:26 INFO - Blob upload gear active. 20:59:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:59:26 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 20:59:26 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:59:26 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:59:27 INFO - (blobuploader) - INFO - Open directory for files ... 20:59:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:59:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:59:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:59:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:59:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:59:27 INFO - (blobuploader) - INFO - Done attempting. 20:59:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:59:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:59:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:59:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:59:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:59:28 INFO - (blobuploader) - INFO - Done attempting. 20:59:28 INFO - (blobuploader) - INFO - Iteration through files over. 20:59:28 INFO - Return code: 0 20:59:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:59:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:59:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/46698078e8edceef6e8137076f131a53f425bc488a5a4e783bc067b8506bd01e6e994b15d618dcc201884b5d404f2607767e5d00b046ba1b49d3e57fc1543c7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4fd3f59f12d5cef6b6cc6e7babdaf0e106869ee87a7c197b177de6a17cf33e69bdcf54413ff208a724b75b068a5ae55bb0806b5802d204f392aee8b620543eb"} 20:59:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:59:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:59:28 INFO - Contents: 20:59:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/46698078e8edceef6e8137076f131a53f425bc488a5a4e783bc067b8506bd01e6e994b15d618dcc201884b5d404f2607767e5d00b046ba1b49d3e57fc1543c7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4fd3f59f12d5cef6b6cc6e7babdaf0e106869ee87a7c197b177de6a17cf33e69bdcf54413ff208a724b75b068a5ae55bb0806b5802d204f392aee8b620543eb"} 20:59:28 INFO - Running post-run listener: copy_logs_to_upload_dir 20:59:28 INFO - Copying logs to upload dir... 20:59:28 INFO - mkdir: /builds/slave/test/build/upload/logs 20:59:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.802154 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-05 20:59:28.761141) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 20:59:28.764906) ========= 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-1462505274.121429-2112475437 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-Non-PGO/sha512/46698078e8edceef6e8137076f131a53f425bc488a5a4e783bc067b8506bd01e6e994b15d618dcc201884b5d404f2607767e5d00b046ba1b49d3e57fc1543c7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4fd3f59f12d5cef6b6cc6e7babdaf0e106869ee87a7c197b177de6a17cf33e69bdcf54413ff208a724b75b068a5ae55bb0806b5802d204f392aee8b620543eb"} build_url:https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011118 build_url: 'https://queue.taskcluster.net/v1/task/H9yp_8bJTVSSuQViz4SCQw/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-Non-PGO/sha512/46698078e8edceef6e8137076f131a53f425bc488a5a4e783bc067b8506bd01e6e994b15d618dcc201884b5d404f2607767e5d00b046ba1b49d3e57fc1543c7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4fd3f59f12d5cef6b6cc6e7babdaf0e106869ee87a7c197b177de6a17cf33e69bdcf54413ff208a724b75b068a5ae55bb0806b5802d204f392aee8b620543eb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 20:59:28.794327) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 20:59:28.794700) ========= 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-1462505274.121429-2112475437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 20:59:28.878195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 20:59:28.878957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 20:59:28.879698) ========= ========= Total master_lag: 0.23 =========