builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1452188189.36 results: success (0) buildid: 20160107090124 builduid: a6651b293b0f4e6eaf72071caa98cf62 revision: dfd6b2cbd7406d464cdb006b239222ca594bff8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.362952) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.363486) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.363788) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006362 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.414312) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.414622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.516293) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.516563) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.565583) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.565865) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.566281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.566559) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 09:36:30-- 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% 73.8M=0s 2016-01-07 09:36:30 (73.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.745226) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.745551) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020799 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:29.795791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 09:36:29.796197) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dfd6b2cbd7406d464cdb006b239222ca594bff8e --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 dfd6b2cbd7406d464cdb006b239222ca594bff8e --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=fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 09:36:30,588 truncating revision to first 12 chars 2016-01-07 09:36:30,588 Setting DEBUG logging. 2016-01-07 09:36:30,588 attempt 1/10 2016-01-07 09:36:30,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dfd6b2cbd740?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 09:36:31,785 unpacking tar archive at: fx-team-dfd6b2cbd740/testing/mozharness/ program finished with exit code 0 elapsedTime=1.511619 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 09:36:31.320669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:31.321024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:31.329213) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:31.329485) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 09:36:31.329887) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-07 09:36:31.330198) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:36:32 INFO - MultiFileLogger online at 20160107 09:36:32 in /builds/slave/test 09:36:32 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 09:36:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:36:32 INFO - {'append_to_log': False, 09:36:32 INFO - 'base_work_dir': '/builds/slave/test', 09:36:32 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:36:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:36:32 INFO - 'branch': 'Fx-Team-Non-PGO', 09:36:32 INFO - 'buildbot_json_path': 'buildprops.json', 09:36:32 INFO - 'config_files': ('talos/linux_config.py',), 09:36:32 INFO - 'default_actions': ('clobber', 09:36:32 INFO - 'read-buildbot-config', 09:36:32 INFO - 'download-and-extract', 09:36:32 INFO - 'populate-webroot', 09:36:32 INFO - 'create-virtualenv', 09:36:32 INFO - 'install', 09:36:32 INFO - 'run-tests'), 09:36:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:36:32 INFO - 'download_minidump_stackwalk': True, 09:36:32 INFO - 'download_symbols': 'ondemand', 09:36:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:36:32 INFO - 'tooltool.py': '/tools/tooltool.py', 09:36:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:36:32 INFO - '/tools/misc-python/virtualenv.py')}, 09:36:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:36:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:36:32 INFO - 'installer_path': 'installer.exe', 09:36:32 INFO - 'log_level': 'info', 09:36:32 INFO - 'log_name': 'talos', 09:36:32 INFO - 'log_to_console': True, 09:36:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:36:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:36:32 INFO - 'opt_config_files': (), 09:36:32 INFO - 'pip_index': False, 09:36:32 INFO - 'sps_profile': False, 09:36:32 INFO - 'sps_profile_interval': 0, 09:36:32 INFO - 'suite': 'dromaeojs', 09:36:32 INFO - 'system_bits': '32', 09:36:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:36:32 INFO - 'title': 'talos-linux64-ix-014', 09:36:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:36:32 INFO - 'use_talos_json': True, 09:36:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:36:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:36:32 INFO - 'work_dir': 'build'} 09:36:32 INFO - ##### 09:36:32 INFO - ##### Running clobber step. 09:36:32 INFO - ##### 09:36:32 INFO - Running pre-action listener: _resource_record_pre_action 09:36:32 INFO - Running main action method: clobber 09:36:32 INFO - rmtree: /builds/slave/test/build 09:36:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:36:32 INFO - Running post-action listener: _resource_record_post_action 09:36:32 INFO - ##### 09:36:32 INFO - ##### Running read-buildbot-config step. 09:36:32 INFO - ##### 09:36:32 INFO - Running pre-action listener: _resource_record_pre_action 09:36:32 INFO - Running main action method: read_buildbot_config 09:36:32 INFO - Using buildbot properties: 09:36:32 INFO - { 09:36:32 INFO - "project": "", 09:36:32 INFO - "product": "firefox", 09:36:32 INFO - "script_repo_revision": "production", 09:36:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:36:32 INFO - "repository": "", 09:36:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:36:32 INFO - "buildid": "20160107090124", 09:36:32 INFO - "pgo_build": "False", 09:36:32 INFO - "basedir": "/builds/slave/test", 09:36:32 INFO - "buildnumber": 1104, 09:36:32 INFO - "slavename": "talos-linux64-ix-014", 09:36:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:36:32 INFO - "platform": "ubuntu64_hw", 09:36:32 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:36:32 INFO - "branch": "fx-team", 09:36:32 INFO - "repo_path": "integration/fx-team", 09:36:32 INFO - "revision": "dfd6b2cbd7406d464cdb006b239222ca594bff8e", 09:36:32 INFO - "stage_platform": "linux64", 09:36:32 INFO - "builduid": "a6651b293b0f4e6eaf72071caa98cf62", 09:36:32 INFO - "slavebuilddir": "test" 09:36:32 INFO - } 09:36:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:36:32 INFO - Running post-action listener: _resource_record_post_action 09:36:32 INFO - ##### 09:36:32 INFO - ##### Running download-and-extract step. 09:36:32 INFO - ##### 09:36:32 INFO - Running pre-action listener: _resource_record_pre_action 09:36:32 INFO - Running main action method: download_and_extract 09:36:32 INFO - mkdir: /builds/slave/test/build/tests 09:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:32 INFO - https://queue.taskcluster.net/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:36:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/test_packages.json 09:36:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/test_packages.json 09:36:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:36:34 INFO - Downloaded 1302 bytes. 09:36:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:36:34 INFO - Using the following test package requirements: 09:36:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:36:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:34 INFO - u'jsshell-linux-x86_64.zip'], 09:36:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:36:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:36:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:36:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:36:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:36:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:34 INFO - https://queue.taskcluster.net/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:36:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:36:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:36:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:36:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:36:36 INFO - Downloaded 22788114 bytes. 09:36:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:36:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:36:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:36:37 INFO - Return code: 0 09:36:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:37 INFO - https://queue.taskcluster.net/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:36:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:36:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:36:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:36:38 INFO - Downloaded 22788114 bytes. 09:36:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:36:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:36:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:36:39 INFO - Return code: 0 09:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:39 INFO - https://queue.taskcluster.net/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:36:41 INFO - Downloaded 11132285 bytes. 09:36:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 09:36:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:36:41 INFO - Return code: 0 09:36: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')]} 09:36:41 INFO - https://queue.taskcluster.net/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:36:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:36:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:36:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:36:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:36:42 INFO - Downloaded 54034635 bytes. 09:36:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:36:42 INFO - mkdir: /builds/slave/test/properties 09:36:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:36:42 INFO - Writing to file /builds/slave/test/properties/build_url 09:36:42 INFO - Contents: 09:36:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:36:42 INFO - Running post-action listener: _resource_record_post_action 09:36:42 INFO - Running post-action listener: set_extra_try_arguments 09:36:42 INFO - ##### 09:36:42 INFO - ##### Running populate-webroot step. 09:36:42 INFO - ##### 09:36:42 INFO - Running pre-action listener: _resource_record_pre_action 09:36:42 INFO - Running main action method: populate_webroot 09:36:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:42 INFO - '--tppagecycles', 09:36:42 INFO - '7'], 09:36:42 INFO - 'tests': ['tsvgm']}}, 09:36:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:36:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:36:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:36:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:36:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:36:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:36:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:42 INFO - 'talos_options': ['--e10s'], 09:36:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:42 INFO - 'tests': ['damp', 'tps']}, 09:36:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:42 INFO - 'talos_options': ['--e10s'], 09:36:42 INFO - 'tests': ['damp', 'tps']}, 09:36:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:36:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:42 INFO - 'other': {'tests': ['a11yr', 09:36:42 INFO - 'ts_paint', 09:36:42 INFO - 'tpaint', 09:36:42 INFO - 'sessionrestore', 09:36:42 INFO - 'sessionrestore_no_auto_restore']}, 09:36:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:36:42 INFO - 'tests': ['a11yr', 09:36:42 INFO - 'ts_paint', 09:36:42 INFO - 'tpaint', 09:36:42 INFO - 'sessionrestore', 09:36:42 INFO - 'sessionrestore_no_auto_restore']}, 09:36:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:36:42 INFO - 'tests': ['a11yr', 09:36:42 INFO - 'ts_paint', 09:36:42 INFO - 'tpaint', 09:36:42 INFO - 'sessionrestore', 09:36:42 INFO - 'sessionrestore_no_auto_restore']}, 09:36:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:36:42 INFO - 'tests': ['a11yr', 09:36:42 INFO - 'ts_paint', 09:36:42 INFO - 'tpaint', 09:36:42 INFO - 'sessionrestore', 09:36:42 INFO - 'sessionrestore_no_auto_restore']}, 09:36:42 INFO - 'other_l64': {'tests': ['a11yr', 09:36:42 INFO - 'ts_paint', 09:36:42 INFO - 'tpaint', 09:36:42 INFO - 'sessionrestore', 09:36:42 INFO - 'sessionrestore_no_auto_restore']}, 09:36:42 INFO - 'other_nol64': {'tests': ['a11yr', 09:36:42 INFO - 'ts_paint', 09:36:42 INFO - 'tpaint', 09:36:42 INFO - 'sessionrestore', 09:36:42 INFO - 'sessionrestore_no_auto_restore']}, 09:36:42 INFO - 'svgr': {'tests': ['tsvgx', 09:36:42 INFO - 'tsvgr_opacity', 09:36:42 INFO - 'tart', 09:36:42 INFO - 'tscrollx', 09:36:42 INFO - 'cart']}, 09:36:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:36:42 INFO - 'tests': ['tsvgx', 09:36:42 INFO - 'tsvgr_opacity', 09:36:42 INFO - 'tart', 09:36:42 INFO - 'tscrollx', 09:36:42 INFO - 'cart']}, 09:36:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:42 INFO - 'tests': ['tp5o']}, 09:36:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:42 INFO - 'talos_options': ['--e10s'], 09:36:42 INFO - 'tests': ['tp5o']}, 09:36:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:42 INFO - 'talos_options': ['--xperf_path', 09:36:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:42 INFO - 'tests': ['tp5n']}, 09:36:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:42 INFO - 'talos_options': ['--e10s', 09:36:42 INFO - '--xperf_path', 09:36:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:42 INFO - 'tests': ['tp5n']}}, 09:36:42 INFO - 'talos.zip': {'path': '', 09:36:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:42 INFO - Running post-action listener: _resource_record_post_action 09:36:42 INFO - ##### 09:36:42 INFO - ##### Running create-virtualenv step. 09:36:42 INFO - ##### 09:36:42 INFO - Running pre-action listener: _resource_record_pre_action 09:36:42 INFO - Running main action method: create_virtualenv 09:36:42 INFO - Creating virtualenv /builds/slave/test/build/venv 09:36:42 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 09:36:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:36:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:42 INFO - Using real prefix '/usr' 09:36:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:36:43 INFO - Installing distribute.............................................................................................................................................................................................done. 09:36:45 INFO - Installing pip.................done. 09:36:45 INFO - Return code: 0 09:36:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:36: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')]} 09:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fac99b91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe393d0>, '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 0xda4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda5360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', '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 09:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 09:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 09:36:45 INFO - Using env: {'DISPLAY': ':0', 09:36:45 INFO - 'HOME': '/home/cltbld', 09:36:45 INFO - 'LANG': 'en_US.UTF-8', 09:36:45 INFO - 'LANGUAGE': 'en_US:en', 09:36:45 INFO - 'LOGNAME': 'cltbld', 09:36:45 INFO - 'MAIL': '/var/mail/cltbld', 09:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:45 INFO - 'MOZ_NO_REMOTE': '1', 09:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:45 INFO - 'NO_EM_RESTART': '1', 09:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:45 INFO - 'PWD': '/builds/slave/test', 09:36:45 INFO - 'SHELL': '/bin/bash', 09:36:45 INFO - 'SHLVL': '1', 09:36:45 INFO - 'TERM': 'linux', 09:36:45 INFO - 'TMOUT': '86400', 09:36:45 INFO - 'USER': 'cltbld', 09:36:45 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', 09:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:45 INFO - '_': '/tools/buildbot/bin/python'} 09:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:45 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 09:36:45 INFO - Cleaning up... 09:36:45 INFO - Return code: 0 09:36:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:36: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')]} 09:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fac99b91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe393d0>, '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 0xda4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda5360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', '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 09:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 09:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 09:36:45 INFO - Using env: {'DISPLAY': ':0', 09:36:45 INFO - 'HOME': '/home/cltbld', 09:36:45 INFO - 'LANG': 'en_US.UTF-8', 09:36:45 INFO - 'LANGUAGE': 'en_US:en', 09:36:45 INFO - 'LOGNAME': 'cltbld', 09:36:45 INFO - 'MAIL': '/var/mail/cltbld', 09:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:45 INFO - 'MOZ_NO_REMOTE': '1', 09:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:45 INFO - 'NO_EM_RESTART': '1', 09:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:45 INFO - 'PWD': '/builds/slave/test', 09:36:45 INFO - 'SHELL': '/bin/bash', 09:36:45 INFO - 'SHLVL': '1', 09:36:45 INFO - 'TERM': 'linux', 09:36:45 INFO - 'TMOUT': '86400', 09:36:45 INFO - 'USER': 'cltbld', 09:36:45 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', 09:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:45 INFO - '_': '/tools/buildbot/bin/python'} 09:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:45 INFO - Downloading/unpacking psutil>=0.7.1 09:36:45 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 09:36:45 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 09:36:45 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 09:36:45 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 09:36:45 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 09:36:45 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 09:36:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:36:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:36:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:47 INFO - Installing collected packages: psutil 09:36:47 INFO - Running setup.py install for psutil 09:36:47 INFO - building 'psutil._psutil_linux' extension 09:36:47 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 09:36:47 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 09:36:47 INFO - building 'psutil._psutil_posix' extension 09:36:47 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 09:36:47 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 09:36:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:47 INFO - Successfully installed psutil 09:36:47 INFO - Cleaning up... 09:36:48 INFO - Return code: 0 09:36:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fac99b91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe393d0>, '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 0xda4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda5360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', '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 09:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 09:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 09:36:48 INFO - Using env: {'DISPLAY': ':0', 09:36:48 INFO - 'HOME': '/home/cltbld', 09:36:48 INFO - 'LANG': 'en_US.UTF-8', 09:36:48 INFO - 'LANGUAGE': 'en_US:en', 09:36:48 INFO - 'LOGNAME': 'cltbld', 09:36:48 INFO - 'MAIL': '/var/mail/cltbld', 09:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:48 INFO - 'MOZ_NO_REMOTE': '1', 09:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:48 INFO - 'NO_EM_RESTART': '1', 09:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:48 INFO - 'PWD': '/builds/slave/test', 09:36:48 INFO - 'SHELL': '/bin/bash', 09:36:48 INFO - 'SHLVL': '1', 09:36:48 INFO - 'TERM': 'linux', 09:36:48 INFO - 'TMOUT': '86400', 09:36:48 INFO - 'USER': 'cltbld', 09:36:48 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', 09:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:48 INFO - '_': '/tools/buildbot/bin/python'} 09:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:36:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:36:49 INFO - Installing collected packages: mozsystemmonitor 09:36:49 INFO - Running setup.py install for mozsystemmonitor 09:36:50 INFO - Successfully installed mozsystemmonitor 09:36:50 INFO - Cleaning up... 09:36:50 INFO - Return code: 0 09:36:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:36:50 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')]} 09:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:50 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')]} 09:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fac99b91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe393d0>, '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 0xda4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda5360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', '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 09:36:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 09:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 09:36:50 INFO - Using env: {'DISPLAY': ':0', 09:36:50 INFO - 'HOME': '/home/cltbld', 09:36:50 INFO - 'LANG': 'en_US.UTF-8', 09:36:50 INFO - 'LANGUAGE': 'en_US:en', 09:36:50 INFO - 'LOGNAME': 'cltbld', 09:36:50 INFO - 'MAIL': '/var/mail/cltbld', 09:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:50 INFO - 'MOZ_NO_REMOTE': '1', 09:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:50 INFO - 'NO_EM_RESTART': '1', 09:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:50 INFO - 'PWD': '/builds/slave/test', 09:36:50 INFO - 'SHELL': '/bin/bash', 09:36:50 INFO - 'SHLVL': '1', 09:36:50 INFO - 'TERM': 'linux', 09:36:50 INFO - 'TMOUT': '86400', 09:36:50 INFO - 'USER': 'cltbld', 09:36:50 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', 09:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:50 INFO - '_': '/tools/buildbot/bin/python'} 09:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:50 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:52 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:36:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:52 INFO - Downloading docopt-0.6.1.tar.gz 09:36:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:52 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:52 INFO - Running setup.py install for blobuploader 09:36:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:36:52 INFO - Running setup.py install for requests 09:36:53 INFO - Running setup.py install for docopt 09:36:53 INFO - Successfully installed blobuploader requests docopt 09:36:53 INFO - Cleaning up... 09:36:53 INFO - Return code: 0 09:36:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fac99b91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe393d0>, '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 0xda4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda5360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', '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 09:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 09:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 09:36:53 INFO - Using env: {'DISPLAY': ':0', 09:36:53 INFO - 'HOME': '/home/cltbld', 09:36:53 INFO - 'LANG': 'en_US.UTF-8', 09:36:53 INFO - 'LANGUAGE': 'en_US:en', 09:36:53 INFO - 'LOGNAME': 'cltbld', 09:36:53 INFO - 'MAIL': '/var/mail/cltbld', 09:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:53 INFO - 'MOZ_NO_REMOTE': '1', 09:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:53 INFO - 'NO_EM_RESTART': '1', 09:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:53 INFO - 'PWD': '/builds/slave/test', 09:36:53 INFO - 'SHELL': '/bin/bash', 09:36:53 INFO - 'SHLVL': '1', 09:36:53 INFO - 'TERM': 'linux', 09:36:53 INFO - 'TMOUT': '86400', 09:36:53 INFO - 'USER': 'cltbld', 09:36:53 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', 09:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:53 INFO - '_': '/tools/buildbot/bin/python'} 09:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:53 INFO - Running setup.py (path:/tmp/pip-rJbqrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:53 INFO - Running setup.py (path:/tmp/pip-H12dH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:53 INFO - Running setup.py (path:/tmp/pip-YDg3Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:53 INFO - Running setup.py (path:/tmp/pip-nURLvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:53 INFO - Running setup.py (path:/tmp/pip-OrFP3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:53 INFO - Running setup.py (path:/tmp/pip-GUKQ4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:53 INFO - Running setup.py (path:/tmp/pip-pyrT3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:54 INFO - Running setup.py (path:/tmp/pip-4dm7H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:54 INFO - Running setup.py (path:/tmp/pip-EughL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:54 INFO - Running setup.py (path:/tmp/pip-9mUNtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:54 INFO - Running setup.py (path:/tmp/pip-UMBznO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:54 INFO - Running setup.py (path:/tmp/pip-E5KVF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:54 INFO - Running setup.py (path:/tmp/pip-2Xa1YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:54 INFO - Running setup.py (path:/tmp/pip-m6KZbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:54 INFO - Running setup.py (path:/tmp/pip-UwPET9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:54 INFO - Running setup.py (path:/tmp/pip-SajmEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:54 INFO - Running setup.py (path:/tmp/pip-gQW3n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:54 INFO - Running setup.py install for manifestparser 09:36:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:36:54 INFO - Running setup.py install for mozcrash 09:36:54 INFO - Running setup.py install for mozdebug 09:36:55 INFO - Running setup.py install for mozdevice 09:36:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:36:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:36:55 INFO - Running setup.py install for mozfile 09:36:55 INFO - Running setup.py install for mozhttpd 09:36:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:36:55 INFO - Running setup.py install for mozinfo 09:36:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:36:55 INFO - Running setup.py install for mozInstall 09:36:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:36:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:36:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:36:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:36:55 INFO - Running setup.py install for mozleak 09:36:55 INFO - Running setup.py install for mozlog 09:36:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:36:55 INFO - Running setup.py install for moznetwork 09:36:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:36:55 INFO - Running setup.py install for mozprocess 09:36:55 INFO - Running setup.py install for mozprofile 09:36:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:36:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:36:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:36:56 INFO - Running setup.py install for mozrunner 09:36:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:36:56 INFO - Running setup.py install for mozscreenshot 09:36:56 INFO - Running setup.py install for moztest 09:36:56 INFO - Running setup.py install for mozversion 09:36:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:36:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:56 INFO - Cleaning up... 09:36:56 INFO - Return code: 0 09:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:56 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')]} 09:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:56 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')]} 09:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fac99b91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe393d0>, '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 0xda4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda5360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', '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 09:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 09:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 09:36:56 INFO - Using env: {'DISPLAY': ':0', 09:36:56 INFO - 'HOME': '/home/cltbld', 09:36:56 INFO - 'LANG': 'en_US.UTF-8', 09:36:56 INFO - 'LANGUAGE': 'en_US:en', 09:36:56 INFO - 'LOGNAME': 'cltbld', 09:36:56 INFO - 'MAIL': '/var/mail/cltbld', 09:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:56 INFO - 'MOZ_NO_REMOTE': '1', 09:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:56 INFO - 'NO_EM_RESTART': '1', 09:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:56 INFO - 'PWD': '/builds/slave/test', 09:36:56 INFO - 'SHELL': '/bin/bash', 09:36:56 INFO - 'SHLVL': '1', 09:36:56 INFO - 'TERM': 'linux', 09:36:56 INFO - 'TMOUT': '86400', 09:36:56 INFO - 'USER': 'cltbld', 09:36:56 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', 09:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:56 INFO - '_': '/tools/buildbot/bin/python'} 09:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:56 INFO - Running setup.py (path:/tmp/pip-EYPN1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:56 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)) 09:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:56 INFO - Running setup.py (path:/tmp/pip-6GDVYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 09:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:56 INFO - Running setup.py (path:/tmp/pip-nDTZgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:56 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)) 09:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:56 INFO - Running setup.py (path:/tmp/pip-dOFmDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:57 INFO - Running setup.py (path:/tmp/pip-q3broW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:57 INFO - Running setup.py (path:/tmp/pip-D3Ovki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:57 INFO - Running setup.py (path:/tmp/pip-orUPCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:57 INFO - Running setup.py (path:/tmp/pip-U2KLYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:57 INFO - Running setup.py (path:/tmp/pip-Dc710a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:57 INFO - Running setup.py (path:/tmp/pip-NdDQuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:57 INFO - Running setup.py (path:/tmp/pip-Ws8TU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:57 INFO - Running setup.py (path:/tmp/pip-hNw4Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:57 INFO - Running setup.py (path:/tmp/pip-eQlrJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:57 INFO - Running setup.py (path:/tmp/pip-sWmkCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:57 INFO - Running setup.py (path:/tmp/pip-XkE0g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:57 INFO - Running setup.py (path:/tmp/pip-kSExZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:57 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)) 09:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:57 INFO - Running setup.py (path:/tmp/pip-1fllFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:57 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)) 09:36:57 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:36:57 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:36:57 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)) 09:36:57 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:36:57 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:36:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:59 INFO - Downloading blessings-1.5.1.tar.gz 09:36:59 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:59 INFO - Installing collected packages: blessings 09:36:59 INFO - Running setup.py install for blessings 09:36:59 INFO - Successfully installed blessings 09:36:59 INFO - Cleaning up... 09:36:59 INFO - Return code: 0 09:36:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:00 INFO - Reading from file tmpfile_stdout 09:37:00 INFO - Current package versions: 09:37:00 INFO - argparse == 1.2.1 09:37:00 INFO - blessings == 1.5.1 09:37:00 INFO - blobuploader == 1.2.4 09:37:00 INFO - docopt == 0.6.1 09:37:00 INFO - manifestparser == 1.1 09:37:00 INFO - mozInstall == 1.12 09:37:00 INFO - mozcrash == 0.16 09:37:00 INFO - mozdebug == 0.1 09:37:00 INFO - mozdevice == 0.47 09:37:00 INFO - mozfile == 1.2 09:37:00 INFO - mozhttpd == 0.7 09:37:00 INFO - mozinfo == 0.9 09:37:00 INFO - mozleak == 0.1 09:37:00 INFO - mozlog == 3.1 09:37:00 INFO - moznetwork == 0.27 09:37:00 INFO - mozprocess == 0.22 09:37:00 INFO - mozprofile == 0.28 09:37:00 INFO - mozrunner == 6.11 09:37:00 INFO - mozscreenshot == 0.1 09:37:00 INFO - mozsystemmonitor == 0.0 09:37:00 INFO - moztest == 0.7 09:37:00 INFO - mozversion == 1.4 09:37:00 INFO - psutil == 3.1.1 09:37:00 INFO - requests == 1.2.3 09:37:00 INFO - wsgiref == 0.1.2 09:37:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fac99b91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe393d0>, '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 0xda4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda5360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', '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 09:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 09:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 09:37:00 INFO - Using env: {'DISPLAY': ':0', 09:37:00 INFO - 'HOME': '/home/cltbld', 09:37:00 INFO - 'LANG': 'en_US.UTF-8', 09:37:00 INFO - 'LANGUAGE': 'en_US:en', 09:37:00 INFO - 'LOGNAME': 'cltbld', 09:37:00 INFO - 'MAIL': '/var/mail/cltbld', 09:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:00 INFO - 'MOZ_NO_REMOTE': '1', 09:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:00 INFO - 'NO_EM_RESTART': '1', 09:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:00 INFO - 'PWD': '/builds/slave/test', 09:37:00 INFO - 'SHELL': '/bin/bash', 09:37:00 INFO - 'SHLVL': '1', 09:37:00 INFO - 'TERM': 'linux', 09:37:00 INFO - 'TMOUT': '86400', 09:37:00 INFO - 'USER': 'cltbld', 09:37:00 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', 09:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:00 INFO - '_': '/tools/buildbot/bin/python'} 09:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:00 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)) 09:37:00 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)) 09:37:00 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)) 09:37:00 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)) 09:37:00 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)) 09:37:00 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)) 09:37:00 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)) 09:37:00 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)) 09:37:00 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)) 09:37:00 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)) 09:37:00 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)) 09:37:00 INFO - Cleaning up... 09:37:00 INFO - Return code: 0 09:37:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fac99b91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe393d0>, '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 0xda4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda5360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', '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 09:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 09:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 09:37:00 INFO - Using env: {'DISPLAY': ':0', 09:37:00 INFO - 'HOME': '/home/cltbld', 09:37:00 INFO - 'LANG': 'en_US.UTF-8', 09:37:00 INFO - 'LANGUAGE': 'en_US:en', 09:37:00 INFO - 'LOGNAME': 'cltbld', 09:37:00 INFO - 'MAIL': '/var/mail/cltbld', 09:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:00 INFO - 'MOZ_NO_REMOTE': '1', 09:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:00 INFO - 'NO_EM_RESTART': '1', 09:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:00 INFO - 'PWD': '/builds/slave/test', 09:37:00 INFO - 'SHELL': '/bin/bash', 09:37:00 INFO - 'SHLVL': '1', 09:37:00 INFO - 'TERM': 'linux', 09:37:00 INFO - 'TMOUT': '86400', 09:37:00 INFO - 'USER': 'cltbld', 09:37:00 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', 09:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:00 INFO - '_': '/tools/buildbot/bin/python'} 09:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:00 INFO - Downloading/unpacking jsonschema 09:37:00 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 09:37:00 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 09:37:00 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 09:37:00 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 09:37:00 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 09:37:00 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 09:37:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:37:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 09:37:02 INFO - Downloading/unpacking functools32 (from jsonschema) 09:37:02 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 09:37:02 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 09:37:02 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 09:37:02 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 09:37:02 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 09:37:02 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 09:37:02 INFO - Downloading functools32-3.2.3-2.tar.gz 09:37:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:37:02 INFO - warning: no files found matching '*.txt' 09:37:02 INFO - no previously-included directories found matching 'build' 09:37:02 INFO - no previously-included directories found matching 'dist' 09:37:02 INFO - no previously-included directories found matching '.git*' 09:37:02 INFO - Installing collected packages: jsonschema, functools32 09:37:02 INFO - Running setup.py install for functools32 09:37:02 INFO - warning: no files found matching '*.txt' 09:37:02 INFO - no previously-included directories found matching 'build' 09:37:02 INFO - no previously-included directories found matching 'dist' 09:37:02 INFO - no previously-included directories found matching '.git*' 09:37:02 INFO - Successfully installed jsonschema functools32 09:37:02 INFO - Cleaning up... 09:37:02 INFO - Return code: 0 09:37:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:37:02 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')]} 09:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:02 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')]} 09:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fac99b91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe393d0>, '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 0xda4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda5360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', '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 09:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 09:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 09:37:02 INFO - Using env: {'DISPLAY': ':0', 09:37:02 INFO - 'HOME': '/home/cltbld', 09:37:02 INFO - 'LANG': 'en_US.UTF-8', 09:37:02 INFO - 'LANGUAGE': 'en_US:en', 09:37:02 INFO - 'LOGNAME': 'cltbld', 09:37:02 INFO - 'MAIL': '/var/mail/cltbld', 09:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:02 INFO - 'MOZ_NO_REMOTE': '1', 09:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:02 INFO - 'NO_EM_RESTART': '1', 09:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:02 INFO - 'PWD': '/builds/slave/test', 09:37:02 INFO - 'SHELL': '/bin/bash', 09:37:02 INFO - 'SHLVL': '1', 09:37:02 INFO - 'TERM': 'linux', 09:37:02 INFO - 'TMOUT': '86400', 09:37:02 INFO - 'USER': 'cltbld', 09:37:02 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', 09:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:02 INFO - '_': '/tools/buildbot/bin/python'} 09:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:02 INFO - Downloading/unpacking flake8 09:37:02 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 09:37:02 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 09:37:02 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 09:37:02 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 09:37:02 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 09:37:02 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 09:37:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:37:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 09:37:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:37:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 09:37:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 09:37:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:37:05 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 09:37:05 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 09:37:05 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 09:37:05 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 09:37:05 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 09:37:05 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 09:37:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:37:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:37:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:37:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:37:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:37:05 INFO - no previously-included directories found matching 'docs/_build' 09:37:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:37:05 INFO - Running setup.py install for pep8 09:37:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:37:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:37:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:37:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:37:05 INFO - no previously-included directories found matching 'docs/_build' 09:37:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:37:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:37:05 INFO - Cleaning up... 09:37:05 INFO - Return code: 0 09:37:05 INFO - Running post-action listener: _resource_record_post_action 09:37:05 INFO - Running post-action listener: _start_resource_monitoring 09:37:05 INFO - Starting resource monitoring. 09:37:05 INFO - ##### 09:37:05 INFO - ##### Running install step. 09:37:05 INFO - ##### 09:37:05 INFO - Running pre-action listener: _resource_record_pre_action 09:37:05 INFO - Running main action method: install 09:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:05 INFO - Reading from file tmpfile_stdout 09:37:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:37:05 INFO - Reading from file tmpfile_stdout 09:37:05 INFO - Output received: 09:37:05 INFO - Usage: mozinstall [options] installer 09:37:05 INFO - Options: 09:37:05 INFO - -h, --help show this help message and exit 09:37:05 INFO - -d DEST, --destination=DEST 09:37:05 INFO - Directory to install application into. [default: 09:37:05 INFO - "/builds/slave/test"] 09:37:05 INFO - --app=APP Application being installed. [default: firefox] 09:37:05 INFO - mkdir: /builds/slave/test/build/application 09:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:37:21 INFO - Reading from file tmpfile_stdout 09:37:21 INFO - Output received: 09:37:21 INFO - /builds/slave/test/build/application/firefox/firefox 09:37:21 INFO - Running post-action listener: _resource_record_post_action 09:37:21 INFO - ##### 09:37:21 INFO - ##### Running run-tests step. 09:37:21 INFO - ##### 09:37:21 INFO - Running pre-action listener: _resource_record_pre_action 09:37:21 INFO - Running main action method: run_tests 09:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:37:21 INFO - Python 2.7.3 09:37:21 INFO - Return code: 0 09:37:21 INFO - grabbing minidump binary from tooltool 09:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe393d0>, '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 0xda4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda5360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:37:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:37:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:37:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:37:21 INFO - Return code: 0 09:37:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:37:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:37:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:37:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:37:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:37:22 INFO - Return code: 0 09:37:22 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/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 09:37:22 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/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 09:37:22 INFO - Using env: {'DISPLAY': ':0', 09:37:22 INFO - 'HOME': '/home/cltbld', 09:37:22 INFO - 'LANG': 'en_US.UTF-8', 09:37:22 INFO - 'LANGUAGE': 'en_US:en', 09:37:22 INFO - 'LOGNAME': 'cltbld', 09:37:22 INFO - 'MAIL': '/var/mail/cltbld', 09:37:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:37:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:22 INFO - 'MOZ_NO_REMOTE': '1', 09:37:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:22 INFO - 'NO_EM_RESTART': '1', 09:37:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:22 INFO - 'PWD': '/builds/slave/test', 09:37:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:37:22 INFO - 'SHELL': '/bin/bash', 09:37:22 INFO - 'SHLVL': '1', 09:37:22 INFO - 'TERM': 'linux', 09:37:22 INFO - 'TMOUT': '86400', 09:37:22 INFO - 'USER': 'cltbld', 09:37:22 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687', 09:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:22 INFO - '_': '/tools/buildbot/bin/python'} 09:37:22 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/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 09:37:22 INFO - mozversion application_buildid: 20160107090124 09:37:22 INFO - mozversion application_changeset: dfd6b2cbd7406d464cdb006b239222ca594bff8e 09:37:22 INFO - mozversion application_display_name: Nightly 09:37:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:37:22 INFO - mozversion application_name: Firefox 09:37:22 INFO - mozversion application_remotingname: firefox 09:37:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:37:22 INFO - mozversion application_vendor: Mozilla 09:37:22 INFO - mozversion application_version: 46.0a1 09:37:22 INFO - mozversion platform_buildid: 20160107090124 09:37:22 INFO - mozversion platform_changeset: dfd6b2cbd7406d464cdb006b239222ca594bff8e 09:37:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:37:22 INFO - mozversion platform_version: 46.0a1 09:37:22 INFO - using testdate: 1452188242 09:37:22 INFO - actual date: 1452188242 09:37:22 INFO - starting webserver on 'localhost:44208' 09:37:22 INFO - SUITE-START | Running 3 tests 09:37:22 INFO - TEST-START | dromaeo_css 09:37:22 INFO - operating with platform_type : linux_ 09:37:22 INFO - Initialising browser for dromaeo_css test... 09:37:22 INFO - TEST-INFO | started process 19947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRpGE0B/profile http://localhost:44208/getInfo.html) 09:37:26 INFO - PROCESS | 19947 | __metrics Screen width/height:1600/1200 09:37:26 INFO - PROCESS | 19947 | colorDepth:24 09:37:26 INFO - PROCESS | 19947 | Browser inner width/height: 1024/697 09:37:26 INFO - PROCESS | 19947 | __metrics 09:37:27 INFO - PROCESS | 19947 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:37:27 INFO - PROCESS | 19947 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:37:28 INFO - TEST-INFO | 19947: exit 0 09:37:28 INFO - Browser initialized. 09:37:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:37:28 INFO - TEST-INFO | started process 20037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRpGE0B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:40 INFO - PROCESS | 20037 | RSS: Main: 150597632 09:37:40 INFO - PROCESS | 20037 | 09:38:31 INFO - PROCESS | 20037 | 1452188311067 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] 09:40:42 INFO - PROCESS | 20037 | Cycle 1(1): loaded http://localhost:44208/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44208/tests/dromaeo/cssquery-ext.html) 09:40:44 INFO - PROCESS | 20037 | RSS: Main: 240140288 09:40:44 INFO - PROCESS | 20037 | 09:43:46 INFO - PROCESS | 20037 | Cycle 1(1): loaded http://localhost:44208/tests/dromaeo/cssquery-ext.html (next: http://localhost:44208/tests/dromaeo/cssquery-jquery.html) 09:43:47 INFO - PROCESS | 20037 | RSS: Main: 228257792 09:43:47 INFO - PROCESS | 20037 | 09:46:49 INFO - PROCESS | 20037 | Cycle 1(1): loaded http://localhost:44208/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44208/tests/dromaeo/cssquery-mootools.html) 09:46:49 INFO - PROCESS | 20037 | RSS: Main: 221888512 09:46:49 INFO - PROCESS | 20037 | 09:49:51 INFO - PROCESS | 20037 | Cycle 1(1): loaded http://localhost:44208/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44208/tests/dromaeo/cssquery-prototype.html) 09:49:52 INFO - PROCESS | 20037 | RSS: Main: 208941056 09:49:52 INFO - PROCESS | 20037 | 09:52:55 INFO - PROCESS | 20037 | Cycle 1(1): loaded http://localhost:44208/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44208/tests/dromaeo/cssquery-yui.html) 09:52:55 INFO - PROCESS | 20037 | RSS: Main: 211685376 09:52:55 INFO - PROCESS | 20037 | 09:55:58 INFO - PROCESS | 20037 | Cycle 1(1): loaded http://localhost:44208/tests/dromaeo/cssquery-yui.html (next: http://localhost:44208/tests/dromaeo/cssquery-dojo.html) 09:55:58 INFO - PROCESS | 20037 | RSS: Main: 289312768 09:55:58 INFO - PROCESS | 20037 | 09:55:58 INFO - PROCESS | 20037 | __start_tp_report 09:55:58 INFO - PROCESS | 20037 | _x_x_mozilla_page_load 09:55:58 INFO - PROCESS | 20037 | _x_x_mozilla_page_load_details 09:55:58 INFO - PROCESS | 20037 | |i|pagename|runs| 09:55:58 INFO - PROCESS | 20037 | |0;dojo.html;2571.1515199984;2645.1535508637244;2657.89368425263;2669.5461771498844;2678.665166854143;4317.158154159933;4463.2412489876715;4547.386102876111;4547.408836851208;4548.977255113724;4445;4471.664625153118;4560.33875088112;4572.5884670379655;4582.679212455129;3800.277947190025;4030.5969403059753;4182.498100227962;4188.685848561355;4235.470566179228;4134.152498737752;4168.874933751978;4207.368894665794;4207.72649777765;4256.553061928499;4029.2747305485;4095.877123686294;4118.299889018874;4141.068259641556;4207.684423668237;4151.335786274181;4173.227952828706;4187.371894215892;4187.434696315989;4212.283911735012;4121.423000779893;4133.1940271647045;4133.607307305801;4134.565870583606;4185.121124563845;4317.611414972667;4442.955570444286;4457.487388950248;4469.3296005599095;4476.261416866213;4790.496997815214;4883.145449546315;4887.3402090717655;4916.385451818523;4941.160002799533;4814.109389762905;4827.951720482785;4831.106245344622;4836.322914791932;4866.489018653061;4377.693561450668;4482.991326951443;4483.417155769762;4485.842995495207;4525.728456292633;4787.281907713871;4902.632302577321;4980.601551875841;5020.723860187652;5029.723365214948;4731;4732.881677958009;4735.981763920774;4768.046390721869;4771.498992605726;4719.646026547954;4809.687370320918;4825.276208568673;4837.637177211724;4860.1251774680895;4700.318453824177;4700.952990470051;4755.857324280277;4843;4883.291922671264;4767.642426818003;4768.237082066853;4773.618110551148;4803.471618122004;4816.8073277069225;4004.59954004603;4010.6590939769862;4012.8595499157973;4014.2573623879675;4042.717009809285;3477.791332520006;3526.453399723047;3545.166885781839;3582.4447210681865;3597.8560857565403;4169.56219596944;4170.311898536707;4179.770112643773;4215.241256573785;4215.241256573785;4818.469968303484;4819.228923372244;4820.132376172322;4826.420829500412;4855.6115510759055;4070;4156.875293741193;4172.061286210578;4173.040200753843;4176.519700234512;4303.354496825501;4330.935035974463;4331.523532411432;4350.695451318441;4368.060866913565;4651.209294419957;4672.345871577982;4674.392328997209;4681.414823147106;4717.080169367009;4637.420322459692;4769.57073863354;4776.9761151194025;4780.282957556395;4877.512248775094;4606.930896036629;4670.486246512813;4671.089137618132;4678.69588476748;4694.014257006067;4802.399700037496;4808.0383923214795;4812.542808433193;4816.927746083882;4857.344258525054;4683.1336202802595;4741.051789642154;4776.498467660846;4784.234522476387;4877.9024419512125;4655.23188673865;4666.859994200044;4670.1827180244;4709.152352576569;4714.198586240279;4661.0444858803185;4664.836730714409;4670.276107203389;4676.438827340741;4701.459332176843;4411.669124815588;4516.548345165457;4520.886977825449;4544.954550454586;4548.658850586286;4727.125481785881;4733;4749.430068391815;4765.046990601824;4785.473597904297;4591.724496530219;4598.21830288845;4602.1946159421295;4602.493725690105;4650.069986002881 09:55:58 INFO - PROCESS | 20037 | |1;ext.html;481.44393225824183;513.3429210610418;515.5360175841744;522.399240872996;527.868032991752;24437.266881993546;25109.121180758677;25125.246242612706;25160.748392516114;32685.182870428252;36001.63998360016;36501;36506.634933650654;36574.634253657525;36659;7535.095788505387;7676.5394076355315;7684.846303073935;7687.8078048048965;7709.6916123354995;6882;7044.68298926547;7045.929540704578;7047.0838790957105;7498.2126876677985;6834.726610935557;6902.965485172592;9384.483853388061;9581.760455988586;9599.95200023999;9480.288978326618;9493;9520.523973801352;9532.380395274286;9628.566714497829;6812.114425124702;9225.907740922572;9362.110599493106;9364.297677674134;9368.484733339663;24869.378265543324;35284.64715352839;35969.64030359715;35986.460203096976;36002.63997360019;2751.5872619107295;2802.4395120975887;2852.671942726592;3300.933981320384;3330.900072997814;22709.545809083727;23961.520769584684;23980.760192398026;24558.386040348956;25040.624390634155;3149.1497295730023;3149.3386388858366;3173.841307934594;3216.6783321667644;3217.3404452087266;211759;213982;214098;214283;214446;54112.45887541074;54193.45806541884;54412.455875441534;54519.45480545144;54543.181852272246;57547;57619.71190144023;57718.71140644354;57759.71120144372;57769.37844972392;12016;12398.876011239772;12403.875961240272;12440.377981100908;12442.81335779964;8302.294304984143;8303;8304.543250121302;8309.916900831035;8353.457025293337;18116.547086322946;18416.447506574823;18564.907175464305;18580.907095464438;18642;7344.632768361561;7601.6579253933705;7602.50583712057;7681.423893208032;7682.884756728654;840.9747707568782;841.8610929196614;843.5149788871423;915.9404638698596;1013.3413281367023;27506.587401188997;28859.134225973256;29475.557866632018;30016.699833001392;30933.381332373225;811.3225456743567;853.6938484119307;876.412803421709;932.1098351074708;937.4000639590668;12364.44360003802;12621.747565048647;12713.809292860615;12777.425015874307;12778.297193654438;316588;324434;324637;325033;326330;39072.413913791315;39886.800565996986;44858.32712509315;45289;46022.76988615035;1151.3494875395374;1170.2276497511602;1170.303669316755;1174;1179.9292042477307;22542.887285564124;24706.752932470445;25797.226083217534;25991.700414978797;26311.21066368012;37370.43944340891;37933.81033094817;38064;38114.2377152461;38178.2364352717;251917;253632;254102;254771;254867;27889.16332510028;28520.286992825346;28630.427391451638;28634.85682571657;28651.713482864903;35771;36915;37855;37907.24185516219;38200;31832.734792142728;32476.675233248312;32939.50590741093;33077;33118.834405827816;32639.67360326366;32982.835085824416;33165.50251746178;34730.652693472744;35095;30019.549706754853;30321.393572128876;33866.66133338635;34662.13344666403;34810.47784283187;25987.870060649577;27201;27314.726852732012;27561;27778.027769027987;21364.359069227947;21692;21696.67454988145;21770.455738606663;22457.663135052662 09:55:58 INFO - PROCESS | 20037 | |2;jquery.html;311.1210829406926;320.2106806721431;322.514615503667;325.3184578308443;326.0641957581741;12507.124501284914;12844;14742.926285368572;15122.395104195833;15877;12258.080643951695;12260.264384136957;12436.937815310934;12583.622491325252;14835.55493335199;4675;4822.156122678535;4968;4975.875603109915;4979.153543897528;3752.9437058444146;3848.2111167210796;5596.496315331639;5819.7963071292515;5896.23348964634;5680.886382272352;5702.258706368167;5728.398518155596;5732.312122545301;5735.340435849868;5543.695096769676;5693.686847223401;5694.430556944293;5704.286964129484;5719.113537401709;4976.328195693607;4992.226204938241;5000.274960130797;5012.072766538202;5035.219540971156;17438.389656361967;19049.14278857441;19140.712889306673;19766.90116549408;19803.207871685114;1874.9718754218698;1900.2683966672791;1910.7133929910485;1933.7776155742129;1957.872738272022;12494.937525312405;12705.936470317682;12826.230426174367;12846.293453860035;13045.34773261333;1779.7686300780945;1819.8362147406665;1833.14758637233;1894.5168981909662;1913.2633935934625;48710.75644621754;49671;50869.49130508685;53753.46246537524;55851;8580;8812.250958668585;8900.332475064397;8904.065073167225;9033.593488293043;11170.497327620276;11194.496247668874;11210.439478026066;11214.215004949576;11230.831537526943;6232.501399887998;6283.842903927439;6316.652584107826;6356.046593011085;6371.426571608577;5906.350301466921;5913.083472061838;6157.415045570664;6165.815025549241;6192.195014648067;3788.886333410002;3823.4456003879836;3840.462335273064;3846.1538461538416;3852.6339997700175;1525.9313330900136;1558.290977605187;1560.6020464781634;1581.9683606327808;1613.8305477924885;854.7179430787825;855.3456605696647;917.898521773874;918.136951265808;967.7532229281488;15020.17389043613;15681;15744.685106298039;16136.919315403347;16170.434034808724;790.1537730337687;796.6932730898645;811.6915572082571;837.3134030095264;839.5592314035181;5645.745941432645;9002.594883230271;9106.908930910738;9161.221296189766;9233.676821311223;437664;440805;441148;459388;472199;50369;61272.387276127556;62953.68523157355;63401.36598634047;66310;954.3176628710505;962.0331566775346;977.8435450328055;978.3836183204678;979.5053497983473;13529;13656.93171534136;13779.450801601735;14054.297285135906;14153.221572813594;28591.85704071466;28774.280642984093;29953;30836.537451938686;31878.362432751677;37540.24919501649;39079.60920390873;40044;40097.198056038134;40518.39222411607;8630.956845215735;8695.217430431292;8807.251383632463;8813.471191728517;8817.250533704708;15186.848131518986;15238.619034523783;15399.384024638888;15695.450659226872;15812.130332831804;13911.373988170759;13952;14135.081219720685;14195.787063193853;14407;11383.886161138282;13841.584752457442;13963.790543141658;14053.648658783612;14074.718505630035;14191.858081419054;14192.716145677236;14485.058471199338;14580.1980891052;14598.051126676732;8272.131426200162;8571.314294856522;8709.953161007285;8723.781905452415;8761.25529330014;9349.766255843659;9471.573779179816;12938.159019663692;13317.134386264861;13696.246706431242 09:55:58 INFO - PROCESS | 20037 | |3;mootools.html;1185.6917201527601;1314.7304802515484;1317.2096741954824;1378.2488543743666;1661.368679901638;5893.882122357556;6768.864622707543;6846.178458584965;6854.246032936386;6859.554128981613;6653.700583473743;6821.897671534918;6827.180738311409;6830.590164590128;6831.897521537168;1962.872413293135;1999.8500112491622;2000.3598848368529;2002.3992802159294;2003.829674477664;1986.0665487220983;2031.5327474680832;2040.1941233212872;2060.9381718548393;2071.968920466194;1968.2914150905663;2022.2113375783383;2051.2512932779578;2054.6198953193634;2056.177528988409;1967.6654968655291;1990.7611086669547;1990.8506861985409;1992.770831354391;1992.8306093981957;2009.3770931011434;2024.98987505063;2031.9187232510683;2033.3696554068138;2033.8779673219506;6894.103766510371;6975.965120174366;6979.616121113337;6979.616121113337;6990.405815505688;3764.642358975893;3815.8473661053804;3830.7701537907537;3835.175437280998;3838.539375274957;2599.5450796110795;2653.6815582130075;2695.9730402696114;2713.4437440324687;2719.3065768228976;877.3902138014083;885.6855816185226;887.4896934262761;920.6777627830206;922.0042354257453;8758.430702004349;8781.209691127766;8783.472991620523;8783.692570759993;8790.912090879137;3620.2397496525496;3628.401313783196;3658.9817050914576;3671.2473942841652;3704.759190652599;7666.310032097138;7677.155512893577;7700.845983080307;7716.035495563055;7725.304722574995;4058.2086493133556;4061.5532291447917;4062.045419326456;4068.3083875741195;4070.1859628074503;3216.967830321667;3296.4725643896863;3609;3715.3498137825773;3724.795136267477;3149.1969547765175;3165.4302225599613;3182.713555779991;3195.2491164576304;3198.6001749781276;1024.3802499487851;1035.3632516002754;1037.5797801890246;1039.9584016639249;1049.506731836036;1127.9210455268217;1129.3901293301526;1135.211028335299;1135.250734515216;1136.9886301137049;6302.432781049728;6579.440747536513;6603.141591593062;6606.240282367493;6614.305497922745;403.1312521516079;411.091487811933;412.577108463821;412.76678676548255;418.55842086598324;4809.5430934061205;4869.780859861315;4871.318015477836;4872.561469467694;4874.610031197496;8013.198680132056;8089.757307280791;8191.098979112293;8266.13205613414;8375.20435558621;8205.79485512867;8239.340852731768;8245;8263.628136733862;8273.46222495536;6425.5502114851515;6493.610383377012;6540.771073012422;6561.2782593914635;6570.441512471493;6233.688315584293;6288.937110629018;6324.715387807468;6326.082718005955;6338.176037115146;7225.421966242583;7366.926330736624;7373.225811289737;7441.218672039358;7443.665035073326;7364.410847132323;7509.399248060251;7510.324070833652;7705.42209334291;7750.7674769756995;5265.868353291198;5355.3305836770405;6022.608530445507;6067.696615169312;6072.605280656743;6416.679166041773;6544.181977252843;6568.638724870178;6569.57297775643;6570.4086632201415;6128.63228206309;6187.504999600112;6206.10011548332;6289;6330.303666596763;6082.5438092142385;6160.507159427146;6224.657643829451;6256.249250090018;6350.618962862059;6329.810105696836;6376.808695739135;6384.521160912857;6384.521160913043;6385.648789316447;5834.912476312944;5889.94110058894;5900.232969713909;5900.940990590039;5908.497777688945;5701.401352858056;5721.628094173865;5784.190213370216;5795.362510123968;5799.797007104731 09:55:58 INFO - PROCESS | 20037 | |4;prototype.html;294.9572312014758;300.69329284130185;305.512707231965;308.9691030896909;309.6903096903097;5273.367195936488;5308.575313974882;5341.866453338664;5343.866403339918;5349.732513374335;5238.52853243208;5280.023195708787;5283;5285.8942821143555;5289.867753306169;3876.3604005339225;4153.8961525961795;4155.189738001091;4159.459270294858;4163.188178305224;3950.545687245975;3955.9011024724323;3957.9010524736823;3964.464797252363;3996.9400458993136;3956.742811717229;3977.2840888640035;4037.656799172074;4043.2924238258333;4051.979740101295;4045.9190816183805;4049.3318602430563;4051.574584668597;4051.756894586334;4058.655014323786;3386.1703882548686;3479.408500554912;3585.354636165489;3591.5690117186105;3611.2416392557593;4980.178270585386;5072.847814565569;5099.133147364957;5106.846794596168;5111.872203194913;4662.463816661059;4671.299305104228;4678.485366609671;4684.859454216379;4685.6485763567525;5545.140503222007;5550.056490396642;5551.833444996616;5561.165825126223;5561.249231353796;3816.484774555427;3884.8834534964;3896.376579747227;3935.2129574085297;3952.1107750756137;5802.21670074543;5803.071508558611;5804.071348584206;5804.535637149018;5805.042168042268;4054.9797251013556;4057.472528571267;4068.2066996935905;4072.3280658690983;4072.450219220367;4118.814653340607;4124.072083781125;4128.896777580524;4131.5248746393945;4131.752094874317;4238.788060596958;4366.934495982563;4681.461631912373;4682.274247491644;4685.929711054337;5233.973830130901;5413.350397952192;5427.810026649048;5438.782448702087;5445.482679145475;1400.719856028778;1422.871941525247;1424.430227908824;1464.3703207620824;1464.934077966494;977.5405559387077;980.2550061952967;980.764616492051;988.3822610868208;994.6817018553993;4814.7833347499445;4832.782524786393;4836.032793441326;4837.830675926326;4841.225403935354;5674.092145256822;5680.971595141998;5686.687232202268;5686.976344257991;5690.573207009408;4806.086843499724;4817.710937343771;4823.975880120577;4825.565699087028;4831;2984.985075074654;3025.3344264261827;3056.144279601715;3069.1713237426216;3078.553609726577;5258.39528454225;5415.296011518478;5466.535344495763;5511.22842802008;5522;5747.626404283708;5929.644221346733;5944.048952167719;5958.851028724316;5965.94175009621;5475.72621368938;5488.56091512678;5496.0931446310915;5497.945020549743;5501.642393244426;5714.8571285716525;5753.884922301614;5758.395368486249;5770.971145144247;5786.971065144648;5445.428230035789;5681.0910254359105;5687.971560142173;5689.971550142222;5693.601447898773;5486.478784515464;5509.173623956439;5512.173174023928;5518.365387980433;5520.806771762969;3972.3048466517666;4005;4013.317735984831;4013.8795836124964;4014.116894283253;5650.830475085754;5800.187973683604;5810.186573879576;5811;5816.098504731774;5583.330000399978;5603.131514615241;5606.215129881738;5608.158776183605;5608.971955140361;5591;5597.608167428404;5599.496045355938;5601.663900166003;5602.719864006702;5422.349318081855;5433.538149257357;5435.809746658848;5479.232907392889;5489.58828087903;5415.1335786274;5613.747381367766;5651.265335506358;5654.547636189177;5660.6037577370835;5455.9454405455435;5484.533814625802;5522.889542209214;5524.171374293888;5528.474794894479 09:55:58 INFO - PROCESS | 20037 | |5;yui.html;648.7859006527844;673.9393454589086;747.3722073458293;772.4476998945753;793.9166387529309;11294.152938529602;11411.885881141186;11444;11453;11454.31274123552;11163.66509004729;11261.774764504706;11267.774644507104;11325.546978120887;11329.830052549218;599.4245524296681;610.1122866229647;766.6358479722115;778.6651739751904;778.7741554949058;775.7440044785208;776.4875182379631;782.2803021220462;782.2998416417303;784;806.8668669669497;814.0882211922625;814.2549567146054;815.0545367373848;815.4251252866744;804.7827086686591;806.3871457692137;807.4428644235459;807.7495976247353;808.6239898447192;602.1990752299431;602.5300265792689;602.7558838670302;602.7860109661095;603.3152372057702;12009.45957431909;12116.878831211663;12144.21062630935;12146.817797733042;12202.816957745641;10577.947110264477;10637.840432393521;11095.72260693481;11181.608643697513;11182.66452006441;8844.248238899701;8958.104189581056;9036.412633178823;9091.545422728837;9138.223251023672;3210.9357812843614;3250.837458127084;3275.0666060172734;3276.770626056177;3282.7537934654997;33548.99999999975;34131.31737365239;37140.81429592835;37928.43107353392;38236.61763382358;9045.864312035324;9139.405938614102;9303.720888373224;9387.249020078378;9664.178544823628;15771.44799931997;15991.920040399957;16014.519564413085;16030.839691603169;16031.759523607156;6266.811995640138;6314.810555683337;6401.583897046677;6471.417572418505;6579.769708060195;3515.4199557073307;3591.120175557005;3595.532580764484;3600.7479476436397;3601.3697602919383;2537.2007817537415;2548.1718441506587;2548.566743653583;2549.2607143928053;2554.514642217973;455.70151550734323;459.49685094821115;462.75011493792977;464.7536805493094;469.63368572513497;424.7557654348762;445.05870084771124;447.7000409725492;450.8151657820278;457.8667797201965;7736.961315193388;7943.4042446815565;7958.880616790752;8031.55826429552;8204.794880127925;472.24440894568414;554.5258803722759;557.7127779193719;594.3848117198766;597.2653636027624;3490.144914495914;3534.9469757953652;3556.253186830743;3639.2721455708966;3665.138692407282;45873.54126458759;45985;46198.07603847904;46427.30359044617;47831;42719.786401067795;42779.57220427818;43054.78472607617;43110;43484.347734784;32762.344753104804;37894.62105378966;41763.79118104451;41939.37090943638;41996.37005444921;7329.377002954809;7549.886751698619;7562.621868906423;7588.62056897164;7667.156612772702;30079.69920300769;30495.390092198475;30768.538471922493;30994.225144371572;31619.525707113953;35258.471122932664;35942.28115437729;37561.81219093996;37989.62010379861;38419.615803842724;9590.280728945218;9612.231021518402;9639.277054220822;9666.661666841626;9696.127348538665;10559.894401056199;10672.946635266773;10696.572137114428;10759.946200268949;10844.45777711127;9703;10103.848442273518;10348;10507.369557826554;11248.88751112511;10318.690439286833;10479.10927571165;10864.130869530261;10958.397288149228;11127.109831213646;10093.394396336244;10282.485875706334;10405.791884162425;10549.736256593647;11037.83443248368;9031.50326732036;9065.41074830134;9072.364934454525;9176.95411522938;9920.503974801375;8203.425760196968;8474.1949514796;8502.604621892966;8539.188777066169;8695.608697608497 09:55:58 INFO - PROCESS | 20037 | __end_tp_report 09:55:58 INFO - PROCESS | 20037 | __start_cc_report 09:55:58 INFO - PROCESS | 20037 | _x_x_mozilla_cycle_collect,1110 09:55:58 INFO - PROCESS | 20037 | __end_cc_report 09:55:58 INFO - PROCESS | 20037 | __startTimestamp1452189358516__endTimestamp 09:55:58 INFO - PROCESS | 20037 | 09:55:58 INFO - PROCESS | 20037 | ------- Summary: start ------- 09:55:58 INFO - PROCESS | 20037 | Number of tests: 6 09:55:58 INFO - PROCESS | 20037 | 09:55:58 INFO - PROCESS | 20037 | [#0] dojo.html Cycles:165 Average:4456.59 Median:4602.19 stddev:456.39 (9.9%) stddev-sans-first:433.16 09:55:58 INFO - PROCESS | 20037 | Values: 2571.2 2645.2 2657.9 2669.5 2678.7 4317.2 4463.2 4547.4 4547.4 4549.0 4445.0 4471.7 4560.3 4572.6 4582.7 3800.3 4030.6 4182.5 4188.7 4235.5 4134.2 4168.9 4207.4 4207.7 4256.6 4029.3 4095.9 4118.3 4141.1 4207.7 4151.3 4173.2 4187.4 4187.4 4212.3 4121.4 4133.2 4133.6 4134.6 4185.1 4317.6 4443.0 4457.5 4469.3 4476.3 4790.5 4883.1 4887.3 4916.4 4941.2 4814.1 4828.0 4831.1 4836.3 4866.5 4377.7 4483.0 4483.4 4485.8 4525.7 4787.3 4902.6 4980.6 5020.7 5029.7 4731.0 4732.9 4736.0 4768.0 4771.5 4719.6 4809.7 4825.3 4837.6 4860.1 4700.3 4701.0 4755.9 4843.0 4883.3 4767.6 4768.2 4773.6 4803.5 4816.8 4004.6 4010.7 4012.9 4014.3 4042.7 3477.8 3526.5 3545.2 3582.4 3597.9 4169.6 4170.3 4179.8 4215.2 4215.2 4818.5 4819.2 4820.1 4826.4 4855.6 4070.0 4156.9 4172.1 4173.0 4176.5 4303.4 4330.9 4331.5 4350.7 4368.1 4651.2 4672.3 4674.4 4681.4 4717.1 4637.4 4769.6 4777.0 4780.3 4877.5 4606.9 4670.5 4671.1 4678.7 4694.0 4802.4 4808.0 4812.5 4816.9 4857.3 4683.1 4741.1 4776.5 4784.2 4877.9 4655.2 4666.9 4670.2 4709.2 4714.2 4661.0 4664.8 4670.3 4676.4 4701.5 4411.7 4516.5 4520.9 4545.0 4548.7 4727.1 4733.0 4749.4 4765.0 4785.5 4591.7 4598.2 4602.2 4602.5 4650.1 09:55:58 INFO - PROCESS | 20037 | 09:55:58 INFO - PROCESS | 20037 | [#1] ext.html Cycles:180 Average:41208.63 Median:18248.20 stddev:70173.03 (384.5%) stddev-sans-first:70303.25 09:55:58 INFO - PROCESS | 20037 | Values: 481.4 513.3 515.5 522.4 527.9 24437.3 25109.1 25125.2 25160.7 32685.2 36001.6 36501.0 36506.6 36574.6 36659.0 7535.1 7676.5 7684.8 7687.8 7709.7 6882.0 7044.7 7045.9 7047.1 7498.2 6834.7 6903.0 9384.5 9581.8 9600.0 9480.3 9493.0 9520.5 9532.4 9628.6 6812.1 9225.9 9362.1 9364.3 9368.5 24869.4 35284.6 35969.6 35986.5 36002.6 2751.6 2802.4 2852.7 3300.9 3330.9 22709.5 23961.5 23980.8 24558.4 25040.6 3149.1 3149.3 3173.8 3216.7 3217.3 211759.0 213982.0 214098.0 214283.0 214446.0 54112.5 54193.5 54412.5 54519.5 54543.2 57547.0 57619.7 57718.7 57759.7 57769.4 12016.0 12398.9 12403.9 12440.4 12442.8 8302.3 8303.0 8304.5 8309.9 8353.5 18116.5 18416.4 18564.9 18580.9 18642.0 7344.6 7601.7 7602.5 7681.4 7682.9 841.0 841.9 843.5 915.9 1013.3 27506.6 28859.1 29475.6 30016.7 30933.4 811.3 853.7 876.4 932.1 937.4 12364.4 12621.7 12713.8 12777.4 12778.3 316588.0 324434.0 324637.0 325033.0 326330.0 39072.4 39886.8 44858.3 45289.0 46022.8 1151.3 1170.2 1170.3 1174.0 1179.9 22542.9 24706.8 25797.2 25991.7 26311.2 37370.4 37933.8 38064.0 38114.2 38178.2 251917.0 253632.0 254102.0 254771.0 254867.0 27889.2 28520.3 28630.4 28634.9 28651.7 35771.0 36915.0 37855.0 37907.2 38200.0 31832.7 32476.7 32939.5 33077.0 33118.8 32639.7 32982.8 33165.5 34730.7 35095.0 30019.5 30321.4 33866.7 34662.1 34810.5 25987.9 27201.0 27314.7 27561.0 27778.0 21364.4 21692.0 21696.7 21770.5 22457.7 09:55:58 INFO - PROCESS | 20037 | 09:55:58 INFO - PROCESS | 20037 | [#2] jquery.html Cycles:180 Average:24630.57 Median:21466.12 stddev:73407.77 (342.0%) stddev-sans-first:73590.99 09:55:58 INFO - PROCESS | 20037 | Values: 311.1 320.2 322.5 325.3 326.1 12507.1 12844.0 14742.9 15122.4 15877.0 12258.1 12260.3 12436.9 12583.6 14835.6 4675.0 4822.2 4968.0 4975.9 4979.2 3752.9 3848.2 5596.5 5819.8 5896.2 5680.9 5702.3 5728.4 5732.3 5735.3 5543.7 5693.7 5694.4 5704.3 5719.1 4976.3 4992.2 5000.3 5012.1 5035.2 17438.4 19049.1 19140.7 19766.9 19803.2 1875.0 1900.3 1910.7 1933.8 1957.9 12494.9 12705.9 12826.2 12846.3 13045.3 1779.8 1819.8 1833.1 1894.5 1913.3 48710.8 49671.0 50869.5 53753.5 55851.0 8580.0 8812.3 8900.3 8904.1 9033.6 11170.5 11194.5 11210.4 11214.2 11230.8 6232.5 6283.8 6316.7 6356.0 6371.4 5906.4 5913.1 6157.4 6165.8 6192.2 3788.9 3823.4 3840.5 3846.2 3852.6 1525.9 1558.3 1560.6 1582.0 1613.8 854.7 855.3 917.9 918.1 967.8 15020.2 15681.0 15744.7 16136.9 16170.4 790.2 796.7 811.7 837.3 839.6 5645.7 9002.6 9106.9 9161.2 9233.7 437664.0 440805.0 441148.0 459388.0 472199.0 50369.0 61272.4 62953.7 63401.4 66310.0 954.3 962.0 977.8 978.4 979.5 13529.0 13656.9 13779.5 14054.3 14153.2 28591.9 28774.3 29953.0 30836.5 31878.4 37540.2 39079.6 40044.0 40097.2 40518.4 8631.0 8695.2 8807.3 8813.5 8817.3 15186.8 15238.6 15399.4 15695.5 15812.1 13911.4 13952.0 14135.1 14195.8 14407.0 11383.9 13841.6 13963.8 14053.6 14074.7 14191.9 14192.7 14485.1 14580.2 14598.1 8272.1 8571.3 8710.0 8723.8 8761.3 9349.8 9471.6 12938.2 13317.1 13696.2 09:55:58 INFO - PROCESS | 20037 | 09:55:58 INFO - PROCESS | 20037 | [#3] mootools.html Cycles:180 Average:4751.58 Median:5900.59 stddev:2474.83 (41.9%) stddev-sans-first:2467.26 09:55:58 INFO - PROCESS | 20037 | Values: 1185.7 1314.7 1317.2 1378.2 1661.4 5893.9 6768.9 6846.2 6854.2 6859.6 6653.7 6821.9 6827.2 6830.6 6831.9 1962.9 1999.9 2000.4 2002.4 2003.8 1986.1 2031.5 2040.2 2060.9 2072.0 1968.3 2022.2 2051.3 2054.6 2056.2 1967.7 1990.8 1990.9 1992.8 1992.8 2009.4 2025.0 2031.9 2033.4 2033.9 6894.1 6976.0 6979.6 6979.6 6990.4 3764.6 3815.8 3830.8 3835.2 3838.5 2599.5 2653.7 2696.0 2713.4 2719.3 877.4 885.7 887.5 920.7 922.0 8758.4 8781.2 8783.5 8783.7 8790.9 3620.2 3628.4 3659.0 3671.2 3704.8 7666.3 7677.2 7700.8 7716.0 7725.3 4058.2 4061.6 4062.0 4068.3 4070.2 3217.0 3296.5 3609.0 3715.3 3724.8 3149.2 3165.4 3182.7 3195.2 3198.6 1024.4 1035.4 1037.6 1040.0 1049.5 1127.9 1129.4 1135.2 1135.3 1137.0 6302.4 6579.4 6603.1 6606.2 6614.3 403.1 411.1 412.6 412.8 418.6 4809.5 4869.8 4871.3 4872.6 4874.6 8013.2 8089.8 8191.1 8266.1 8375.2 8205.8 8239.3 8245.0 8263.6 8273.5 6425.6 6493.6 6540.8 6561.3 6570.4 6233.7 6288.9 6324.7 6326.1 6338.2 7225.4 7366.9 7373.2 7441.2 7443.7 7364.4 7509.4 7510.3 7705.4 7750.8 5265.9 5355.3 6022.6 6067.7 6072.6 6416.7 6544.2 6568.6 6569.6 6570.4 6128.6 6187.5 6206.1 6289.0 6330.3 6082.5 6160.5 6224.7 6256.2 6350.6 6329.8 6376.8 6384.5 6384.5 6385.6 5834.9 5889.9 5900.2 5900.9 5908.5 5701.4 5721.6 5784.2 5795.4 5799.8 09:55:58 INFO - PROCESS | 20037 | 09:55:58 INFO - PROCESS | 20037 | [#4] prototype.html Cycles:180 Average:4604.55 Median:5284.45 stddev:1355.10 (25.6%) stddev-sans-first:1319.73 09:55:58 INFO - PROCESS | 20037 | Values: 295.0 300.7 305.5 309.0 309.7 5273.4 5308.6 5341.9 5343.9 5349.7 5238.5 5280.0 5283.0 5285.9 5289.9 3876.4 4153.9 4155.2 4159.5 4163.2 3950.5 3955.9 3957.9 3964.5 3996.9 3956.7 3977.3 4037.7 4043.3 4052.0 4045.9 4049.3 4051.6 4051.8 4058.7 3386.2 3479.4 3585.4 3591.6 3611.2 4980.2 5072.8 5099.1 5106.8 5111.9 4662.5 4671.3 4678.5 4684.9 4685.6 5545.1 5550.1 5551.8 5561.2 5561.2 3816.5 3884.9 3896.4 3935.2 3952.1 5802.2 5803.1 5804.1 5804.5 5805.0 4055.0 4057.5 4068.2 4072.3 4072.5 4118.8 4124.1 4128.9 4131.5 4131.8 4238.8 4366.9 4681.5 4682.3 4685.9 5234.0 5413.4 5427.8 5438.8 5445.5 1400.7 1422.9 1424.4 1464.4 1464.9 977.5 980.3 980.8 988.4 994.7 4814.8 4832.8 4836.0 4837.8 4841.2 5674.1 5681.0 5686.7 5687.0 5690.6 4806.1 4817.7 4824.0 4825.6 4831.0 2985.0 3025.3 3056.1 3069.2 3078.6 5258.4 5415.3 5466.5 5511.2 5522.0 5747.6 5929.6 5944.0 5958.9 5965.9 5475.7 5488.6 5496.1 5497.9 5501.6 5714.9 5753.9 5758.4 5771.0 5787.0 5445.4 5681.1 5688.0 5690.0 5693.6 5486.5 5509.2 5512.2 5518.4 5520.8 3972.3 4005.0 4013.3 4013.9 4014.1 5650.8 5800.2 5810.2 5811.0 5816.1 5583.3 5603.1 5606.2 5608.2 5609.0 5591.0 5597.6 5599.5 5601.7 5602.7 5422.3 5433.5 5435.8 5479.2 5489.6 5415.1 5613.7 5651.3 5654.5 5660.6 5455.9 5484.5 5522.9 5524.2 5528.5 09:55:58 INFO - PROCESS | 20037 | 09:55:58 INFO - PROCESS | 20037 | [#5] yui.html Cycles:180 Average:11758.14 Median:446.38 stddev:13030.39 (2919.1%) stddev-sans-first:13040.23 09:55:58 INFO - PROCESS | 20037 | Values: 648.8 673.9 747.4 772.4 793.9 11294.2 11411.9 11444.0 11453.0 11454.3 11163.7 11261.8 11267.8 11325.5 11329.8 599.4 610.1 766.6 778.7 778.8 775.7 776.5 782.3 782.3 784.0 806.9 814.1 814.3 815.1 815.4 804.8 806.4 807.4 807.7 808.6 602.2 602.5 602.8 602.8 603.3 12009.5 12116.9 12144.2 12146.8 12202.8 10577.9 10637.8 11095.7 11181.6 11182.7 8844.2 8958.1 9036.4 9091.5 9138.2 3210.9 3250.8 3275.1 3276.8 3282.8 33549.0 34131.3 37140.8 37928.4 38236.6 9045.9 9139.4 9303.7 9387.2 9664.2 15771.4 15991.9 16014.5 16030.8 16031.8 6266.8 6314.8 6401.6 6471.4 6579.8 3515.4 3591.1 3595.5 3600.7 3601.4 2537.2 2548.2 2548.6 2549.3 2554.5 455.7 459.5 462.8 464.8 469.6 424.8 445.1 447.7 450.8 457.9 7737.0 7943.4 7958.9 8031.6 8204.8 472.2 554.5 557.7 594.4 597.3 3490.1 3534.9 3556.3 3639.3 3665.1 45873.5 45985.0 46198.1 46427.3 47831.0 42719.8 42779.6 43054.8 43110.0 43484.3 32762.3 37894.6 41763.8 41939.4 41996.4 7329.4 7549.9 7562.6 7588.6 7667.2 30079.7 30495.4 30768.5 30994.2 31619.5 35258.5 35942.3 37561.8 37989.6 38419.6 9590.3 9612.2 9639.3 9666.7 9696.1 10559.9 10672.9 10696.6 10759.9 10844.5 9703.0 10103.8 10348.0 10507.4 11248.9 10318.7 10479.1 10864.1 10958.4 11127.1 10093.4 10282.5 10405.8 10549.7 11037.8 9031.5 9065.4 9072.4 9177.0 9920.5 8203.4 8474.2 8502.6 8539.2 8695.6 09:55:58 INFO - PROCESS | 20037 | -------- Summary: end -------- 09:55:58 INFO - PROCESS | 20037 | 09:55:59 INFO - TEST-INFO | 20037: exit 0 09:55:59 INFO - TEST-OK | dromaeo_css | took 1116421ms 09:55:59 INFO - TEST-START | kraken 09:55:59 INFO - operating with platform_type : linux_ 09:55:59 INFO - Initialising browser for kraken test... 09:55:59 INFO - TEST-INFO | started process 20232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpne_jqn/profile http://localhost:44208/getInfo.html) 09:56:03 INFO - PROCESS | 20232 | __metrics Screen width/height:1600/1200 09:56:03 INFO - PROCESS | 20232 | colorDepth:24 09:56:03 INFO - PROCESS | 20232 | Browser inner width/height: 1024/697 09:56:03 INFO - PROCESS | 20232 | __metrics 09:56:03 INFO - PROCESS | 20232 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:56:03 INFO - PROCESS | 20232 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:04 INFO - TEST-INFO | 20232: exit 0 09:56:04 INFO - Browser initialized. 09:56:04 INFO - Running cycle 1/1 for kraken test... 09:56:04 INFO - TEST-INFO | started process 20314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpne_jqn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:16 INFO - PROCESS | 20314 | RSS: Main: 149962752 09:56:16 INFO - PROCESS | 20314 | 09:56:19 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44208/tests/kraken/driver.html?testName=audio-beat-detection) 09:56:19 INFO - PROCESS | 20314 | RSS: Main: 185454592 09:56:19 INFO - PROCESS | 20314 | 09:56:22 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44208/tests/kraken/driver.html?testName=audio-dft) 09:56:23 INFO - PROCESS | 20314 | RSS: Main: 174632960 09:56:23 INFO - PROCESS | 20314 | 09:56:26 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44208/tests/kraken/driver.html?testName=audio-fft) 09:56:26 INFO - PROCESS | 20314 | RSS: Main: 162746368 09:56:26 INFO - PROCESS | 20314 | 09:56:28 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44208/tests/kraken/driver.html?testName=audio-oscillator) 09:56:29 INFO - PROCESS | 20314 | RSS: Main: 164777984 09:56:29 INFO - PROCESS | 20314 | 09:56:31 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44208/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:56:32 INFO - PROCESS | 20314 | RSS: Main: 165572608 09:56:32 INFO - PROCESS | 20314 | 09:56:35 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44208/tests/kraken/driver.html?testName=imaging-darkroom) 09:56:35 INFO - PROCESS | 20314 | RSS: Main: 167206912 09:56:35 INFO - PROCESS | 20314 | 09:56:39 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44208/tests/kraken/driver.html?testName=imaging-desaturate) 09:56:39 INFO - PROCESS | 20314 | RSS: Main: 166305792 09:56:39 INFO - PROCESS | 20314 | 09:56:42 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44208/tests/kraken/driver.html?testName=json-parse-financial) 09:56:43 INFO - PROCESS | 20314 | RSS: Main: 166035456 09:56:43 INFO - PROCESS | 20314 | 09:56:44 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44208/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:56:45 INFO - PROCESS | 20314 | RSS: Main: 176676864 09:56:45 INFO - PROCESS | 20314 | 09:56:47 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44208/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:56:47 INFO - PROCESS | 20314 | RSS: Main: 174452736 09:56:47 INFO - PROCESS | 20314 | 09:56:50 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44208/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:50 INFO - PROCESS | 20314 | RSS: Main: 184868864 09:56:50 INFO - PROCESS | 20314 | 09:56:53 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:53 INFO - PROCESS | 20314 | RSS: Main: 188334080 09:56:53 INFO - PROCESS | 20314 | 09:56:56 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:56 INFO - PROCESS | 20314 | RSS: Main: 186798080 09:56:56 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:44208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44208/tests/kraken/driver.html?testName=ai-astar) 09:56:58 INFO - PROCESS | 20314 | RSS: Main: 244940800 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | __start_tp_report 09:56:58 INFO - PROCESS | 20314 | _x_x_mozilla_page_load 09:56:58 INFO - PROCESS | 20314 | _x_x_mozilla_page_load_details 09:56:58 INFO - PROCESS | 20314 | |i|pagename|runs| 09:56:58 INFO - PROCESS | 20314 | |0;ai-astar;112;115;108;114;114;114;105;113;115;105 09:56:58 INFO - PROCESS | 20314 | |1;audio-beat-detection;152;129;156;174;137;153;150;133;166;135 09:56:58 INFO - PROCESS | 20314 | |2;audio-dft;161;161;163;161;164;161;162;163;162;162 09:56:58 INFO - PROCESS | 20314 | |3;audio-fft;73;72;80;90;72;73;72;107;95;72 09:56:58 INFO - PROCESS | 20314 | |4;audio-oscillator;97;97;132;98;97;98;137;97;98;126 09:56:58 INFO - PROCESS | 20314 | |5;imaging-gaussian-blur;109;109;109;109;111;111;111;109;109;110 09:56:58 INFO - PROCESS | 20314 | |6;imaging-darkroom;148;148;147;146;148;148;149;148;149;148 09:56:58 INFO - PROCESS | 20314 | |7;imaging-desaturate;96;96;96;95;97;95;95;96;96;95 09:56:58 INFO - PROCESS | 20314 | |8;json-parse-financial;73;71;72;71;71;71;70;81;68;68 09:56:58 INFO - PROCESS | 20314 | |9;json-stringify-tinderbox;69;68;69;68;68;69;69;68;68;69 09:56:58 INFO - PROCESS | 20314 | |10;stanford-crypto-aes;83;84;84;83;92;85;83;84;85;84 09:56:58 INFO - PROCESS | 20314 | |11;stanford-crypto-ccm;123;119;125;121;126;123;132;122;121;120 09:56:58 INFO - PROCESS | 20314 | |12;stanford-crypto-pbkdf2;140;155;151;149;160;138;151;148;149;138 09:56:58 INFO - PROCESS | 20314 | |13;stanford-crypto-sha256-iterative;72;71;72;71;71;70;72;72;71;73 09:56:58 INFO - PROCESS | 20314 | __end_tp_report 09:56:58 INFO - PROCESS | 20314 | __start_cc_report 09:56:58 INFO - PROCESS | 20314 | _x_x_mozilla_cycle_collect,1028 09:56:58 INFO - PROCESS | 20314 | __end_cc_report 09:56:58 INFO - PROCESS | 20314 | __startTimestamp1452189418936__endTimestamp 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | ------- Summary: start ------- 09:56:58 INFO - PROCESS | 20314 | Number of tests: 14 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#0] ai-astar Cycles:10 Average:111.50 Median:114.00 stddev:3.98 (3.5%) stddev-sans-first:4.22 09:56:58 INFO - PROCESS | 20314 | Values: 112.0 115.0 108.0 114.0 114.0 114.0 105.0 113.0 115.0 105.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:152.50 stddev:14.84 (9.7%) stddev-sans-first:15.69 09:56:58 INFO - PROCESS | 20314 | Values: 152.0 129.0 156.0 174.0 137.0 153.0 150.0 133.0 166.0 135.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 09:56:58 INFO - PROCESS | 20314 | Values: 161.0 161.0 163.0 161.0 164.0 161.0 162.0 163.0 162.0 162.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#3] audio-fft Cycles:10 Average:80.60 Median:73.00 stddev:12.49 (17.1%) stddev-sans-first:12.94 09:56:58 INFO - PROCESS | 20314 | Values: 73.0 72.0 80.0 90.0 72.0 73.0 72.0 107.0 95.0 72.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:97.00 stddev:16.75 (17.3%) stddev-sans-first:17.31 09:56:58 INFO - PROCESS | 20314 | Values: 97.0 97.0 132.0 98.0 97.0 98.0 137.0 97.0 98.0 126.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:109.50 stddev:0.95 (0.9%) stddev-sans-first:0.97 09:56:58 INFO - PROCESS | 20314 | Values: 109.0 109.0 109.0 109.0 111.0 111.0 111.0 109.0 109.0 110.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 09:56:58 INFO - PROCESS | 20314 | Values: 148.0 148.0 147.0 146.0 148.0 148.0 149.0 148.0 149.0 148.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:56:58 INFO - PROCESS | 20314 | Values: 96.0 96.0 96.0 95.0 97.0 95.0 95.0 96.0 96.0 95.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#8] json-parse-financial Cycles:10 Average:71.60 Median:71.00 stddev:3.66 (5.2%) stddev-sans-first:3.84 09:56:58 INFO - PROCESS | 20314 | Values: 73.0 71.0 72.0 71.0 71.0 71.0 70.0 81.0 68.0 68.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:56:58 INFO - PROCESS | 20314 | Values: 69.0 68.0 69.0 68.0 68.0 69.0 69.0 68.0 68.0 69.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:2.67 (3.2%) stddev-sans-first:2.76 09:56:58 INFO - PROCESS | 20314 | Values: 83.0 84.0 84.0 83.0 92.0 85.0 83.0 84.0 85.0 84.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:123.00 stddev:3.77 (3.1%) stddev-sans-first:3.99 09:56:58 INFO - PROCESS | 20314 | Values: 123.0 119.0 125.0 121.0 126.0 123.0 132.0 122.0 121.0 120.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:150.00 stddev:7.28 (4.9%) stddev-sans-first:7.14 09:56:58 INFO - PROCESS | 20314 | Values: 140.0 155.0 151.0 149.0 160.0 138.0 151.0 148.0 149.0 138.0 09:56:58 INFO - PROCESS | 20314 | 09:56:58 INFO - PROCESS | 20314 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 09:56:58 INFO - PROCESS | 20314 | Values: 72.0 71.0 72.0 71.0 71.0 70.0 72.0 72.0 71.0 73.0 09:56:58 INFO - PROCESS | 20314 | -------- Summary: end -------- 09:56:58 INFO - PROCESS | 20314 | 09:56:59 INFO - TEST-INFO | 20314: exit 0 09:56:59 INFO - TEST-OK | kraken | took 60657ms 09:56:59 INFO - TEST-START | v8_7 09:56:59 INFO - operating with platform_type : linux_ 09:56:59 INFO - Initialising browser for v8_7 test... 09:56:59 INFO - TEST-INFO | started process 20563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC8CHvz/profile http://localhost:44208/getInfo.html) 09:57:04 INFO - PROCESS | 20563 | __metrics Screen width/height:1600/1200 09:57:04 INFO - PROCESS | 20563 | colorDepth:24 09:57:04 INFO - PROCESS | 20563 | Browser inner width/height: 1024/697 09:57:04 INFO - PROCESS | 20563 | __metrics 09:57:04 INFO - PROCESS | 20563 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:57:04 INFO - PROCESS | 20563 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:04 INFO - PROCESS | 20563 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:57:05 INFO - TEST-INFO | 20563: exit 0 09:57:05 INFO - Browser initialized. 09:57:05 INFO - Running cycle 1/1 for v8_7 test... 09:57:05 INFO - TEST-INFO | started process 20646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC8CHvz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:17 INFO - PROCESS | 20646 | RSS: Main: 147992576 09:57:17 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | Cycle 1(1): loaded http://localhost:44208/tests/v8_7/run.html (next: http://localhost:44208/tests/v8_7/run.html) 09:57:38 INFO - PROCESS | 20646 | RSS: Main: 448040960 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | __start_tp_report 09:57:38 INFO - PROCESS | 20646 | _x_x_mozilla_page_load 09:57:38 INFO - PROCESS | 20646 | _x_x_mozilla_page_load_details 09:57:38 INFO - PROCESS | 20646 | |i|pagename|runs| 09:57:38 INFO - PROCESS | 20646 | |0;Richards;166.36167027116952 09:57:38 INFO - PROCESS | 20646 | |1;DeltaBlue;187.33608092918695 09:57:38 INFO - PROCESS | 20646 | |2;Encrypt;277.700638711469 09:57:38 INFO - PROCESS | 20646 | |3;Decrypt;5251.308900523561 09:57:38 INFO - PROCESS | 20646 | |4;RayTrace;2024.2914979757086 09:57:38 INFO - PROCESS | 20646 | |5;Earley;803.8585209003215 09:57:38 INFO - PROCESS | 20646 | |6;Boyer;12329.268292682927 09:57:38 INFO - PROCESS | 20646 | |7;RegExp;27135.135135135137 09:57:38 INFO - PROCESS | 20646 | |8;Splay;615.3374233128834 09:57:38 INFO - PROCESS | 20646 | |9;NavierStokes;4854.368932038835 09:57:38 INFO - PROCESS | 20646 | __end_tp_report 09:57:38 INFO - PROCESS | 20646 | __startTimestamp1452189458693__endTimestamp 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | ------- Summary: start ------- 09:57:38 INFO - PROCESS | 20646 | Number of tests: 10 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | [#0] Richards Cycles:1 Average:166.36 Median:166.36 stddev:0.00 (0.0%) 09:57:38 INFO - PROCESS | 20646 | Values: 166.4 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | [#1] DeltaBlue Cycles:1 Average:187.34 Median:187.34 stddev:0.00 (0.0%) 09:57:38 INFO - PROCESS | 20646 | Values: 187.3 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 09:57:38 INFO - PROCESS | 20646 | Values: 277.7 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 09:57:38 INFO - PROCESS | 20646 | Values: 5251.3 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | [#4] RayTrace Cycles:1 Average:2024.29 Median:2024.29 stddev:0.00 (0.0%) 09:57:38 INFO - PROCESS | 20646 | Values: 2024.3 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | [#5] Earley Cycles:1 Average:803.86 Median:803.86 stddev:0.00 (0.0%) 09:57:38 INFO - PROCESS | 20646 | Values: 803.9 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 09:57:38 INFO - PROCESS | 20646 | Values: 12329.3 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | [#7] RegExp Cycles:1 Average:27135.14 Median:27135.14 stddev:0.00 (0.0%) 09:57:38 INFO - PROCESS | 20646 | Values: 27135.1 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | [#8] Splay Cycles:1 Average:615.34 Median:615.34 stddev:0.00 (0.0%) 09:57:38 INFO - PROCESS | 20646 | Values: 615.3 09:57:38 INFO - PROCESS | 20646 | 09:57:38 INFO - PROCESS | 20646 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 09:57:38 INFO - PROCESS | 20646 | Values: 4854.4 09:57:38 INFO - PROCESS | 20646 | -------- Summary: end -------- 09:57:38 INFO - PROCESS | 20646 | 09:57:39 INFO - TEST-INFO | 20646: exit 0 09:57:39 INFO - TEST-OK | v8_7 | took 39733ms 09:57:39 INFO - SUITE-END | took 1216s 09:57:39 INFO - Completed test suite (00:20:16) 09:57:39 INFO - Working with test: dromaeo_css 09:57:39 INFO - Generating results file: dromaeo_css 09:57:39 INFO - Working with test: kraken 09:57:39 INFO - Generating results file: kraken 09:57:39 INFO - javascript benchmark 09:57:39 INFO - Working with test: v8_7 09:57:39 INFO - Generating results file: v8_7 09:57:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:57:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:57:39 INFO - process_Request line: dromaeo_css 6092.51 graph.html#tests=[[72,132,35]] 09:57:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:57:39 INFO - process_Request line: kraken 1531.00 graph.html#tests=[[232,132,35]] 09:57:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:57:39 INFO - process_Request line: v8_7 19614.83 graph.html#tests=[[230,132,35]] 09:57:39 INFO - RETURN: dromaeo_css: 6092.51 09:57:39 INFO - RETURN: kraken: 1531.00 09:57:39 INFO - RETURN: v8_7: 19614.83 09:57:39 INFO - javascript benchmark 09:57:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2571.1515199984, 2645.1535508637244, 2657.89368425263, 2669.5461771498844, 2678.665166854143, 4317.158154159933, 4463.2412489876715, 4547.386102876111, 4547.408836851208, 4548.977255113724, 4445.0, 4471.664625153118, 4560.33875088112, 4572.5884670379655, 4582.679212455129, 3800.277947190025, 4030.5969403059753, 4182.498100227962, 4188.685848561355, 4235.470566179228, 4134.152498737752, 4168.874933751978, 4207.368894665794, 4207.72649777765, 4256.553061928499, 4029.2747305485, 4095.877123686294, 4118.299889018874, 4141.068259641556, 4207.684423668237, 4151.335786274181, 4173.227952828706, 4187.371894215892, 4187.434696315989, 4212.283911735012, 4121.423000779893, 4133.1940271647045, 4133.607307305801, 4134.565870583606, 4185.121124563845, 4317.611414972667, 4442.955570444286, 4457.487388950248, 4469.3296005599095, 4476.261416866213, 4790.496997815214, 4883.145449546315, 4887.3402090717655, 4916.385451818523, 4941.160002799533, 4814.109389762905, 4827.951720482785, 4831.106245344622, 4836.322914791932, 4866.489018653061, 4377.693561450668, 4482.991326951443, 4483.417155769762, 4485.842995495207, 4525.728456292633, 4787.281907713871, 4902.632302577321, 4980.601551875841, 5020.723860187652, 5029.723365214948, 4731.0, 4732.881677958009, 4735.981763920774, 4768.046390721869, 4771.498992605726, 4719.646026547954, 4809.687370320918, 4825.276208568673, 4837.637177211724, 4860.1251774680895, 4700.318453824177, 4700.952990470051, 4755.857324280277, 4843.0, 4883.291922671264, 4767.642426818003, 4768.237082066853, 4773.618110551148, 4803.471618122004, 4816.8073277069225, 4004.59954004603, 4010.6590939769862, 4012.8595499157973, 4014.2573623879675, 4042.717009809285, 3477.791332520006, 3526.453399723047, 3545.166885781839, 3582.4447210681865, 3597.8560857565403, 4169.56219596944, 4170.311898536707, 4179.770112643773, 4215.241256573785, 4215.241256573785, 4818.469968303484, 4819.228923372244, 4820.132376172322, 4826.420829500412, 4855.6115510759055, 4070.0, 4156.875293741193, 4172.061286210578, 4173.040200753843, 4176.519700234512, 4303.354496825501, 4330.935035974463, 4331.523532411432, 4350.695451318441, 4368.060866913565, 4651.209294419957, 4672.345871577982, 4674.392328997209, 4681.414823147106, 4717.080169367009, 4637.420322459692, 4769.57073863354, 4776.9761151194025, 4780.282957556395, 4877.512248775094, 4606.930896036629, 4670.486246512813, 4671.089137618132, 4678.69588476748, 4694.014257006067, 4802.399700037496, 4808.0383923214795, 4812.542808433193, 4816.927746083882, 4857.344258525054, 4683.1336202802595, 4741.051789642154, 4776.498467660846, 4784.234522476387, 4877.9024419512125, 4655.23188673865, 4666.859994200044, 4670.1827180244, 4709.152352576569, 4714.198586240279, 4661.0444858803185, 4664.836730714409, 4670.276107203389, 4676.438827340741, 4701.459332176843, 4411.669124815588, 4516.548345165457, 4520.886977825449, 4544.954550454586, 4548.658850586286, 4727.125481785881, 4733.0, 4749.430068391815, 4765.046990601824, 4785.473597904297, 4591.724496530219, 4598.21830288845, 4602.1946159421295, 4602.493725690105, 4650.069986002881], "unit": "score", "name": "dojo.html", "value": 4429.037901691296}, {"lowerIsBetter": false, "replicates": [481.44393225824183, 513.3429210610418, 515.5360175841744, 522.399240872996, 527.868032991752, 24437.266881993546, 25109.121180758677, 25125.246242612706, 25160.748392516114, 32685.182870428252, 36001.63998360016, 36501.0, 36506.634933650654, 36574.634253657525, 36659.0, 7535.095788505387, 7676.5394076355315, 7684.846303073935, 7687.8078048048965, 7709.6916123354995, 6882.0, 7044.68298926547, 7045.929540704578, 7047.0838790957105, 7498.2126876677985, 6834.726610935557, 6902.965485172592, 9384.483853388061, 9581.760455988586, 9599.95200023999, 9480.288978326618, 9493.0, 9520.523973801352, 9532.380395274286, 9628.566714497829, 6812.114425124702, 9225.907740922572, 9362.110599493106, 9364.297677674134, 9368.484733339663, 24869.378265543324, 35284.64715352839, 35969.64030359715, 35986.460203096976, 36002.63997360019, 2751.5872619107295, 2802.4395120975887, 2852.671942726592, 3300.933981320384, 3330.900072997814, 22709.545809083727, 23961.520769584684, 23980.760192398026, 24558.386040348956, 25040.624390634155, 3149.1497295730023, 3149.3386388858366, 3173.841307934594, 3216.6783321667644, 3217.3404452087266, 211759.0, 213982.0, 214098.0, 214283.0, 214446.0, 54112.45887541074, 54193.45806541884, 54412.455875441534, 54519.45480545144, 54543.181852272246, 57547.0, 57619.71190144023, 57718.71140644354, 57759.71120144372, 57769.37844972392, 12016.0, 12398.876011239772, 12403.875961240272, 12440.377981100908, 12442.81335779964, 8302.294304984143, 8303.0, 8304.543250121302, 8309.916900831035, 8353.457025293337, 18116.547086322946, 18416.447506574823, 18564.907175464305, 18580.907095464438, 18642.0, 7344.632768361561, 7601.6579253933705, 7602.50583712057, 7681.423893208032, 7682.884756728654, 840.9747707568782, 841.8610929196614, 843.5149788871423, 915.9404638698596, 1013.3413281367023, 27506.587401188997, 28859.134225973256, 29475.557866632018, 30016.699833001392, 30933.381332373225, 811.3225456743567, 853.6938484119307, 876.412803421709, 932.1098351074708, 937.4000639590668, 12364.44360003802, 12621.747565048647, 12713.809292860615, 12777.425015874307, 12778.297193654438, 316588.0, 324434.0, 324637.0, 325033.0, 326330.0, 39072.413913791315, 39886.800565996986, 44858.32712509315, 45289.0, 46022.76988615035, 1151.3494875395374, 1170.2276497511602, 1170.303669316755, 1174.0, 1179.9292042477307, 22542.887285564124, 24706.752932470445, 25797.226083217534, 25991.700414978797, 26311.21066368012, 37370.43944340891, 37933.81033094817, 38064.0, 38114.2377152461, 38178.2364352717, 251917.0, 253632.0, 254102.0, 254771.0, 254867.0, 27889.16332510028, 28520.286992825346, 28630.427391451638, 28634.85682571657, 28651.713482864903, 35771.0, 36915.0, 37855.0, 37907.24185516219, 38200.0, 31832.734792142728, 32476.675233248312, 32939.50590741093, 33077.0, 33118.834405827816, 32639.67360326366, 32982.835085824416, 33165.50251746178, 34730.652693472744, 35095.0, 30019.549706754853, 30321.393572128876, 33866.66133338635, 34662.13344666403, 34810.47784283187, 25987.870060649577, 27201.0, 27314.726852732012, 27561.0, 27778.027769027987, 21364.359069227947, 21692.0, 21696.67454988145, 21770.455738606663, 22457.663135052662], "unit": "score", "name": "ext.html", "value": 16230.77414415354}, {"lowerIsBetter": false, "replicates": [311.1210829406926, 320.2106806721431, 322.514615503667, 325.3184578308443, 326.0641957581741, 12507.124501284914, 12844.0, 14742.926285368572, 15122.395104195833, 15877.0, 12258.080643951695, 12260.264384136957, 12436.937815310934, 12583.622491325252, 14835.55493335199, 4675.0, 4822.156122678535, 4968.0, 4975.875603109915, 4979.153543897528, 3752.9437058444146, 3848.2111167210796, 5596.496315331639, 5819.7963071292515, 5896.23348964634, 5680.886382272352, 5702.258706368167, 5728.398518155596, 5732.312122545301, 5735.340435849868, 5543.695096769676, 5693.686847223401, 5694.430556944293, 5704.286964129484, 5719.113537401709, 4976.328195693607, 4992.226204938241, 5000.274960130797, 5012.072766538202, 5035.219540971156, 17438.389656361967, 19049.14278857441, 19140.712889306673, 19766.90116549408, 19803.207871685114, 1874.9718754218698, 1900.2683966672791, 1910.7133929910485, 1933.7776155742129, 1957.872738272022, 12494.937525312405, 12705.936470317682, 12826.230426174367, 12846.293453860035, 13045.34773261333, 1779.7686300780945, 1819.8362147406665, 1833.14758637233, 1894.5168981909662, 1913.2633935934625, 48710.75644621754, 49671.0, 50869.49130508685, 53753.46246537524, 55851.0, 8580.0, 8812.250958668585, 8900.332475064397, 8904.065073167225, 9033.593488293043, 11170.497327620276, 11194.496247668874, 11210.439478026066, 11214.215004949576, 11230.831537526943, 6232.501399887998, 6283.842903927439, 6316.652584107826, 6356.046593011085, 6371.426571608577, 5906.350301466921, 5913.083472061838, 6157.415045570664, 6165.815025549241, 6192.195014648067, 3788.886333410002, 3823.4456003879836, 3840.462335273064, 3846.1538461538416, 3852.6339997700175, 1525.9313330900136, 1558.290977605187, 1560.6020464781634, 1581.9683606327808, 1613.8305477924885, 854.7179430787825, 855.3456605696647, 917.898521773874, 918.136951265808, 967.7532229281488, 15020.17389043613, 15681.0, 15744.685106298039, 16136.919315403347, 16170.434034808724, 790.1537730337687, 796.6932730898645, 811.6915572082571, 837.3134030095264, 839.5592314035181, 5645.745941432645, 9002.594883230271, 9106.908930910738, 9161.221296189766, 9233.676821311223, 437664.0, 440805.0, 441148.0, 459388.0, 472199.0, 50369.0, 61272.387276127556, 62953.68523157355, 63401.36598634047, 66310.0, 954.3176628710505, 962.0331566775346, 977.8435450328055, 978.3836183204678, 979.5053497983473, 13529.0, 13656.93171534136, 13779.450801601735, 14054.297285135906, 14153.221572813594, 28591.85704071466, 28774.280642984093, 29953.0, 30836.537451938686, 31878.362432751677, 37540.24919501649, 39079.60920390873, 40044.0, 40097.198056038134, 40518.39222411607, 8630.956845215735, 8695.217430431292, 8807.251383632463, 8813.471191728517, 8817.250533704708, 15186.848131518986, 15238.619034523783, 15399.384024638888, 15695.450659226872, 15812.130332831804, 13911.373988170759, 13952.0, 14135.081219720685, 14195.787063193853, 14407.0, 11383.886161138282, 13841.584752457442, 13963.790543141658, 14053.648658783612, 14074.718505630035, 14191.858081419054, 14192.716145677236, 14485.058471199338, 14580.1980891052, 14598.051126676732, 8272.131426200162, 8571.314294856522, 8709.953161007285, 8723.781905452415, 8761.25529330014, 9349.766255843659, 9471.573779179816, 12938.159019663692, 13317.134386264861, 13696.246706431242], "unit": "score", "name": "jquery.html", "value": 8034.666410293477}, {"lowerIsBetter": false, "replicates": [1185.6917201527601, 1314.7304802515484, 1317.2096741954824, 1378.2488543743666, 1661.368679901638, 5893.882122357556, 6768.864622707543, 6846.178458584965, 6854.246032936386, 6859.554128981613, 6653.700583473743, 6821.897671534918, 6827.180738311409, 6830.590164590128, 6831.897521537168, 1962.872413293135, 1999.8500112491622, 2000.3598848368529, 2002.3992802159294, 2003.829674477664, 1986.0665487220983, 2031.5327474680832, 2040.1941233212872, 2060.9381718548393, 2071.968920466194, 1968.2914150905663, 2022.2113375783383, 2051.2512932779578, 2054.6198953193634, 2056.177528988409, 1967.6654968655291, 1990.7611086669547, 1990.8506861985409, 1992.770831354391, 1992.8306093981957, 2009.3770931011434, 2024.98987505063, 2031.9187232510683, 2033.3696554068138, 2033.8779673219506, 6894.103766510371, 6975.965120174366, 6979.616121113337, 6979.616121113337, 6990.405815505688, 3764.642358975893, 3815.8473661053804, 3830.7701537907537, 3835.175437280998, 3838.539375274957, 2599.5450796110795, 2653.6815582130075, 2695.9730402696114, 2713.4437440324687, 2719.3065768228976, 877.3902138014083, 885.6855816185226, 887.4896934262761, 920.6777627830206, 922.0042354257453, 8758.430702004349, 8781.209691127766, 8783.472991620523, 8783.692570759993, 8790.912090879137, 3620.2397496525496, 3628.401313783196, 3658.9817050914576, 3671.2473942841652, 3704.759190652599, 7666.310032097138, 7677.155512893577, 7700.845983080307, 7716.035495563055, 7725.304722574995, 4058.2086493133556, 4061.5532291447917, 4062.045419326456, 4068.3083875741195, 4070.1859628074503, 3216.967830321667, 3296.4725643896863, 3609.0, 3715.3498137825773, 3724.795136267477, 3149.1969547765175, 3165.4302225599613, 3182.713555779991, 3195.2491164576304, 3198.6001749781276, 1024.3802499487851, 1035.3632516002754, 1037.5797801890246, 1039.9584016639249, 1049.506731836036, 1127.9210455268217, 1129.3901293301526, 1135.211028335299, 1135.250734515216, 1136.9886301137049, 6302.432781049728, 6579.440747536513, 6603.141591593062, 6606.240282367493, 6614.305497922745, 403.1312521516079, 411.091487811933, 412.577108463821, 412.76678676548255, 418.55842086598324, 4809.5430934061205, 4869.780859861315, 4871.318015477836, 4872.561469467694, 4874.610031197496, 8013.198680132056, 8089.757307280791, 8191.098979112293, 8266.13205613414, 8375.20435558621, 8205.79485512867, 8239.340852731768, 8245.0, 8263.628136733862, 8273.46222495536, 6425.5502114851515, 6493.610383377012, 6540.771073012422, 6561.2782593914635, 6570.441512471493, 6233.688315584293, 6288.937110629018, 6324.715387807468, 6326.082718005955, 6338.176037115146, 7225.421966242583, 7366.926330736624, 7373.225811289737, 7441.218672039358, 7443.665035073326, 7364.410847132323, 7509.399248060251, 7510.324070833652, 7705.42209334291, 7750.7674769756995, 5265.868353291198, 5355.3305836770405, 6022.608530445507, 6067.696615169312, 6072.605280656743, 6416.679166041773, 6544.181977252843, 6568.638724870178, 6569.57297775643, 6570.4086632201415, 6128.63228206309, 6187.504999600112, 6206.10011548332, 6289.0, 6330.303666596763, 6082.5438092142385, 6160.507159427146, 6224.657643829451, 6256.249250090018, 6350.618962862059, 6329.810105696836, 6376.808695739135, 6384.521160912857, 6384.521160913043, 6385.648789316447, 5834.912476312944, 5889.94110058894, 5900.232969713909, 5900.940990590039, 5908.497777688945, 5701.401352858056, 5721.628094173865, 5784.190213370216, 5795.362510123968, 5799.797007104731], "unit": "score", "name": "mootools.html", "value": 3842.098390070908}, {"lowerIsBetter": false, "replicates": [294.9572312014758, 300.69329284130185, 305.512707231965, 308.9691030896909, 309.6903096903097, 5273.367195936488, 5308.575313974882, 5341.866453338664, 5343.866403339918, 5349.732513374335, 5238.52853243208, 5280.023195708787, 5283.0, 5285.8942821143555, 5289.867753306169, 3876.3604005339225, 4153.8961525961795, 4155.189738001091, 4159.459270294858, 4163.188178305224, 3950.545687245975, 3955.9011024724323, 3957.9010524736823, 3964.464797252363, 3996.9400458993136, 3956.742811717229, 3977.2840888640035, 4037.656799172074, 4043.2924238258333, 4051.979740101295, 4045.9190816183805, 4049.3318602430563, 4051.574584668597, 4051.756894586334, 4058.655014323786, 3386.1703882548686, 3479.408500554912, 3585.354636165489, 3591.5690117186105, 3611.2416392557593, 4980.178270585386, 5072.847814565569, 5099.133147364957, 5106.846794596168, 5111.872203194913, 4662.463816661059, 4671.299305104228, 4678.485366609671, 4684.859454216379, 4685.6485763567525, 5545.140503222007, 5550.056490396642, 5551.833444996616, 5561.165825126223, 5561.249231353796, 3816.484774555427, 3884.8834534964, 3896.376579747227, 3935.2129574085297, 3952.1107750756137, 5802.21670074543, 5803.071508558611, 5804.071348584206, 5804.535637149018, 5805.042168042268, 4054.9797251013556, 4057.472528571267, 4068.2066996935905, 4072.3280658690983, 4072.450219220367, 4118.814653340607, 4124.072083781125, 4128.896777580524, 4131.5248746393945, 4131.752094874317, 4238.788060596958, 4366.934495982563, 4681.461631912373, 4682.274247491644, 4685.929711054337, 5233.973830130901, 5413.350397952192, 5427.810026649048, 5438.782448702087, 5445.482679145475, 1400.719856028778, 1422.871941525247, 1424.430227908824, 1464.3703207620824, 1464.934077966494, 977.5405559387077, 980.2550061952967, 980.764616492051, 988.3822610868208, 994.6817018553993, 4814.7833347499445, 4832.782524786393, 4836.032793441326, 4837.830675926326, 4841.225403935354, 5674.092145256822, 5680.971595141998, 5686.687232202268, 5686.976344257991, 5690.573207009408, 4806.086843499724, 4817.710937343771, 4823.975880120577, 4825.565699087028, 4831.0, 2984.985075074654, 3025.3344264261827, 3056.144279601715, 3069.1713237426216, 3078.553609726577, 5258.39528454225, 5415.296011518478, 5466.535344495763, 5511.22842802008, 5522.0, 5747.626404283708, 5929.644221346733, 5944.048952167719, 5958.851028724316, 5965.94175009621, 5475.72621368938, 5488.56091512678, 5496.0931446310915, 5497.945020549743, 5501.642393244426, 5714.8571285716525, 5753.884922301614, 5758.395368486249, 5770.971145144247, 5786.971065144648, 5445.428230035789, 5681.0910254359105, 5687.971560142173, 5689.971550142222, 5693.601447898773, 5486.478784515464, 5509.173623956439, 5512.173174023928, 5518.365387980433, 5520.806771762969, 3972.3048466517666, 4005.0, 4013.317735984831, 4013.8795836124964, 4014.116894283253, 5650.830475085754, 5800.187973683604, 5810.186573879576, 5811.0, 5816.098504731774, 5583.330000399978, 5603.131514615241, 5606.215129881738, 5608.158776183605, 5608.971955140361, 5591.0, 5597.608167428404, 5599.496045355938, 5601.663900166003, 5602.719864006702, 5422.349318081855, 5433.538149257357, 5435.809746658848, 5479.232907392889, 5489.58828087903, 5415.1335786274, 5613.747381367766, 5651.265335506358, 5654.547636189177, 5660.6037577370835, 5455.9454405455435, 5484.533814625802, 5522.889542209214, 5524.171374293888, 5528.474794894479], "unit": "score", "name": "prototype.html", "value": 4171.396373712932}, {"lowerIsBetter": false, "replicates": [648.7859006527844, 673.9393454589086, 747.3722073458293, 772.4476998945753, 793.9166387529309, 11294.152938529602, 11411.885881141186, 11444.0, 11453.0, 11454.31274123552, 11163.66509004729, 11261.774764504706, 11267.774644507104, 11325.546978120887, 11329.830052549218, 599.4245524296681, 610.1122866229647, 766.6358479722115, 778.6651739751904, 778.7741554949058, 775.7440044785208, 776.4875182379631, 782.2803021220462, 782.2998416417303, 784.0, 806.8668669669497, 814.0882211922625, 814.2549567146054, 815.0545367373848, 815.4251252866744, 804.7827086686591, 806.3871457692137, 807.4428644235459, 807.7495976247353, 808.6239898447192, 602.1990752299431, 602.5300265792689, 602.7558838670302, 602.7860109661095, 603.3152372057702, 12009.45957431909, 12116.878831211663, 12144.21062630935, 12146.817797733042, 12202.816957745641, 10577.947110264477, 10637.840432393521, 11095.72260693481, 11181.608643697513, 11182.66452006441, 8844.248238899701, 8958.104189581056, 9036.412633178823, 9091.545422728837, 9138.223251023672, 3210.9357812843614, 3250.837458127084, 3275.0666060172734, 3276.770626056177, 3282.7537934654997, 33548.99999999975, 34131.31737365239, 37140.81429592835, 37928.43107353392, 38236.61763382358, 9045.864312035324, 9139.405938614102, 9303.720888373224, 9387.249020078378, 9664.178544823628, 15771.44799931997, 15991.920040399957, 16014.519564413085, 16030.839691603169, 16031.759523607156, 6266.811995640138, 6314.810555683337, 6401.583897046677, 6471.417572418505, 6579.769708060195, 3515.4199557073307, 3591.120175557005, 3595.532580764484, 3600.7479476436397, 3601.3697602919383, 2537.2007817537415, 2548.1718441506587, 2548.566743653583, 2549.2607143928053, 2554.514642217973, 455.70151550734323, 459.49685094821115, 462.75011493792977, 464.7536805493094, 469.63368572513497, 424.7557654348762, 445.05870084771124, 447.7000409725492, 450.8151657820278, 457.8667797201965, 7736.961315193388, 7943.4042446815565, 7958.880616790752, 8031.55826429552, 8204.794880127925, 472.24440894568414, 554.5258803722759, 557.7127779193719, 594.3848117198766, 597.2653636027624, 3490.144914495914, 3534.9469757953652, 3556.253186830743, 3639.2721455708966, 3665.138692407282, 45873.54126458759, 45985.0, 46198.07603847904, 46427.30359044617, 47831.0, 42719.786401067795, 42779.57220427818, 43054.78472607617, 43110.0, 43484.347734784, 32762.344753104804, 37894.62105378966, 41763.79118104451, 41939.37090943638, 41996.37005444921, 7329.377002954809, 7549.886751698619, 7562.621868906423, 7588.62056897164, 7667.156612772702, 30079.69920300769, 30495.390092198475, 30768.538471922493, 30994.225144371572, 31619.525707113953, 35258.471122932664, 35942.28115437729, 37561.81219093996, 37989.62010379861, 38419.615803842724, 9590.280728945218, 9612.231021518402, 9639.277054220822, 9666.661666841626, 9696.127348538665, 10559.894401056199, 10672.946635266773, 10696.572137114428, 10759.946200268949, 10844.45777711127, 9703.0, 10103.848442273518, 10348.0, 10507.369557826554, 11248.88751112511, 10318.690439286833, 10479.10927571165, 10864.130869530261, 10958.397288149228, 11127.109831213646, 10093.394396336244, 10282.485875706334, 10405.791884162425, 10549.736256593647, 11037.83443248368, 9031.50326732036, 9065.41074830134, 9072.364934454525, 9176.95411522938, 9920.503974801375, 8203.425760196968, 8474.1949514796, 8502.604621892966, 8539.188777066169, 8695.608697608497], "unit": "score", "name": "yui.html", "value": 5524.145204653119}], "name": "dromaeo_css", "value": 6092.51215574211}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 108.0, 114.0, 114.0, 114.0, 105.0, 113.0, 115.0, 105.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [152.0, 129.0, 156.0, 174.0, 137.0, 153.0, 150.0, 133.0, 166.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 161.0, 164.0, 161.0, 162.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 80.0, 90.0, 72.0, 73.0, 72.0, 107.0, 95.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 132.0, 98.0, 97.0, 98.0, 137.0, 97.0, 98.0, 126.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 111.0, 111.0, 111.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 146.0, 148.0, 148.0, 149.0, 148.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 72.0, 71.0, 71.0, 71.0, 70.0, 81.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 83.0, 92.0, 85.0, 83.0, 84.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [123.0, 119.0, 125.0, 121.0, 126.0, 123.0, 132.0, 122.0, 121.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [140.0, 155.0, 151.0, 149.0, 160.0, 138.0, 151.0, 148.0, 149.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 71.0, 71.0, 70.0, 72.0, 72.0, 71.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1531.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.36167027116952], "unit": "score", "name": "Richards", "value": 212.20032200000009}, {"lowerIsBetter": false, "replicates": [187.33608092918695], "unit": "score", "name": "DeltaBlue", "value": 352.9378840000001}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [2024.2914979757086], "unit": "score", "name": "RayTrace", "value": 365.55456600000014}, {"lowerIsBetter": false, "replicates": [803.8585209003215], "unit": "score", "name": "Earley", "value": 829.0799720000001}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [27135.135135135137], "unit": "score", "name": "RegExp", "value": 33.572156374501965}, {"lowerIsBetter": false, "replicates": [615.3374233128834], "unit": "score", "name": "Splay", "value": 132.43303090727818}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19614.82526119364}]} 09:57:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19614.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1531.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6092.51"}}} 09:57:39 INFO - Return code: 0 09:57:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:57:40 INFO - # TBPL SUCCESS # 09:57:40 INFO - Running post-action listener: _resource_record_post_action 09:57:40 INFO - Running post-run listener: _resource_record_post_run 09:57:41 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 558133248; Read time: 0; Write time: 460032 09:57:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238563328; Read time: 0; Write time: 241932 09:57:41 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 318705664; Read time: 0; Write time: 218048 09:57:41 INFO - Running post-run listener: _upload_blobber_files 09:57:41 INFO - Blob upload gear active. 09:57:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:57:41 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 09:57:41 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'] 09:57:41 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 09:57:41 INFO - (blobuploader) - INFO - Open directory for files ... 09:57:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:57:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:57:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:42 INFO - (blobuploader) - INFO - Done attempting. 09:57:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:57:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:57:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:43 INFO - (blobuploader) - INFO - Done attempting. 09:57:43 INFO - (blobuploader) - INFO - Iteration through files over. 09:57:43 INFO - Return code: 0 09:57:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:57:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:57:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29d5b822c2d72987e65091f0d3563cec352d3487284df73993171f7cd011252cfd4086353b58b99750fd592ca0a2eb5f1cceee8511b2d31e3572db6722ae8666", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f969e3bca7c0187ac3808caac5b0b9aea7bbe482992fc8c7f9cdaa07ffda3c2fb4d935c180323d698e49446d29b44cd707433d42793c360a4bdbabdaf356bd7"} 09:57:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:57:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:57:43 INFO - Contents: 09:57:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29d5b822c2d72987e65091f0d3563cec352d3487284df73993171f7cd011252cfd4086353b58b99750fd592ca0a2eb5f1cceee8511b2d31e3572db6722ae8666", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f969e3bca7c0187ac3808caac5b0b9aea7bbe482992fc8c7f9cdaa07ffda3c2fb4d935c180323d698e49446d29b44cd707433d42793c360a4bdbabdaf356bd7"} 09:57:43 INFO - Copying logs to upload dir... 09:57:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.312734 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-07 09:57:42.674273) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 09:57:42.681465) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687 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/29d5b822c2d72987e65091f0d3563cec352d3487284df73993171f7cd011252cfd4086353b58b99750fd592ca0a2eb5f1cceee8511b2d31e3572db6722ae8666", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f969e3bca7c0187ac3808caac5b0b9aea7bbe482992fc8c7f9cdaa07ffda3c2fb4d935c180323d698e49446d29b44cd707433d42793c360a4bdbabdaf356bd7"} build_url:https://queue.taskcluster.net/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/Vdz2nwHCTlmV51LcvZ7eBw/artifacts/public/build/firefox-46.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/29d5b822c2d72987e65091f0d3563cec352d3487284df73993171f7cd011252cfd4086353b58b99750fd592ca0a2eb5f1cceee8511b2d31e3572db6722ae8666", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f969e3bca7c0187ac3808caac5b0b9aea7bbe482992fc8c7f9cdaa07ffda3c2fb4d935c180323d698e49446d29b44cd707433d42793c360a4bdbabdaf356bd7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 09:57:42.705894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 09:57:42.709246) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452187817.342623-1014453687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 09:57:42.788675) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 09:57:42.788984) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 09:57:42.790463) ========= ========= Total master_lag: 0.27 =========